-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Sun 2024-10-06 18:08:43 IST. -- Oct 06 18:07:00 volumio volumio[711]: Searching plugin music_service/tidal Oct 06 18:07:00 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: tidal , search Oct 06 18:07:00 volumio volumio[711]: info: searchTIDALUri took 646 milliseconds Oct 06 18:07:00 volumio volumio[711]: info: search took 647 milliseconds Oct 06 18:07:00 volumio volumio[711]: info: All search sources collected, pushing search results Oct 06 18:07:01 volumio volumio[711]: Searching plugin music_service/tidal Oct 06 18:07:01 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: tidal , search Oct 06 18:07:02 volumio volumio[711]: info: searchTIDALUri took 1125 milliseconds Oct 06 18:07:02 volumio volumio[711]: info: search took 1126 milliseconds Oct 06 18:07:02 volumio volumio[711]: info: All search sources collected, pushing search results Oct 06 18:07:02 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Oct 06 18:07:03 volumio volumio[711]: info: browseTIDALUri took 717 milliseconds Oct 06 18:07:03 volumio volumio[711]: info: Preload queue cleared Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989288 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989289 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989290 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989291 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989292 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989293 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989294 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989295 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989296 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989297 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989298 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989299 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989300 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989301 Oct 06 18:07:03 volumio volumio[711]: info: Preloading song: tidal://song/77989302 Oct 06 18:07:03 volumio volumio[711]: info: Exploding uri tidal://song/77989288 in service tidal Oct 06 18:07:03 volumio volumio[711]: info: Exploding uri tidal://song/77989289 in service tidal Oct 06 18:07:03 volumio volumio[711]: info: Executing endpoint getSimilarAlbums Oct 06 18:07:03 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Oct 06 18:07:03 volumio volumio[711]: info: Exploding uri tidal://song/77989290 in service tidal Oct 06 18:07:03 volumio volumio[711]: info: Exploding uri tidal://song/77989291 in service tidal Oct 06 18:07:03 volumio volumio[711]: info: Executing endpoint metavolumio Oct 06 18:07:03 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 06 18:07:03 volumio volumio[711]: info: Executing endpoint metavolumio Oct 06 18:07:03 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 06 18:07:03 volumio volumio[711]: info: Exploding uri tidal://song/77989292 in service tidal Oct 06 18:07:03 volumio volumio[711]: info: Exploding uri tidal://song/77989293 in service tidal Oct 06 18:07:03 volumio volumio[711]: info: explodeTIDALUri took 268 milliseconds Oct 06 18:07:03 volumio volumio[711]: info: Exploding uri tidal://song/77989294 in service tidal Oct 06 18:07:03 volumio volumio[711]: info: Exploding uri tidal://song/77989295 in service tidal Oct 06 18:07:04 volumio volumio[711]: info: Exploding uri tidal://song/77989296 in service tidal Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 305 milliseconds Oct 06 18:07:04 volumio volumio[711]: info: Exploding uri tidal://song/77989297 in service tidal Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 229 milliseconds Oct 06 18:07:04 volumio volumio[711]: info: Exploding uri tidal://song/77989298 in service tidal Oct 06 18:07:04 volumio volumio[711]: info: Exploding uri tidal://song/77989299 in service tidal Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 253 milliseconds Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 237 milliseconds Oct 06 18:07:04 volumio volumio[711]: info: Exploding uri tidal://song/77989300 in service tidal Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 238 milliseconds Oct 06 18:07:04 volumio volumio[711]: info: Exploding uri tidal://song/77989301 in service tidal Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 247 milliseconds Oct 06 18:07:04 volumio volumio[711]: info: Exploding uri tidal://song/77989302 in service tidal Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 229 milliseconds Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 695 milliseconds Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 216 milliseconds Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 268 milliseconds Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 696 milliseconds Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 234 milliseconds Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 675 milliseconds Oct 06 18:07:04 volumio volumio[711]: info: explodeTIDALUri took 252 milliseconds Oct 06 18:07:05 volumio volumio[711]: error: Failed request for metavolumio API Oct 06 18:07:05 volumio volumio[711]: error: Failed request for metavolumio API Oct 06 18:07:13 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 18:07:13 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 18:07:13 volumio volumio[711]: info: Discovery: Getting this device information Oct 06 18:07:13 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:07:13 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 18:07:16 volumio volumio[711]: info: Preload queue cleared Oct 06 18:07:16 volumio volumio[711]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 06 18:07:16 volumio volumio[711]: info: CoreStateMachine::ClearQueue Oct 06 18:07:16 volumio volumio[711]: info: CoreStateMachine::stop Oct 06 18:07:16 volumio volumio[711]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 18:07:16 volumio volumio[711]: info: CoreStateMachine::stPlaybackTimer Oct 06 18:07:16 volumio volumio[711]: info: CoreStateMachine::updateTrackBlock Oct 06 18:07:16 volumio volumio[711]: info: CorePlayQueue::getTrackBlock Oct 06 18:07:16 volumio volumio[711]: info: CoreStateMachine::pushState Oct 06 18:07:16 volumio volumio[711]: info: CorePlayQueue::getTrack 19 Oct 06 18:07:16 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 18:07:16 volumio volumio[711]: info: CoreCommandRouter::volumioPushState Oct 06 18:07:16 volumio volumio[711]: info: MRS: Pushing multiroomSync output update for this device Oct 06 18:07:16 volumio volumio[711]: info: MRS: Pushing multiroomSync output Oct 06 18:07:16 volumio volumio[711]: info: CoreStateMachine::serviceStop Oct 06 18:07:16 volumio volumio[711]: info: CorePlayQueue::getTrack 19 Oct 06 18:07:16 volumio volumio[711]: info: CoreCommandRouter::serviceStop Oct 06 18:07:16 volumio volumio[711]: info: [1728234436894] ControllerTidal::stop Oct 06 18:07:16 volumio volumio[711]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 06 18:07:16 volumio volumio[711]: info: ControllerMpd::stop Oct 06 18:07:16 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand stop Oct 06 18:07:16 volumio volumio[711]: info: CorePlayQueue::clearPlayQueue Oct 06 18:07:16 volumio volumio[711]: info: CorePlayQueue::saveQueue Oct 06 18:07:16 volumio volumio[711]: info: CoreCommandRouter::volumioPushQueue Oct 06 18:07:16 volumio volumio[711]: info: CoreStateMachine::addQueueItems Oct 06 18:07:16 volumio volumio[711]: info: CorePlayQueue::addQueueItems Oct 06 18:07:16 volumio volumio[711]: info: Preload queue cleared Oct 06 18:07:16 volumio volumio[711]: info: Adding Item to queue: tidal://album/77989287 Oct 06 18:07:16 volumio volumio[711]: info: Exploding uri tidal://album/77989287 in service tidal Oct 06 18:07:16 volumio volumio[711]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 06 18:07:17 volumio volumio[711]: info: sendMpdCommand stop took 113 milliseconds Oct 06 18:07:17 volumio volumio[711]: info: Oct 06 18:07:17 volumio volumio[711]: ---------------------------- MPD announces state update: player Oct 06 18:07:17 volumio volumio[711]: info: ControllerMpd::getState Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand status Oct 06 18:07:17 volumio volumio[711]: info: sendMpdCommand status took 0 milliseconds Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::parseState Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 18:07:17 volumio volumio[711]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::parseTrackInfo Oct 06 18:07:17 volumio volumio[711]: info: ControllerMpd::pushState Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::servicePushState Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::pushState Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::volumioPushState Oct 06 18:07:17 volumio volumio[711]: info: MRS: Pushing multiroomSync output update for this device Oct 06 18:07:17 volumio volumio[711]: info: MRS: Pushing multiroomSync output Oct 06 18:07:17 volumio volumio[711]: info: CorePlayQueue::getTrack 19 Oct 06 18:07:17 volumio volumio[711]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"78769546&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/78769546&soundQuality=LOSSLESS","trackType":"tidal"} Oct 06 18:07:17 volumio volumio[711]: verbose: CURRENT POSITION 19 Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::syncState stateService stop Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::syncState currentStatus stop Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::pushState Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::volumioPushState Oct 06 18:07:17 volumio volumio[711]: info: MRS: Pushing multiroomSync output update for this device Oct 06 18:07:17 volumio volumio[711]: info: MRS: Pushing multiroomSync output Oct 06 18:07:17 volumio volumio[711]: info: No code Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::pushState Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::volumioPushState Oct 06 18:07:17 volumio volumio[711]: info: MRS: Pushing multiroomSync output update for this device Oct 06 18:07:17 volumio volumio[711]: info: MRS: Pushing multiroomSync output Oct 06 18:07:17 volumio volumio[711]: info: ------------------------------ 52ms Oct 06 18:07:17 volumio volumio[711]: info: explodeTIDALUri took 283 milliseconds Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::volumioPushQueue Oct 06 18:07:17 volumio volumio[711]: info: CorePlayQueue::saveQueue Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::updateTrackBlock Oct 06 18:07:17 volumio volumio[711]: info: CorePlayQueue::getTrackBlock Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::volumioPlay Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::play index 0 Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::stop Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::play index undefined Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 18:07:17 volumio volumio[711]: info: CorePlayQueue::getTrack 0 Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::startPlaybackTimer Oct 06 18:07:17 volumio volumio[711]: info: CorePlayQueue::getTrack 0 Oct 06 18:07:17 volumio volumio[711]: info: [1728234437195] ControllerTidal::clearAddPlayTrack Oct 06 18:07:17 volumio volumio[711]: info: Getting stream with soundQuality LOSSLESS Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand stop Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:07:17 volumio volumio[711]: info: CorePlayQueue::getTrack 0 Oct 06 18:07:17 volumio volumio[711]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 06 18:07:17 volumio volumio[711]: info: sendMpdCommand stop took 74 milliseconds Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand clear Oct 06 18:07:17 volumio volumio[711]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Oct 06 18:07:17 volumio volumio[711]: info: Oct 06 18:07:17 volumio volumio[711]: ---------------------------- MPD announces system playlist update Oct 06 18:07:17 volumio volumio[711]: info: Ignoring MPD Status Update Oct 06 18:07:17 volumio volumio[711]: info: sendMpdCommand clear took 19 milliseconds Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/77989288&soundQuality=LOSSLESS" Oct 06 18:07:17 volumio volumio[711]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 06 18:07:17 volumio volumio[711]: error: updateQueue error: null Oct 06 18:07:17 volumio volumio[711]: info: Oct 06 18:07:17 volumio volumio[711]: ---------------------------- MPD announces system playlist update Oct 06 18:07:17 volumio volumio[711]: info: Ignoring MPD Status Update Oct 06 18:07:17 volumio volumio[711]: info: ------------------------------ 5ms Oct 06 18:07:17 volumio volumio[711]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/77989288&soundQuality=LOSSLESS" took 4 milliseconds Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand play Oct 06 18:07:17 volumio volumio[711]: STREAMING PROXY: Handling url /?data=tidal://song/77989288&soundQuality=LOSSLESS Oct 06 18:07:17 volumio volumio[711]: info: ------------------------------ 14ms Oct 06 18:07:17 volumio volumio[711]: info: sendMpdCommand play took 13 milliseconds Oct 06 18:07:17 volumio volumio[711]: info: Executing endpoint getStreamUrltidal Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Oct 06 18:07:17 volumio volumio[711]: info: getStreamUrl took 261 milliseconds Oct 06 18:07:17 volumio volumio[711]: STREAMING PROXY: Got real url: http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEic3MGIxNDIwZjc1ZmIwNDkyYzJlZWY4NGM0Y2Q2ZGNiOF82MS5tcDQ/0.flac?Expires=1728238037&Signature=Bf9HfKfugiQ4ktSSOhDN~KJnGD1U9DGLTATpZLZRWmLtau7ky1nXjq0ofJvZ74seXRo0vKHLMm-98p2olatKThQ8ORkNg3lOgxIV9le0RGX9s1HsbXoXQc19sLyIFh7ZoZguj51JbWPXDyWoNBJEsSybuhm-r2HEyNTam8Dh1dWNP7F3g-Rk~yk5BuM8c0oU3nbUMuelzI01olCvLQWSrye~vNHQuxyESx15MPhq6ZIBHVTJyS4qIOkCZMUDGYZWak1wKL6MJG1AlcrTPZbUgUxZU7GWP8xUerTORanvi1Eom5C8LPAxkQJ-ix7eT1D7Q77wHjZ6689qGNGYlh~4bw__&Key-Pair-Id=K14LZCZ9QUI4JL Oct 06 18:07:17 volumio volumio[711]: STREAMING PROXY: Response: 200, length: 35876286 Oct 06 18:07:17 volumio volumio[711]: info: Oct 06 18:07:17 volumio volumio[711]: ---------------------------- MPD announces state update: player Oct 06 18:07:17 volumio volumio[711]: info: ControllerMpd::getState Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand status Oct 06 18:07:17 volumio volumio[711]: info: Oct 06 18:07:17 volumio volumio[711]: ---------------------------- MPD announces state update: player Oct 06 18:07:17 volumio volumio[711]: info: sendMpdCommand status took 2 milliseconds Oct 06 18:07:17 volumio volumio[711]: info: ControllerMpd::getState Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand status Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::parseState Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 18:07:17 volumio volumio[711]: info: sendMpdCommand status took 1 milliseconds Oct 06 18:07:17 volumio volumio[711]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::parseState Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::parseTrackInfo Oct 06 18:07:17 volumio volumio[711]: info: ControllerMpd::pushState Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::servicePushState Oct 06 18:07:17 volumio volumio[711]: info: CorePlayQueue::getTrack 0 Oct 06 18:07:17 volumio volumio[711]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"77989288&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/77989288&soundQuality=LOSSLESS","trackType":"tidal"} Oct 06 18:07:17 volumio volumio[711]: verbose: CURRENT POSITION 0 Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::syncState stateService play Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::syncState currentStatus stop Oct 06 18:07:17 volumio volumio[711]: info: ------------------------------ 8ms Oct 06 18:07:17 volumio volumio[711]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 06 18:07:17 volumio volumio[711]: verbose: ControllerMpd::parseTrackInfo Oct 06 18:07:17 volumio volumio[711]: info: ControllerMpd::pushState Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::servicePushState Oct 06 18:07:17 volumio volumio[711]: info: CorePlayQueue::getTrack 0 Oct 06 18:07:17 volumio volumio[711]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"77989288&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/77989288&soundQuality=LOSSLESS","trackType":"tidal"} Oct 06 18:07:17 volumio volumio[711]: verbose: CURRENT POSITION 0 Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::syncState stateService play Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::syncState currentStatus play Oct 06 18:07:17 volumio volumio[711]: info: Received an update from plugin. extracting info from payload Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::pushState Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::volumioPushState Oct 06 18:07:17 volumio volumio[711]: info: MRS: Pushing multiroomSync output update for this device Oct 06 18:07:17 volumio volumio[711]: info: MRS: Pushing multiroomSync output Oct 06 18:07:17 volumio volumio[711]: info: CoreStateMachine::pushState Oct 06 18:07:17 volumio volumio[711]: info: CoreCommandRouter::volumioPushState Oct 06 18:07:17 volumio volumio[711]: info: MRS: Pushing multiroomSync output update for this device Oct 06 18:07:17 volumio volumio[711]: info: MRS: Pushing multiroomSync output Oct 06 18:07:17 volumio volumio[711]: info: ------------------------------ 40ms Oct 06 18:07:19 volumio volumio[711]: STREAMING PROXY: Client dropped request, destroying Oct 06 18:07:26 volumio volumio[711]: info: CoreCommandRouter::volumioSeek Oct 06 18:07:26 volumio volumio[711]: info: CoreStateMachine::seek Oct 06 18:07:26 volumio volumio[711]: info: CorePlayQueue::getTrack 0 Oct 06 18:07:26 volumio volumio[711]: info: TRACKBLOCK {"uri":"tidal://song/77989288","service":"tidal","name":"Rain, Pt. 1","title":"Rain, Pt. 1","album":"Rain","type":"track","tracknumber":1,"volumeNumber":1,"albumart":"https://resources.tidal.com/images/e2848334/f8d9/42dc/991f/f2849c6bdf8b/640x640.jpg","duration":345,"trackType":"tidal","samplerate":"44.1 KHz","bitdepth":"16 bit","explicit":true,"artist":"Freedom To Glide","artistUri":"tidal://artist/4734512","albumUri":"tidal://album/77989287","audioQuality":"LOSSLESS"} Oct 06 18:07:26 volumio volumio[711]: info: CoreStateMachine::startPlaybackTimer Oct 06 18:07:26 volumio volumio[711]: info: CorePlayQueue::getTrack 0 Oct 06 18:07:26 volumio volumio[711]: info: [1728234446556] ControllerTidal::seek Oct 06 18:07:26 volumio volumio[711]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 06 18:07:26 volumio volumio[711]: info: ControllerMpd::seek Oct 06 18:07:26 volumio volumio[711]: info: CoreStateMachine::pushState Oct 06 18:07:26 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 18:07:26 volumio volumio[711]: info: CoreCommandRouter::volumioPushState Oct 06 18:07:26 volumio volumio[711]: info: MRS: Pushing multiroomSync output update for this device Oct 06 18:07:26 volumio volumio[711]: info: MRS: Pushing multiroomSync output Oct 06 18:07:26 volumio volumio[711]: error: null Oct 06 18:07:26 volumio volumio[711]: info: Oct 06 18:07:26 volumio volumio[711]: ---------------------------- MPD announces state update: player Oct 06 18:07:26 volumio volumio[711]: info: ControllerMpd::getState Oct 06 18:07:26 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand status Oct 06 18:07:26 volumio volumio[711]: info: sendMpdCommand status took 1 milliseconds Oct 06 18:07:26 volumio volumio[711]: verbose: ControllerMpd::parseState Oct 06 18:07:26 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 18:07:26 volumio volumio[711]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 06 18:07:26 volumio volumio[711]: verbose: ControllerMpd::parseTrackInfo Oct 06 18:07:26 volumio volumio[711]: info: ControllerMpd::pushState Oct 06 18:07:26 volumio volumio[711]: info: CoreCommandRouter::servicePushState Oct 06 18:07:26 volumio volumio[711]: info: CorePlayQueue::getTrack 0 Oct 06 18:07:26 volumio volumio[711]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63000,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"926 Kbps","isStreaming":false,"title":"77989288&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/77989288&soundQuality=LOSSLESS","trackType":"tidal"} Oct 06 18:07:26 volumio volumio[711]: verbose: CURRENT POSITION 0 Oct 06 18:07:26 volumio volumio[711]: info: CoreStateMachine::syncState stateService play Oct 06 18:07:26 volumio volumio[711]: info: CoreStateMachine::syncState currentStatus play Oct 06 18:07:26 volumio volumio[711]: info: Received an update from plugin. extracting info from payload Oct 06 18:07:26 volumio volumio[711]: info: CoreStateMachine::pushState Oct 06 18:07:26 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 18:07:26 volumio volumio[711]: info: CoreCommandRouter::volumioPushState Oct 06 18:07:26 volumio volumio[711]: info: MRS: Pushing multiroomSync output update for this device Oct 06 18:07:26 volumio volumio[711]: info: MRS: Pushing multiroomSync output Oct 06 18:07:26 volumio volumio[711]: info: CoreStateMachine::pushState Oct 06 18:07:26 volumio volumio[711]: info: CoreCommandRouter::volumioPushState Oct 06 18:07:26 volumio volumio[711]: info: MRS: Pushing multiroomSync output update for this device Oct 06 18:07:26 volumio volumio[711]: info: MRS: Pushing multiroomSync output Oct 06 18:07:26 volumio volumio[711]: info: ------------------------------ 38ms Oct 06 18:07:43 volumio volumio[711]: info: CoreCommandRouter::volumioSeek Oct 06 18:07:43 volumio volumio[711]: info: CoreStateMachine::seek Oct 06 18:07:43 volumio volumio[711]: info: CorePlayQueue::getTrack 0 Oct 06 18:07:43 volumio volumio[711]: info: TRACKBLOCK {"uri":"tidal://song/77989288","service":"tidal","name":"Rain, Pt. 1","title":"Rain, Pt. 1","album":"Rain","type":"track","tracknumber":1,"volumeNumber":1,"albumart":"https://resources.tidal.com/images/e2848334/f8d9/42dc/991f/f2849c6bdf8b/640x640.jpg","duration":345,"trackType":"tidal","samplerate":"44.1 KHz","bitdepth":"16 bit","explicit":true,"artist":"Freedom To Glide","artistUri":"tidal://artist/4734512","albumUri":"tidal://album/77989287","audioQuality":"LOSSLESS"} Oct 06 18:07:43 volumio volumio[711]: info: CoreStateMachine::startPlaybackTimer Oct 06 18:07:43 volumio volumio[711]: info: CorePlayQueue::getTrack 0 Oct 06 18:07:43 volumio volumio[711]: info: [1728234463009] ControllerTidal::seek Oct 06 18:07:43 volumio volumio[711]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 06 18:07:43 volumio volumio[711]: info: ControllerMpd::seek Oct 06 18:07:43 volumio volumio[711]: info: CoreStateMachine::pushState Oct 06 18:07:43 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 18:07:43 volumio volumio[711]: info: CoreCommandRouter::volumioPushState Oct 06 18:07:43 volumio volumio[711]: info: MRS: Pushing multiroomSync output update for this device Oct 06 18:07:43 volumio volumio[711]: info: MRS: Pushing multiroomSync output Oct 06 18:07:43 volumio volumio[711]: error: null Oct 06 18:07:43 volumio volumio[711]: info: Oct 06 18:07:43 volumio volumio[711]: ---------------------------- MPD announces state update: player Oct 06 18:07:43 volumio volumio[711]: info: ControllerMpd::getState Oct 06 18:07:43 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand status Oct 06 18:07:43 volumio volumio[711]: info: sendMpdCommand status took 1 milliseconds Oct 06 18:07:43 volumio volumio[711]: verbose: ControllerMpd::parseState Oct 06 18:07:43 volumio volumio[711]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 18:07:43 volumio volumio[711]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 06 18:07:43 volumio volumio[711]: verbose: ControllerMpd::parseTrackInfo Oct 06 18:07:43 volumio volumio[711]: info: ControllerMpd::pushState Oct 06 18:07:43 volumio volumio[711]: info: CoreCommandRouter::servicePushState Oct 06 18:07:43 volumio volumio[711]: info: CorePlayQueue::getTrack 0 Oct 06 18:07:43 volumio volumio[711]: verbose: STATE SERVICE {"status":"play","position":0,"seek":117000,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"718 Kbps","isStreaming":false,"title":"77989288&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/77989288&soundQuality=LOSSLESS","trackType":"tidal"} Oct 06 18:07:43 volumio volumio[711]: verbose: CURRENT POSITION 0 Oct 06 18:07:43 volumio volumio[711]: info: CoreStateMachine::syncState stateService play Oct 06 18:07:43 volumio volumio[711]: info: CoreStateMachine::syncState currentStatus play Oct 06 18:07:43 volumio volumio[711]: info: Received an update from plugin. extracting info from payload Oct 06 18:07:43 volumio volumio[711]: info: CoreStateMachine::pushState Oct 06 18:07:43 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 18:07:43 volumio volumio[711]: info: CoreCommandRouter::volumioPushState Oct 06 18:07:43 volumio volumio[711]: info: MRS: Pushing multiroomSync output update for this device Oct 06 18:07:43 volumio volumio[711]: info: MRS: Pushing multiroomSync output Oct 06 18:07:43 volumio volumio[711]: info: CoreStateMachine::pushState Oct 06 18:07:43 volumio volumio[711]: info: CoreCommandRouter::volumioPushState Oct 06 18:07:43 volumio volumio[711]: info: MRS: Pushing multiroomSync output update for this device Oct 06 18:07:43 volumio volumio[711]: info: MRS: Pushing multiroomSync output Oct 06 18:07:43 volumio volumio[711]: info: ------------------------------ 34ms Oct 06 18:07:43 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 18:07:43 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 18:07:43 volumio volumio[711]: info: Discovery: Getting this device information Oct 06 18:07:43 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:07:43 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 18:08:04 volumio sudo[1840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 06 18:08:04 volumio sudo[1840]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 18:08:04 volumio sudo[1840]: pam_unix(sudo:session): session closed for user root Oct 06 18:08:04 volumio sudo[1843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 06 18:08:04 volumio sudo[1843]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 18:08:04 volumio sudo[1843]: pam_unix(sudo:session): session closed for user root Oct 06 18:08:04 volumio volumio[711]: verbose: New Socket.io Connection to 192.168.68.92 from 192.168.68.70 UA: Mozilla/5.0 (Linux; Android 13; IN2013 Build/RKQ1.211119.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Total Clients: 10 Oct 06 18:08:04 volumio sudo[1846]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 06 18:08:04 volumio sudo[1846]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 18:08:04 volumio sudo[1846]: pam_unix(sudo:session): session closed for user root Oct 06 18:08:04 volumio sudo[1849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 06 18:08:04 volumio sudo[1849]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 18:08:04 volumio sudo[1849]: pam_unix(sudo:session): session closed for user root Oct 06 18:08:04 volumio volumio[711]: verbose: New Socket.io Connection to 192.168.68.92 from 192.168.68.70 UA: Mozilla/5.0 (Linux; Android 13; IN2013 Build/RKQ1.211119.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Total Clients: 11 Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::volumioGetVisibleSources Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 06 18:08:05 volumio volumio[711]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 06 18:08:05 volumio volumio[711]: info: Received Get System Info Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 18:08:05 volumio volumio[711]: info: Discovery: Getting this device information Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:08:05 volumio volumio[711]: info: Listing playlists Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 06 18:08:05 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 06 18:08:06 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 06 18:08:06 volumio volumio[711]: info: Received Get System Info Oct 06 18:08:06 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 18:08:06 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 18:08:06 volumio volumio[711]: info: Discovery: Getting this device information Oct 06 18:08:06 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:08:06 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 18:08:08 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 06 18:08:08 volumio volumio[711]: info: Received Get System Info Oct 06 18:08:08 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 18:08:08 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 18:08:08 volumio volumio[711]: info: Discovery: Getting this device information Oct 06 18:08:08 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:08:08 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 18:08:08 volumio volumio[711]: info: CoreCommandRouter::volumioGetQueue Oct 06 18:08:08 volumio volumio[711]: info: CoreStateMachine::getQueue Oct 06 18:08:08 volumio volumio[711]: info: CorePlayQueue::getQueue Oct 06 18:08:08 volumio volumio[711]: info: Executing endpoint metavolumio Oct 06 18:08:08 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 06 18:08:08 volumio volumio[711]: info: Executing endpoint metavolumio Oct 06 18:08:08 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 06 18:08:08 volumio volumio[711]: info: CorePlayQueue::getTrack 0 Oct 06 18:08:08 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: tidal , goto Oct 06 18:08:08 volumio volumio[711]: info: explodeTIDALUri took 126 milliseconds Oct 06 18:08:09 volumio volumio[711]: info: browseTIDALUri took 727 milliseconds Oct 06 18:08:09 volumio volumio[711]: info: Executing endpoint getSimilarArtists Oct 06 18:08:09 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Oct 06 18:08:10 volumio volumio[711]: info: Executing endpoint metavolumio Oct 06 18:08:10 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 06 18:08:12 volumio volumio[711]: error: Failed request for metavolumio API Oct 06 18:08:13 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 18:08:13 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 18:08:13 volumio volumio[711]: info: Discovery: Getting this device information Oct 06 18:08:13 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:08:13 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 18:08:18 volumio sudo[1853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 06 18:08:18 volumio sudo[1853]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 18:08:18 volumio sudo[1853]: pam_unix(sudo:session): session closed for user root Oct 06 18:08:18 volumio sudo[1856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 06 18:08:18 volumio sudo[1856]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 18:08:18 volumio sudo[1856]: pam_unix(sudo:session): session closed for user root Oct 06 18:08:18 volumio volumio[711]: verbose: New Socket.io Connection to 192.168.68.92 from 192.168.68.70 UA: Mozilla/5.0 (Linux; Android 13; IN2013 Build/RKQ1.211119.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Total Clients: 12 Oct 06 18:08:19 volumio sudo[1859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 06 18:08:19 volumio sudo[1859]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 18:08:19 volumio sudo[1859]: pam_unix(sudo:session): session closed for user root Oct 06 18:08:19 volumio sudo[1862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 06 18:08:19 volumio sudo[1862]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 18:08:19 volumio sudo[1862]: pam_unix(sudo:session): session closed for user root Oct 06 18:08:19 volumio volumio[711]: verbose: New Socket.io Connection to 192.168.68.92 from 192.168.68.70 UA: Mozilla/5.0 (Linux; Android 13; IN2013 Build/RKQ1.211119.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Total Clients: 13 Oct 06 18:08:19 volumio volumio[711]: info: Executing endpoint metavolumio Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::volumioGetVisibleSources Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::volumioGetQueue Oct 06 18:08:19 volumio volumio[711]: info: CoreStateMachine::getQueue Oct 06 18:08:19 volumio volumio[711]: info: CorePlayQueue::getQueue Oct 06 18:08:19 volumio volumio[711]: info: Listing playlists Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 06 18:08:19 volumio volumio[711]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 06 18:08:19 volumio volumio[711]: info: Received Get System Info Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 18:08:19 volumio volumio[711]: info: Discovery: Getting this device information Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 06 18:08:19 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 06 18:08:21 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 06 18:08:21 volumio volumio[711]: info: Received Get System Info Oct 06 18:08:21 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 18:08:21 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 18:08:21 volumio volumio[711]: info: Discovery: Getting this device information Oct 06 18:08:21 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:08:21 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 18:08:21 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 06 18:08:21 volumio volumio[711]: info: Received Get System Info Oct 06 18:08:21 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 18:08:21 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 18:08:21 volumio volumio[711]: info: Discovery: Getting this device information Oct 06 18:08:21 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:08:21 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 18:08:23 volumio volumio[711]: error: Failed request for metavolumio API Oct 06 18:08:25 volumio nmbd[647]: [2024/10/06 18:08:25.789175, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 06 18:08:25 volumio nmbd[647]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.68.92 for name WORKGROUP<1d>. Oct 06 18:08:25 volumio nmbd[647]: This response was from IP 192.168.68.95, reporting an IP address of 192.168.68.95. Oct 06 18:08:33 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 06 18:08:33 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 06 18:08:37 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 06 18:08:37 volumio volumio[711]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 06 18:08:37 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 06 18:08:37 volumio volumio[711]: info: Received Get System Version Oct 06 18:08:37 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 06 18:08:37 volumio volumio[711]: info: Received Get System Info Oct 06 18:08:37 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 18:08:37 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 18:08:37 volumio volumio[711]: info: Discovery: Getting this device information Oct 06 18:08:37 volumio volumio[711]: info: CoreCommandRouter::volumioGetState Oct 06 18:08:37 volumio volumio[711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 18:08:41 volumio sudo[1870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i s/localhost:4004/localhost:3000/g /opt/volumiokiosk.sh Oct 06 18:08:41 volumio sudo[1870]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 18:08:41 volumio sudo[1870]: pam_unix(sudo:session): session closed for user root Oct 06 18:08:41 volumio volumio[711]: [sudo] password for volumio: info: [now-playing] Executing /usr/bin/sudo /bin/systemctl status volumio-kiosk Oct 06 18:08:41 volumio sudo[1873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status volumio-kiosk Oct 06 18:08:41 volumio sudo[1873]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 18:08:41 volumio sudo[1873]: pam_unix(sudo:session): session closed for user root Oct 06 18:08:41 volumio volumio[711]: info: [now-playing] Executing /usr/bin/sudo /bin/systemctl restart volumio-kiosk Oct 06 18:08:42 volumio sudo[1876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-kiosk Oct 06 18:08:42 volumio sudo[1876]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 18:08:42 volumio startx[972]: xinit: connection to X server lost Oct 06 18:08:42 volumio startx[972]: [1B blob data] Oct 06 18:08:42 volumio systemd[1]: Stopping Volumio Kiosk... Oct 06 18:08:42 volumio volumio[711]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 06 18:08:42 volumio startx[972]: waiting for X server to shut down (II) Server terminated successfully (0). Closing log file. Oct 06 18:08:42 volumio volumio[711]: error: touch_display: Xserver unix domain socket cannot be determined. Oct 06 18:08:42 volumio volumio[711]: error: touch_display: Xserver unix domain socket cannot be determined. Oct 06 18:08:42 volumio volumio[711]: error: touch_display: Xserver unix domain socket cannot be determined. Oct 06 18:08:42 volumio volumio[711]: error: touch_display: Xserver unix domain socket cannot be determined. Oct 06 18:08:42 volumio volumio[711]: error: touch_display: Xserver unix domain socket cannot be determined. Oct 06 18:08:42 volumio volumio[711]: error: touch_display: Xserver unix domain socket cannot be determined. Oct 06 18:08:42 volumio volumio[711]: error: touch_display: Xserver unix domain socket cannot be determined. Oct 06 18:08:43 volumio startx[972]: xinit: unexpected signal 15 Oct 06 18:08:43 volumio sudo[1903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Oct 06 18:08:43 volumio sudo[1903]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 18:08:43 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Oct 06 18:08:43 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Oct 06 18:08:43 volumio systemd[1]: Stopped Volumio Kiosk. Oct 06 18:08:43 volumio sudo[1901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /Option "TransformationMatrix"/d /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Oct 06 18:08:43 volumio sudo[1901]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 18:08:43 volumio sudo[1901]: pam_unix(sudo:session): session closed for user root Oct 06 18:08:43 volumio volumio[711]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 18:08:43 volumio volumio[711]: Error: connect ENOENT /tmp/.X11-unix/X Oct 06 18:08:43 volumio volumio[711]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Oct 06 18:08:43 volumio volumio[711]: errno: -2, Oct 06 18:08:43 volumio volumio[711]: code: 'ENOENT', Oct 06 18:08:43 volumio volumio[711]: syscall: 'connect', Oct 06 18:08:43 volumio volumio[711]: address: '/tmp/.X11-unix/X' Oct 06 18:08:43 volumio volumio[711]: } Oct 06 18:08:43 volumio volumio[711]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 18:08:43 volumio systemd[1]: Started Volumio Kiosk. Oct 06 18:08:43 volumio sudo[1876]: pam_unix(sudo:session): session closed for user root Oct 06 18:08:43 volumio systemd[1]: Stopping Volumio Kiosk... Oct 06 18:08:43 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=killed, status=15/TERM Oct 06 18:08:43 volumio systemd[1]: volumio-kiosk.service: Succeeded. Oct 06 18:08:43 volumio systemd[1]: Stopped Volumio Kiosk. Oct 06 18:08:43 volumio sudo[1903]: pam_unix(sudo:session): session closed for user root Oct 06 18:08:43 volumio sudo[1927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-06 18:07 Oct 06 18:08:43 volumio sudo[1927]: 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="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 03:38:28 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4163d3756b55b3bf7c480d7285f68954"