-- Logs begin at Sun 2024-03-31 11:29:28 CEST, end at Mon 2025-07-07 19:01:46 CEST. --
Jul 07 19:00:00 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Jul 07 19:00:00 shd-prac volumio[660]: info: TidalConnect service started!
Jul 07 19:00:00 shd-prac volumio[660]: info: Completed starting Core Plugins
Jul 07 19:00:00 shd-prac volumio[660]: info: -------------------------------------------
Jul 07 19:00:00 shd-prac volumio[660]: info: ----- MyVolumio plugins startup ----
Jul 07 19:00:00 shd-prac volumio[660]: info: -------------------------------------------
Jul 07 19:00:00 shd-prac volumio[660]: info: [MyVolumio PluginManager] Fetching plans data....
Jul 07 19:00:00 shd-prac volumio-remote-updater[456]: [2025-07-07 19:00:00] [connect] Successful connection
Jul 07 19:00:00 shd-prac volumio-remote-updater[456]: [2025-07-07 19:00:00] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751907600 101
Jul 07 19:00:00 shd-prac volumio[660]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 5
Jul 07 19:00:03 shd-prac volumio[660]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Jul 07 19:00:04 shd-prac volumio[1060]: ...........................................................++++
Jul 07 19:00:08 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 07 19:00:09 shd-prac volumio[660]: info: Preload queue cleared
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Jul 07 19:00:09 shd-prac volumio[660]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Jul 07 19:00:10 shd-prac volumio[660]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Jul 07 19:00:10 shd-prac volumio[660]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Jul 07 19:00:10 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:10 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:10 shd-prac volumio[660]: info: Starting MyVolumio Remote Streaming Endpoints
Jul 07 19:00:10 shd-prac volumio[660]: info: MyVolumio login type: Token
Jul 07 19:00:10 shd-prac volumio[660]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Jul 07 19:00:10 shd-prac volumio[660]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services//package.json: ENOENT: no such file or directory, open '/myvolumio/plugins/music_service/streaming_services//package.json'
Jul 07 19:00:10 shd-prac volumio[660]: info: Preload queue cleared
Jul 07 19:00:10 shd-prac volumio[660]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 07 19:00:10 shd-prac volumio[660]: info: CoreStateMachine::ClearQueue
Jul 07 19:00:10 shd-prac volumio[660]: info: CoreStateMachine::stop
Jul 07 19:00:10 shd-prac volumio[660]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 07 19:00:10 shd-prac volumio[660]: info: CorePlayQueue::clearPlayQueue
Jul 07 19:00:10 shd-prac volumio[660]: info: CorePlayQueue::saveQueue
Jul 07 19:00:10 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushQueue
Jul 07 19:00:10 shd-prac volumio[660]: info: CoreStateMachine::addQueueItems
Jul 07 19:00:10 shd-prac volumio[660]: info: CorePlayQueue::addQueueItems
Jul 07 19:00:10 shd-prac volumio[660]: info: Preload queue cleared
Jul 07 19:00:10 shd-prac volumio[660]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s298107&filter=s:~D:country
Jul 07 19:00:10 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jul 07 19:00:11 shd-prac volumio[660]: error: MyVolumio Custom Token format not valid, refreshing it
Jul 07 19:00:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushQueue
Jul 07 19:00:11 shd-prac volumio[660]: info: CorePlayQueue::saveQueue
Jul 07 19:00:11 shd-prac volumio[660]: info: CoreStateMachine::updateTrackBlock
Jul 07 19:00:11 shd-prac volumio[660]: info: CorePlayQueue::getTrackBlock
Jul 07 19:00:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPlay
Jul 07 19:00:11 shd-prac volumio[660]: info: CoreStateMachine::play index 0
Jul 07 19:00:11 shd-prac volumio[660]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 07 19:00:11 shd-prac volumio[660]: info: CoreStateMachine::stop
Jul 07 19:00:11 shd-prac volumio[660]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 07 19:00:11 shd-prac volumio[660]: info: CoreStateMachine::play index undefined
Jul 07 19:00:11 shd-prac volumio[660]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 07 19:00:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:11 shd-prac volumio[660]: info: CoreStateMachine::startPlaybackTimer
Jul 07 19:00:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:11 shd-prac volumio[660]: info: [1751907611117] ControllerWebradio::clearAddPlayTrack
Jul 07 19:00:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand stop
Jul 07 19:00:11 shd-prac volumio[660]: info: sendMpdCommand stop took 9 milliseconds
Jul 07 19:00:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand clear
Jul 07 19:00:11 shd-prac volumio[660]: info:
Jul 07 19:00:11 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:11 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:11 shd-prac volumio[660]: info: sendMpdCommand clear took 4 milliseconds
Jul 07 19:00:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand load "https://danubiusradio.hu/live_HiFi"
Jul 07 19:00:11 shd-prac volumio[660]: info:
Jul 07 19:00:11 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:11 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:11 shd-prac volumio[660]: info:
Jul 07 19:00:11 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:11 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:11 shd-prac volumio[660]: error: updateQueue error: null
Jul 07 19:00:11 shd-prac volumio[660]: info: ------------------------------ 18ms
Jul 07 19:00:12 shd-prac volumio[660]: info: MyVolumio login type: Token
Jul 07 19:00:12 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 07 19:00:12 shd-prac volumio[660]: info: Preload queue cleared
Jul 07 19:00:12 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand add "https://danubiusradio.hu/live_HiFi"
Jul 07 19:00:12 shd-prac volumio[660]: error: updateQueue error: null
Jul 07 19:00:12 shd-prac volumio[660]: error: updateQueue error: null
Jul 07 19:00:12 shd-prac volumio[660]: info:
Jul 07 19:00:12 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:12 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:12 shd-prac volumio[660]: info: ------------------------------ 1737ms
Jul 07 19:00:12 shd-prac volumio[660]: info: ------------------------------ 1729ms
Jul 07 19:00:12 shd-prac volumio[660]: info: sendMpdCommand add "https://danubiusradio.hu/live_HiFi" took 4 milliseconds
Jul 07 19:00:12 shd-prac volumio[660]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 07 19:00:12 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand play
Jul 07 19:00:12 shd-prac volumio[660]: info:
Jul 07 19:00:12 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:12 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:12 shd-prac volumio[660]: info:
Jul 07 19:00:12 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:12 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:12 shd-prac volumio[660]: info: ------------------------------ 16ms
Jul 07 19:00:12 shd-prac volumio[660]: info: sendMpdCommand play took 13 milliseconds
Jul 07 19:00:12 shd-prac volumio[660]: info: ------------------------------ 10ms
Jul 07 19:00:12 shd-prac volumio[660]: info: ------------------------------ 8ms
Jul 07 19:00:12 shd-prac volumio[660]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand status took 15 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand status took 18 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand status took 15 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:13 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"live_HiFi","artist":null,"album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:13 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus stop
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 41ms
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:13 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:13 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand status took 26 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 22 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 20 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand status took 12 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:13 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"live_HiFi","artist":null,"album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:13 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:00:13 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:13 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"live_HiFi","artist":null,"album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:13 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:00:13 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 124ms
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 119ms
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:13 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:13 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand status took 97 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 97ms
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand status took 89 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 96ms
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand status took 89 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 89 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 84 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 15ms
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand status took 13 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 12ms
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand status took 9 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:13 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Phats & Small - This Time Around","artist":"Danubius R?di? HQ","album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:13 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:00:13 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:13 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":228,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Phats & Small - This Time Around","artist":"Danubius R?di? HQ","album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:13 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:00:13 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 189ms
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 173ms
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:13 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:13 shd-prac volumio[660]: info:
Jul 07 19:00:13 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 132 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 132 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 132 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 130 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 130 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 67ms
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand status took 64 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:13 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":359,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Phats & Small - This Time Around","artist":"Danubius R?di? HQ","album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:13 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:00:13 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:13 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1147,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Phats & Small - This Time Around","artist":"Danubius R?di? HQ","album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:13 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:00:13 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:13 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1147,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Phats & Small - This Time Around","artist":"Danubius R?di? HQ","album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:13 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:00:13 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:13 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1147,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Phats & Small - This Time Around","artist":"Danubius R?di? HQ","album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:13 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:00:13 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:13 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1147,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Phats & Small - This Time Around","artist":"Danubius R?di? HQ","album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:13 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:00:13 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 365ms
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 362ms
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 361ms
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 280ms
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 277ms
Jul 07 19:00:13 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 133 milliseconds
Jul 07 19:00:13 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:13 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:13 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1319,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Phats & Small - This Time Around","artist":"Danubius R?di? HQ","album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:13 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:00:13 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:13 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:13 shd-prac volumio[660]: info: ------------------------------ 231ms
Jul 07 19:00:13 shd-prac volumio[660]: info: MyVolumio token set successfully
Jul 07 19:00:13 shd-prac volumio[660]: info: MYVOLUMIO: Adding device
Jul 07 19:00:13 shd-prac volumio[660]: info: MYVOLUMIO: Evaluating Server
Jul 07 19:00:14 shd-prac volumio[660]: info: MyVolumio status changed
Jul 07 19:00:14 shd-prac volumio[660]: info: Streaming services startup
Jul 07 19:00:14 shd-prac volumio[660]: info: Starting Streaming Daemon
Jul 07 19:00:14 shd-prac volumio[660]: info: Removing browser output: myVolumio user plan is not superstar
Jul 07 19:00:14 shd-prac volumio[660]: info: Removing audio output:
Jul 07 19:00:14 shd-prac volumio[660]: info: Stoppping Tunnel 1
Jul 07 19:00:14 shd-prac sudo[1164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jul 07 19:00:14 shd-prac sudo[1164]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 19:00:14 shd-prac sudo[1164]: pam_unix(sudo:session): session closed for user root
Jul 07 19:00:14 shd-prac sudo[1167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Jul 07 19:00:14 shd-prac sudo[1167]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 19:00:14 shd-prac volumio[660]: error: Cannot start Volumio Streaming Daemon
Jul 07 19:00:14 shd-prac volumio[660]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jul 07 19:00:14 shd-prac volumio[660]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jul 07 19:00:14 shd-prac sudo[1167]: pam_unix(sudo:session): session closed for user root
Jul 07 19:00:14 shd-prac volumio[660]: info: Remote SSH Stopped
Jul 07 19:00:14 shd-prac volumio[660]: info: Setting Geolocation for MyVolumio to eu4
Jul 07 19:00:14 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:14 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:14 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:14 shd-prac volumio[660]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Jul 07 19:00:14 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 07 19:00:14 shd-prac volumio[660]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jul 07 19:00:14 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jul 07 19:00:14 shd-prac volumio[660]: info: Received Get System Version
Jul 07 19:00:14 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 07 19:00:14 shd-prac volumio[660]: info: Received Get System Info
Jul 07 19:00:14 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 07 19:00:14 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 07 19:00:14 shd-prac volumio[660]: info: Discovery: Getting this device information
Jul 07 19:00:14 shd-prac volumio[660]: info: CoreCommandRouter::volumioGetState
Jul 07 19:00:14 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 07 19:00:15 shd-prac volumio[660]: info: Updating MyVolumio device info
Jul 07 19:00:15 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:15 shd-prac volumio[660]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Jul 07 19:00:16 shd-prac volumio[660]: info:
Jul 07 19:00:16 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:16 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:16 shd-prac volumio[660]: info:
Jul 07 19:00:16 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:16 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:16 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:16 shd-prac volumio[660]: info:
Jul 07 19:00:16 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:16 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:16 shd-prac volumio[660]: info:
Jul 07 19:00:16 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:16 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:16 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:16 shd-prac volumio[660]: info:
Jul 07 19:00:16 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:00:16 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:00:16 shd-prac volumio[660]: info:
Jul 07 19:00:16 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:00:16 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:00:16 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:00:16 shd-prac volumio[660]: info: ------------------------------ 14ms
Jul 07 19:00:16 shd-prac volumio[660]: info: sendMpdCommand status took 11 milliseconds
Jul 07 19:00:16 shd-prac volumio[660]: info: ------------------------------ 10ms
Jul 07 19:00:16 shd-prac volumio[660]: info: sendMpdCommand status took 8 milliseconds
Jul 07 19:00:16 shd-prac volumio[660]: info: ------------------------------ 8ms
Jul 07 19:00:16 shd-prac volumio[660]: info: sendMpdCommand status took 5 milliseconds
Jul 07 19:00:16 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:16 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:16 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:16 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:16 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:00:16 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:00:16 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 07 19:00:16 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 07 19:00:16 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jul 07 19:00:16 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:16 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:16 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:00:16 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:16 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4153,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"DANUBIUS RADIO - VALTOZATOSSAG 103","artist":"Danubius R?di? HQ","album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:16 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:00:16 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:16 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:16 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4153,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"DANUBIUS RADIO - VALTOZATOSSAG 103","artist":"Danubius R?di? HQ","album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:16 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:00:16 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:16 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:00:16 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4153,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"DANUBIUS RADIO - VALTOZATOSSAG 103","artist":"Danubius R?di? HQ","album":null,"uri":"https://danubiusradio.hu/live_HiFi","trackType":""}
Jul 07 19:00:16 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:00:16 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:00:16 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:00:16 shd-prac volumio[660]: info: ------------------------------ 101ms
Jul 07 19:00:16 shd-prac volumio[660]: info: ------------------------------ 99ms
Jul 07 19:00:16 shd-prac volumio[660]: info: ------------------------------ 96ms
Jul 07 19:00:16 shd-prac volumio[1060]: ..............................................................................................................................++++
Jul 07 19:00:16 shd-prac volumio[1060]: e is 65537 (0x010001)
Jul 07 19:00:16 shd-prac volumio[1060]: writing RSA key
Jul 07 19:00:18 shd-prac volumio[660]: info: MYVOLUMIO: Adding device
Jul 07 19:00:18 shd-prac volumio[660]: info: MYVOLUMIO: Evaluating Server
Jul 07 19:00:19 shd-prac volumio[660]: info: Setting Geolocation for MyVolumio to eu4
Jul 07 19:00:19 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:19 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:19 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:19 shd-prac volumio[660]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Jul 07 19:00:20 shd-prac volumio[660]: info: Updating MyVolumio device info
Jul 07 19:00:20 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:20 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:20 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:20 shd-prac volumio[660]: error: MyVolumio Plugin failed to start in a timely fashion
Jul 07 19:00:20 shd-prac volumio[660]: info: BOOT COMPLETED
Jul 07 19:00:20 shd-prac volumio[660]: [Metrics] CommandRouter: 46s 559.94ms
Jul 07 19:00:20 shd-prac volumio[660]: info: CoreCommandRouter::volumiosetStartupVolume
Jul 07 19:00:20 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 19:00:20 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:20 shd-prac volumio[660]: info: CoreCommandRouter::Close All Modals sent
Jul 07 19:00:20 shd-prac volumio[660]: info: CoreCommandRouter::Close All Modals sent
Jul 07 19:00:20 shd-prac volumio[660]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Jul 07 19:00:20 shd-prac volumio[660]: aplay: main:828: audio open error: Device or resource busy
Jul 07 19:00:21 shd-prac volumio[660]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Jul 07 19:00:21 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jul 07 19:00:21 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 07 19:00:21 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jul 07 19:00:24 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 07 19:00:24 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 19:00:24 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 07 19:00:24 shd-prac volumio-remote-updater[456]: No test mode
Jul 07 19:00:24 shd-prac volumio-remote-updater[456]: No alpha test mode
Jul 07 19:00:24 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Jul 07 19:00:24 shd-prac volumio[660]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Jul 07 19:00:24 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jul 07 19:00:25 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 07 19:00:25 shd-prac volumio[660]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6
Jul 07 19:00:25 shd-prac volumio[660]: info: CoreCommandRouter::volumioGetState
Jul 07 19:00:27 shd-prac volumiologrotate[450]: ls: cannot access '/var/log/samba/log.wb-SHD': No such file or directory
Jul 07 19:00:27 shd-prac volumiologrotate[450]: ls: cannot access 'PRAC': No such file or directory
Jul 07 19:00:30 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 19:00:30 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 19:00:30 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Jul 07 19:00:30 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jul 07 19:00:30 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Jul 07 19:00:30 shd-prac volumio[660]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 07 19:00:30 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 07 19:00:31 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 07 19:00:31 shd-prac volumio[660]: info: Preload queue cleared
Jul 07 19:00:42 shd-prac volumio[660]: Searching plugin music_service/radio
Jul 07 19:00:42 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: radio , search
Jul 07 19:00:42 shd-prac volumio[660]: info: All search sources collected, pushing search results
Jul 07 19:00:45 shd-prac volumio[660]: Searching plugin music_service/radio
Jul 07 19:00:45 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: radio , search
Jul 07 19:00:45 shd-prac volumio[660]: info: All search sources collected, pushing search results
Jul 07 19:00:46 shd-prac volumio[660]: Searching plugin music_service/radio
Jul 07 19:00:46 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: radio , search
Jul 07 19:00:46 shd-prac volumio[660]: info: All search sources collected, pushing search results
Jul 07 19:01:08 shd-prac volumio[660]: info: Preload queue cleared
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::ClearQueue
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::stop
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::stPlaybackTimer
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::updateTrackBlock
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::getTrackBlock
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::serviceStop
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreCommandRouter::serviceStop
Jul 07 19:01:08 shd-prac volumio[660]: info: [1751907668253] ControllerWebradio::stop
Jul 07 19:01:08 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand stop
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::clearPlayQueue
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::saveQueue
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushQueue
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::addQueueItems
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::addQueueItems
Jul 07 19:01:08 shd-prac volumio[660]: info: Preload queue cleared
Jul 07 19:01:08 shd-prac volumio[660]: info: Adding Item to queue: https://oxygenmusic.hu:8443/oxygenmagyarzene
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushQueue
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::saveQueue
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::updateTrackBlock
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::getTrackBlock
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreCommandRouter::volumioPlay
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::play index 0
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::stop
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::play index undefined
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::startPlaybackTimer
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:08 shd-prac volumio[660]: info: [1751907668290] ControllerWebradio::clearAddPlayTrack
Jul 07 19:01:08 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand stop
Jul 07 19:01:08 shd-prac volumio[660]: info:
Jul 07 19:01:08 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:08 shd-prac volumio[660]: info: sendMpdCommand stop took 55 milliseconds
Jul 07 19:01:08 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:08 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:08 shd-prac volumio[660]: info: sendMpdCommand stop took 18 milliseconds
Jul 07 19:01:08 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand clear
Jul 07 19:01:08 shd-prac volumio[660]: info:
Jul 07 19:01:08 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:08 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:08 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:08 shd-prac volumio[660]: info:
Jul 07 19:01:08 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:08 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:08 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:08 shd-prac volumio[660]: info:
Jul 07 19:01:08 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:01:08 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:01:08 shd-prac volumio[660]: info: sendMpdCommand status took 12 milliseconds
Jul 07 19:01:08 shd-prac volumio[660]: info: sendMpdCommand clear took 11 milliseconds
Jul 07 19:01:08 shd-prac volumio[660]: info: sendMpdCommand status took 9 milliseconds
Jul 07 19:01:08 shd-prac volumio[660]: info: sendMpdCommand status took 7 milliseconds
Jul 07 19:01:08 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:08 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:01:08 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand load "https://oxygenmusic.hu:8443/oxygenmagyarzene"
Jul 07 19:01:08 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:08 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:08 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:08 shd-prac volumio[660]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 07 19:01:08 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:08 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:08 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:08 shd-prac volumio[660]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 07 19:01:08 shd-prac volumio[660]: info: ------------------------------ 52ms
Jul 07 19:01:08 shd-prac volumio[660]: info: ------------------------------ 50ms
Jul 07 19:01:08 shd-prac volumio[660]: info:
Jul 07 19:01:08 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:01:08 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:01:08 shd-prac volumio[660]: info:
Jul 07 19:01:08 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:01:08 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:01:08 shd-prac volumio[660]: error: updateQueue error: null
Jul 07 19:01:08 shd-prac volumio[660]: info: ------------------------------ 54ms
Jul 07 19:01:08 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 49 milliseconds
Jul 07 19:01:08 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:01:08 shd-prac volumio[660]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jul 07 19:01:08 shd-prac volumio[660]: info: ------------------------------ 72ms
Jul 07 19:01:10 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand add "https://oxygenmusic.hu:8443/oxygenmagyarzene"
Jul 07 19:01:10 shd-prac volumio[660]: error: updateQueue error: null
Jul 07 19:01:10 shd-prac volumio[660]: error: updateQueue error: null
Jul 07 19:01:10 shd-prac volumio[660]: info:
Jul 07 19:01:10 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:01:10 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:01:10 shd-prac volumio[660]: info: ------------------------------ 1642ms
Jul 07 19:01:10 shd-prac volumio[660]: info: ------------------------------ 1640ms
Jul 07 19:01:10 shd-prac volumio[660]: info: sendMpdCommand add "https://oxygenmusic.hu:8443/oxygenmagyarzene" took 5 milliseconds
Jul 07 19:01:10 shd-prac volumio[660]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 07 19:01:10 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand play
Jul 07 19:01:10 shd-prac volumio[660]: info:
Jul 07 19:01:10 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:01:10 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:01:10 shd-prac volumio[660]: info:
Jul 07 19:01:10 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:01:10 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:01:10 shd-prac volumio[660]: info: ------------------------------ 15ms
Jul 07 19:01:10 shd-prac volumio[660]: info: sendMpdCommand play took 12 milliseconds
Jul 07 19:01:10 shd-prac volumio[660]: info: ------------------------------ 11ms
Jul 07 19:01:10 shd-prac volumio[660]: info: ------------------------------ 8ms
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand status took 4 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand status took 13 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand status took 8 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand status took 5 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oxygenmagyarzene","artist":null,"album":null,"uri":"https://oxygenmusic.hu:8443/oxygenmagyarzene","trackType":""}
Jul 07 19:01:11 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus stop
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 35ms
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:01:11 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:01:11 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 31 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 27 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 27 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand status took 17 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand status took 15 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oxygenmagyarzene","artist":null,"album":null,"uri":"https://oxygenmusic.hu:8443/oxygenmagyarzene","trackType":""}
Jul 07 19:01:11 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:01:11 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oxygenmagyarzene","artist":null,"album":null,"uri":"https://oxygenmusic.hu:8443/oxygenmagyarzene","trackType":""}
Jul 07 19:01:11 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:01:11 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oxygenmagyarzene","artist":null,"album":null,"uri":"https://oxygenmusic.hu:8443/oxygenmagyarzene","trackType":""}
Jul 07 19:01:11 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:01:11 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 175ms
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 171ms
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 172ms
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:01:11 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:01:11 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 155ms
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand status took 146 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 153ms
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand status took 145 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 140 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 139 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 18ms
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand status took 15 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 14ms
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand status took 12 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1026,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Gringo Szt?r - Hetvenkett?","artist":"Oxygen Magyar Zene","album":null,"uri":"https://oxygenmusic.hu:8443/oxygenmagyarzene","trackType":""}
Jul 07 19:01:11 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:01:11 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1129,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Gringo Szt?r - Hetvenkett?","artist":"Oxygen Magyar Zene","album":null,"uri":"https://oxygenmusic.hu:8443/oxygenmagyarzene","trackType":""}
Jul 07 19:01:11 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:01:11 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 277ms
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 272ms
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces system playlist update
Jul 07 19:01:11 shd-prac volumio[660]: info: Ignoring MPD Status Update
Jul 07 19:01:11 shd-prac volumio[660]: info:
Jul 07 19:01:11 shd-prac volumio[660]: ---------------------------- MPD announces state update: player
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::getState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 185 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 183 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 181 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 179 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 83ms
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand status took 81 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseState
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1152,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Gringo Szt?r - Hetvenkett?","artist":"Oxygen Magyar Zene","album":null,"uri":"https://oxygenmusic.hu:8443/oxygenmagyarzene","trackType":""}
Jul 07 19:01:11 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:01:11 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1152,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Gringo Szt?r - Hetvenkett?","artist":"Oxygen Magyar Zene","album":null,"uri":"https://oxygenmusic.hu:8443/oxygenmagyarzene","trackType":""}
Jul 07 19:01:11 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:01:11 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1152,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Gringo Szt?r - Hetvenkett?","artist":"Oxygen Magyar Zene","album":null,"uri":"https://oxygenmusic.hu:8443/oxygenmagyarzene","trackType":""}
Jul 07 19:01:11 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:01:11 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1152,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Gringo Szt?r - Hetvenkett?","artist":"Oxygen Magyar Zene","album":null,"uri":"https://oxygenmusic.hu:8443/oxygenmagyarzene","trackType":""}
Jul 07 19:01:11 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:01:11 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 474ms
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 473ms
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 337ms
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 334ms
Jul 07 19:01:11 shd-prac volumio[660]: info: sendMpdCommand playlistinfo took 143 milliseconds
Jul 07 19:01:11 shd-prac volumio[660]: verbose: ControllerMpd::parseTrackInfo
Jul 07 19:01:11 shd-prac volumio[660]: info: ControllerMpd::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::servicePushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CorePlayQueue::getTrack 0
Jul 07 19:01:11 shd-prac volumio[660]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1312,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Gringo Szt?r - Hetvenkett?","artist":"Oxygen Magyar Zene","album":null,"uri":"https://oxygenmusic.hu:8443/oxygenmagyarzene","trackType":""}
Jul 07 19:01:11 shd-prac volumio[660]: verbose: CURRENT POSITION 0
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState stateService play
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::syncState currentStatus play
Jul 07 19:01:11 shd-prac volumio[660]: info: Received an update from plugin. extracting info from payload
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreStateMachine::pushState
Jul 07 19:01:11 shd-prac volumio[660]: info: CoreCommandRouter::volumioPushState
Jul 07 19:01:11 shd-prac volumio[660]: info: ------------------------------ 260ms
Jul 07 19:01:18 shd-prac volumio[660]: info: Saving local item radio-favourites
Jul 07 19:01:18 shd-prac volumio[660]: info: Pushing Favourites {"uri":"https://oxygenmusic.hu:8443/oxygenmagyarzene","favourite":false}
Jul 07 19:01:26 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 07 19:01:26 shd-prac volumio[660]: info: Preload queue cleared
Jul 07 19:01:27 shd-prac volumiologrotate[450]: ls: cannot access '/var/log/samba/log.wb-SHD': No such file or directory
Jul 07 19:01:27 shd-prac volumiologrotate[450]: ls: cannot access 'PRAC': No such file or directory
Jul 07 19:01:45 shd-prac volumio[660]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch
Jul 07 19:01:45 shd-prac volumio[660]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 07 19:01:45 shd-prac volumio[660]: TypeError: Cannot read property 'then' of undefined
Jul 07 19:01:45 shd-prac volumio[660]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:470:20)
Jul 07 19:01:45 shd-prac volumio[660]: at Socket.emit (events.js:400:28)
Jul 07 19:01:45 shd-prac volumio[660]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Jul 07 19:01:45 shd-prac volumio[660]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Jul 07 19:01:45 shd-prac volumio[660]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 07 19:01:46 shd-prac sudo[1494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-07 19:00
Jul 07 19:01:46 shd-prac sudo[1494]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="minidspshd"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 22 Mar 2024 03:00:28 PM CET"
VOLUMIO_VERSION="3.608"
VOLUMIO_HARDWARE="nanopineo2"
VOLUMIO_DEVICENAME="NanoPi Neo2"
VOLUMIO_VENDOR="miniDSP"
VOLUMIO_MODEL="SHD"
VOLUMIO_VENDOR_MODEL="miniDSP SHD"
VOLUMIO_HASH="29ccfe8a9cff19911db4b736879ac117"