-- Logs begin at Thu 2019-02-14 19:12:00 KST, end at Sat 2024-10-26 16:02:02 KST. -- Oct 26 16:01:01 hswh-dx volumio[795]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Oct 26 16:01:05 hswh-dx volumio[795]: info: browseTIDALUri took 3681 milliseconds Oct 26 16:01:05 hswh-dx volumio[795]: info: Preload queue cleared Oct 26 16:01:05 hswh-dx volumio[795]: info: Preload queue cleared Oct 26 16:01:12 hswh-dx volumiologrotate[543]: ls: cannot access '/var/log/samba/log.wb-HSWH': No such file or directory Oct 26 16:01:12 hswh-dx volumiologrotate[543]: ls: cannot access 'DX': No such file or directory Oct 26 16:01:23 hswh-dx volumio[795]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Oct 26 16:01:24 hswh-dx volumio[795]: info: browseTIDALUri took 1090 milliseconds Oct 26 16:01:24 hswh-dx volumio[795]: info: Preload queue cleared Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170600 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170601 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170602 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170603 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170604 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170605 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170606 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170607 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170608 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170609 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170610 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170611 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170612 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170613 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170614 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170615 Oct 26 16:01:24 hswh-dx volumio[795]: info: Preloading song: tidal://song/320170616 Oct 26 16:01:24 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170600 in service tidal Oct 26 16:01:24 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170601 in service tidal Oct 26 16:01:24 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170602 in service tidal Oct 26 16:01:24 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170603 in service tidal Oct 26 16:01:24 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170604 in service tidal Oct 26 16:01:24 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170605 in service tidal Oct 26 16:01:25 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170606 in service tidal Oct 26 16:01:25 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170607 in service tidal Oct 26 16:01:25 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170608 in service tidal Oct 26 16:01:25 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170609 in service tidal Oct 26 16:01:25 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170610 in service tidal Oct 26 16:01:25 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170611 in service tidal Oct 26 16:01:25 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170612 in service tidal Oct 26 16:01:25 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170613 in service tidal Oct 26 16:01:25 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170614 in service tidal Oct 26 16:01:25 hswh-dx volumio[795]: info: explodeTIDALUri took 751 milliseconds Oct 26 16:01:25 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170615 in service tidal Oct 26 16:01:25 hswh-dx volumio[795]: info: explodeTIDALUri took 752 milliseconds Oct 26 16:01:25 hswh-dx volumio[795]: info: Exploding uri tidal://song/320170616 in service tidal Oct 26 16:01:25 hswh-dx volumio[795]: info: explodeTIDALUri took 762 milliseconds Oct 26 16:01:25 hswh-dx volumio[795]: info: explodeTIDALUri took 756 milliseconds Oct 26 16:01:25 hswh-dx volumio[795]: info: explodeTIDALUri took 757 milliseconds Oct 26 16:01:25 hswh-dx volumio[795]: info: explodeTIDALUri took 745 milliseconds Oct 26 16:01:25 hswh-dx volumio[795]: info: explodeTIDALUri took 787 milliseconds Oct 26 16:01:25 hswh-dx volumio[795]: info: explodeTIDALUri took 774 milliseconds Oct 26 16:01:25 hswh-dx volumio[795]: info: explodeTIDALUri took 748 milliseconds Oct 26 16:01:25 hswh-dx volumio[795]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 16:01:25 hswh-dx volumio[795]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 16:01:25 hswh-dx volumio[795]: info: Discovery: Getting this device information Oct 26 16:01:25 hswh-dx volumio[795]: info: CoreCommandRouter::volumioGetState Oct 26 16:01:25 hswh-dx volumio[795]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 16:01:25 hswh-dx volumio[795]: info: explodeTIDALUri took 761 milliseconds Oct 26 16:01:25 hswh-dx volumio[795]: info: explodeTIDALUri took 779 milliseconds Oct 26 16:01:26 hswh-dx volumio[795]: info: explodeTIDALUri took 760 milliseconds Oct 26 16:01:26 hswh-dx volumio[795]: info: explodeTIDALUri took 759 milliseconds Oct 26 16:01:26 hswh-dx volumio[795]: info: explodeTIDALUri took 747 milliseconds Oct 26 16:01:26 hswh-dx volumio[795]: info: explodeTIDALUri took 746 milliseconds Oct 26 16:01:26 hswh-dx volumio[795]: info: explodeTIDALUri took 750 milliseconds Oct 26 16:01:26 hswh-dx volumio[795]: info: explodeTIDALUri took 719 milliseconds Oct 26 16:01:28 hswh-dx volumio[795]: info: Preload queue cleared Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::ClearQueue Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::stop Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::stPlaybackTimer Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::updateTrackBlock Oct 26 16:01:28 hswh-dx volumio[795]: info: CorePlayQueue::getTrackBlock Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::pushState Oct 26 16:01:28 hswh-dx volumio[795]: info: CorePlayQueue::getTrack 0 Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreCommandRouter::volumioPushState Oct 26 16:01:28 hswh-dx volumio[795]: info: MRS: Pushing multiroomSync output update for this device Oct 26 16:01:28 hswh-dx volumio[795]: info: MRS: Pushing multiroomSync output Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::serviceStop Oct 26 16:01:28 hswh-dx volumio[795]: info: CorePlayQueue::getTrack 0 Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreCommandRouter::serviceStop Oct 26 16:01:28 hswh-dx volumio[795]: info: [1729926088504] ControllerWebradio::stop Oct 26 16:01:28 hswh-dx volumio[795]: verbose: ControllerMpd::sendMpdCommand stop Oct 26 16:01:28 hswh-dx volumio[795]: info: CorePlayQueue::clearPlayQueue Oct 26 16:01:28 hswh-dx volumio[795]: info: CorePlayQueue::saveQueue Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreCommandRouter::volumioPushQueue Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::addQueueItems Oct 26 16:01:28 hswh-dx volumio[795]: info: CorePlayQueue::addQueueItems Oct 26 16:01:28 hswh-dx volumio[795]: info: Preload queue cleared Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170600 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170600 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170601 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170601 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170602 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170602 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170603 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170603 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170604 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170604 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170605 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170605 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170606 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170606 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170607 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170607 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170608 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170608 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170609 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170609 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170610 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170610 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170611 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170611 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170612 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170612 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170613 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170613 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170614 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170614 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170615 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170615 Oct 26 16:01:28 hswh-dx volumio[795]: info: Adding Item to queue: tidal://song/320170616 Oct 26 16:01:28 hswh-dx volumio[795]: info: Using cached record of: tidal://song/320170616 Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreCommandRouter::volumioPushQueue Oct 26 16:01:28 hswh-dx volumio[795]: info: CorePlayQueue::saveQueue Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::updateTrackBlock Oct 26 16:01:28 hswh-dx volumio[795]: info: CorePlayQueue::getTrackBlock Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreCommandRouter::volumioPlay Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::play index 0 Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::stop Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::play index undefined Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 16:01:28 hswh-dx volumio[795]: info: CorePlayQueue::getTrack 0 Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::startPlaybackTimer Oct 26 16:01:28 hswh-dx volumio[795]: info: CorePlayQueue::getTrack 0 Oct 26 16:01:28 hswh-dx volumio[795]: info: [1729926088570] ControllerTidal::clearAddPlayTrack Oct 26 16:01:28 hswh-dx volumio[795]: info: Getting stream with soundQuality LOSSLESS Oct 26 16:01:28 hswh-dx volumio[795]: verbose: ControllerMpd::sendMpdCommand stop Oct 26 16:01:28 hswh-dx volumio[795]: info: Oct 26 16:01:28 hswh-dx volumio[795]: ---------------------------- MPD announces state update: player Oct 26 16:01:28 hswh-dx volumio[795]: info: sendMpdCommand stop took 166 milliseconds Oct 26 16:01:28 hswh-dx volumio[795]: info: ControllerMpd::getState Oct 26 16:01:28 hswh-dx volumio[795]: verbose: ControllerMpd::sendMpdCommand status Oct 26 16:01:28 hswh-dx volumio[795]: info: sendMpdCommand stop took 97 milliseconds Oct 26 16:01:28 hswh-dx volumio[795]: verbose: ControllerMpd::sendMpdCommand clear Oct 26 16:01:28 hswh-dx volumio[795]: info: Oct 26 16:01:28 hswh-dx volumio[795]: ---------------------------- MPD announces system playlist update Oct 26 16:01:28 hswh-dx volumio[795]: info: Ignoring MPD Status Update Oct 26 16:01:28 hswh-dx volumio[795]: info: sendMpdCommand status took 59 milliseconds Oct 26 16:01:28 hswh-dx volumio[795]: info: sendMpdCommand clear took 57 milliseconds Oct 26 16:01:28 hswh-dx volumio[795]: verbose: ControllerMpd::parseState Oct 26 16:01:28 hswh-dx volumio[795]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 16:01:28 hswh-dx volumio[795]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/320170600&soundQuality=LOSSLESS" Oct 26 16:01:28 hswh-dx volumio[795]: error: updateQueue error: null Oct 26 16:01:28 hswh-dx volumio[795]: info: Oct 26 16:01:28 hswh-dx volumio[795]: ---------------------------- MPD announces system playlist update Oct 26 16:01:28 hswh-dx volumio[795]: info: Ignoring MPD Status Update Oct 26 16:01:28 hswh-dx volumio[795]: info: ------------------------------ 20ms Oct 26 16:01:28 hswh-dx volumio[795]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 26 16:01:28 hswh-dx volumio[795]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/320170600&soundQuality=LOSSLESS" took 10 milliseconds Oct 26 16:01:28 hswh-dx volumio[795]: verbose: ControllerMpd::parseTrackInfo Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 26 16:01:28 hswh-dx volumio[795]: verbose: ControllerMpd::sendMpdCommand play Oct 26 16:01:28 hswh-dx volumio[795]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 26 16:01:28 hswh-dx volumio[795]: info: ------------------------------ 103ms Oct 26 16:01:28 hswh-dx volumio[795]: STREAMING PROXY: Handling url /?data=tidal://song/320170600&soundQuality=LOSSLESS Oct 26 16:01:28 hswh-dx volumio[795]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 26 16:01:28 hswh-dx volumio[795]: info: ------------------------------ 34ms Oct 26 16:01:28 hswh-dx volumio[795]: info: sendMpdCommand play took 23 milliseconds Oct 26 16:01:28 hswh-dx volumio[795]: info: Executing endpoint getStreamUrltidal Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Oct 26 16:01:28 hswh-dx volumio[795]: info: CoreCommandRouter::volumioGetState Oct 26 16:01:29 hswh-dx volumio[795]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Oct 26 16:01:29 hswh-dx volumio[795]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 26 16:01:29 hswh-dx volumio[795]: info: getStreamUrl took 760 milliseconds Oct 26 16:01:29 hswh-dx volumio[795]: STREAMING PROXY: Got real url: http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEidkOGZiZjlkMWU3ZjczMjNkNzdiMDQyMTkzNGM5YzFiNV82MS5tcDQ/0.flac?Expires=1729929689&Signature=QVR4y2W6SDvB7RmFYuc~7nvh9JM1OKTosSsjFR14IaJK-erkG1-emNf2uhYu78FkpxztR44CAJJ03MGolUcGGVBmbOfZA0~WRXVxAu~VOyk6b9vrfwkgCa28dNjiP3WJs7YNDtUTGsQuhPyjWRysKcu9Xaf062pgre2CcRu5wtI5D9lWr7tgpeiNDnYUG5FYgr-RZvQmfXT8UYWwurwOOhiM-Z7SKpR304YXkrYgtoR-vQPHwaFbQC9oeCh93TDbfzCzk4aTQta6F3TbgWN0d3UnKkZwcdXSa2gcr1IED4aehf3vZZXDTLfCUu1fiM6D29S~14R2bFi9r1PYnnbOYA__&Key-Pair-Id=K14LZCZ9QUI4JL Oct 26 16:01:29 hswh-dx volumio[795]: STREAMING PROXY: Response: 200, length: 35271627 Oct 26 16:01:29 hswh-dx volumio[795]: info: Oct 26 16:01:29 hswh-dx volumio[795]: ---------------------------- MPD announces state update: player Oct 26 16:01:29 hswh-dx volumio[795]: info: ControllerMpd::getState Oct 26 16:01:29 hswh-dx volumio[795]: verbose: ControllerMpd::sendMpdCommand status Oct 26 16:01:29 hswh-dx volumio[795]: info: Oct 26 16:01:29 hswh-dx volumio[795]: ---------------------------- MPD announces state update: player Oct 26 16:01:29 hswh-dx volumio[795]: info: ControllerMpd::getState Oct 26 16:01:29 hswh-dx volumio[795]: verbose: ControllerMpd::sendMpdCommand status Oct 26 16:01:29 hswh-dx volumio[795]: info: sendMpdCommand status took 4 milliseconds Oct 26 16:01:29 hswh-dx volumio[795]: verbose: ControllerMpd::parseState Oct 26 16:01:29 hswh-dx volumio[795]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 16:01:29 hswh-dx volumio[795]: info: sendMpdCommand status took 4 milliseconds Oct 26 16:01:29 hswh-dx volumio[795]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 26 16:01:29 hswh-dx volumio[795]: verbose: ControllerMpd::parseState Oct 26 16:01:29 hswh-dx volumio[795]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 16:01:29 hswh-dx volumio[795]: verbose: ControllerMpd::parseTrackInfo Oct 26 16:01:29 hswh-dx volumio[795]: info: ControllerMpd::pushState Oct 26 16:01:29 hswh-dx volumio[795]: info: CoreCommandRouter::servicePushState Oct 26 16:01:29 hswh-dx volumio[795]: info: CorePlayQueue::getTrack 0 Oct 26 16:01:29 hswh-dx volumio[795]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":547,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"320170600&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/320170600&soundQuality=LOSSLESS","trackType":"tidal"} Oct 26 16:01:29 hswh-dx volumio[795]: verbose: CURRENT POSITION 0 Oct 26 16:01:29 hswh-dx volumio[795]: info: CoreStateMachine::syncState stateService play Oct 26 16:01:29 hswh-dx volumio[795]: info: CoreStateMachine::syncState currentStatus stop Oct 26 16:01:29 hswh-dx volumio[795]: info: ------------------------------ 37ms Oct 26 16:01:29 hswh-dx volumio[795]: info: sendMpdCommand playlistinfo took 25 milliseconds Oct 26 16:01:29 hswh-dx volumio[795]: verbose: ControllerMpd::parseTrackInfo Oct 26 16:01:29 hswh-dx volumio[795]: info: ControllerMpd::pushState Oct 26 16:01:29 hswh-dx volumio[795]: info: CoreCommandRouter::servicePushState Oct 26 16:01:29 hswh-dx volumio[795]: info: CorePlayQueue::getTrack 0 Oct 26 16:01:29 hswh-dx volumio[795]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":547,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"320170600&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/320170600&soundQuality=LOSSLESS","trackType":"tidal"} Oct 26 16:01:29 hswh-dx volumio[795]: verbose: CURRENT POSITION 0 Oct 26 16:01:29 hswh-dx volumio[795]: info: CoreStateMachine::syncState stateService play Oct 26 16:01:29 hswh-dx volumio[795]: info: CoreStateMachine::syncState currentStatus play Oct 26 16:01:29 hswh-dx volumio[795]: info: Received an update from plugin. extracting info from payload Oct 26 16:01:29 hswh-dx volumio[795]: info: CoreStateMachine::pushState Oct 26 16:01:29 hswh-dx volumio[795]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 16:01:29 hswh-dx volumio[795]: info: CoreCommandRouter::volumioPushState Oct 26 16:01:29 hswh-dx volumio[795]: info: MRS: Pushing multiroomSync output update for this device Oct 26 16:01:29 hswh-dx volumio[795]: info: MRS: Pushing multiroomSync output Oct 26 16:01:29 hswh-dx volumio[795]: info: CoreStateMachine::pushState Oct 26 16:01:29 hswh-dx volumio[795]: info: CoreCommandRouter::volumioPushState Oct 26 16:01:29 hswh-dx volumio[795]: info: MRS: Pushing multiroomSync output update for this device Oct 26 16:01:29 hswh-dx volumio[795]: info: MRS: Pushing multiroomSync output Oct 26 16:01:29 hswh-dx volumio[795]: info: ------------------------------ 109ms Oct 26 16:01:29 hswh-dx volumio[795]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 26 16:01:32 hswh-dx volumio[795]: STREAMING PROXY: Client dropped request, destroying Oct 26 16:01:55 hswh-dx volumio[795]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 16:01:55 hswh-dx volumio[795]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 16:01:55 hswh-dx volumio[795]: info: Discovery: Getting this device information Oct 26 16:01:55 hswh-dx volumio[795]: info: CoreCommandRouter::volumioGetState Oct 26 16:01:55 hswh-dx volumio[795]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 16:01:59 hswh-dx volumio[795]: info: CoreCommandRouter::volumioSaveQueueToPlaylist Oct 26 16:01:59 hswh-dx volumio[795]: info: CoreStateMachine::getQueue Oct 26 16:01:59 hswh-dx volumio[795]: info: CorePlayQueue::getQueue Oct 26 16:01:59 hswh-dx volumio[795]: info: Saving Cloud item Saint-Saëns Cello Sonata No.1 in C minor, Op.32 Mats Lidström Oct 26 16:01:59 hswh-dx volumio[795]: info: CoreCommandRouter::executeOnPlugin: my_volumio , saveCloudItem Oct 26 16:01:59 hswh-dx volumio[795]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 16:01:59 hswh-dx volumio[795]: Error: Reference.child failed: First argument was an invalid path = "/user_data/Y1tqxwgnPBO41HjZ1ERZzk9xxef1/myPlaylists/Saint-Saëns Cello Sonata No.1 in C minor, Op.32 Mats Lidström". Paths must be non-empty strings and can't contain ".", "#", "$", "[", or "]" Oct 26 16:01:59 hswh-dx volumio[795]: at validatePathString (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:1667:15) Oct 26 16:01:59 hswh-dx volumio[795]: at validateRootPathString (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:1679:5) Oct 26 16:01:59 hswh-dx volumio[795]: at Reference.child (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:13737:17) Oct 26 16:01:59 hswh-dx volumio[795]: at Database.ref (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:15115:48) Oct 26 16:01:59 hswh-dx volumio[795]: at myVolumio.syncJSONToCloud (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:28817) Oct 26 16:01:59 hswh-dx volumio[795]: at myVolumio.saveCloudMyPlaylist (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:23840) Oct 26 16:01:59 hswh-dx volumio[795]: at myVolumio.saveCloudItem (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:18337) Oct 26 16:01:59 hswh-dx volumio[795]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1083:32) Oct 26 16:01:59 hswh-dx volumio[795]: at PlaylistManager.saveJSONFile (/volumio/app/playlistManager.js:613:31) Oct 26 16:01:59 hswh-dx volumio[795]: at PlaylistManager.commonAddItemsToPlaylist (/volumio/app/playlistManager.js:834:8) Oct 26 16:01:59 hswh-dx volumio[795]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 16:02:02 hswh-dx sudo[21874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-26 16:01 Oct 26 16:02:02 hswh-dx sudo[21874]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"