-- Logs begin at Thu 2019-02-14 12:11:58 EET, end at Fri 2025-07-11 18:54:53 EEST. -- Jul 11 18:54:16 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 18:54:16 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 18:54:16 volumio volumio[1196]: info: Discovery: Getting this device information Jul 11 18:54:16 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:16 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 18:54:16 volumio volumio[1196]: verbose: New Socket.io Connection to 192.168.8.4:3000 from 192.168.8.3 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Jul 11 18:54:16 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:16 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 11 18:54:16 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 11 18:54:17 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:18 volumio sudo[2152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 11 18:54:18 volumio sudo[2152]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:18 volumio sudo[2152]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:18 volumio sudo[2155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 11 18:54:18 volumio sudo[2155]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:18 volumio sudo[2155]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:18 volumio volumio[1196]: verbose: New Socket.io Connection to 192.168.8.4 from 192.168.8.3 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10 Jul 11 18:54:18 volumio sudo[2158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 11 18:54:18 volumio sudo[2158]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:18 volumio sudo[2158]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:18 volumio sudo[2161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 11 18:54:18 volumio sudo[2161]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:18 volumio sudo[2161]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:18 volumio volumio[1196]: verbose: New Socket.io Connection to 192.168.8.4 from 192.168.8.3 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 11 Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::volumioGetVisibleSources Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::volumioGetQueue Jul 11 18:54:18 volumio volumio[1196]: info: CoreStateMachine::getQueue Jul 11 18:54:18 volumio volumio[1196]: info: CorePlayQueue::getQueue Jul 11 18:54:18 volumio volumio[1196]: info: Listing playlists Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 11 18:54:18 volumio volumio[1196]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 11 18:54:18 volumio volumio[1196]: info: Received Get System Info Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 18:54:18 volumio volumio[1196]: info: Discovery: Getting this device information Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 11 18:54:18 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 11 18:54:20 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 11 18:54:20 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 11 18:54:20 volumio volumio[1196]: info: Received Get System Info Jul 11 18:54:20 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 18:54:20 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 18:54:20 volumio volumio[1196]: info: Discovery: Getting this device information Jul 11 18:54:20 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:20 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 18:54:20 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 11 18:54:21 volumio volumio[1196]: info: Preload queue cleared Jul 11 18:54:21 volumio volumio[1196]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 11 18:54:21 volumio volumio[1196]: info: CoreStateMachine::ClearQueue Jul 11 18:54:21 volumio volumio[1196]: info: CoreStateMachine::stop Jul 11 18:54:21 volumio volumio[1196]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 18:54:21 volumio volumio[1196]: info: CorePlayQueue::clearPlayQueue Jul 11 18:54:21 volumio volumio[1196]: info: CorePlayQueue::saveQueue Jul 11 18:54:21 volumio volumio[1196]: info: CoreCommandRouter::volumioPushQueue Jul 11 18:54:21 volumio volumio[1196]: info: CoreStateMachine::addQueueItems Jul 11 18:54:21 volumio volumio[1196]: info: CorePlayQueue::addQueueItems Jul 11 18:54:21 volumio volumio[1196]: info: Preload queue cleared Jul 11 18:54:21 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/101045489 Jul 11 18:54:21 volumio volumio[1196]: info: Exploding uri qobuz://song/101045489 in service qobuz Jul 11 18:54:21 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:21 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/101045485 Jul 11 18:54:21 volumio volumio[1196]: info: Exploding uri qobuz://song/101045485 in service qobuz Jul 11 18:54:21 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:21 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/337070717 Jul 11 18:54:21 volumio volumio[1196]: info: Exploding uri qobuz://song/337070717 in service qobuz Jul 11 18:54:21 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:21 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/1570124 Jul 11 18:54:21 volumio volumio[1196]: info: Exploding uri qobuz://song/1570124 in service qobuz Jul 11 18:54:21 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: explodeUri took 667 milliseconds Jul 11 18:54:22 volumio volumio[1196]: info: explodeUri took 664 milliseconds Jul 11 18:54:22 volumio volumio[1196]: info: explodeUri took 706 milliseconds Jul 11 18:54:22 volumio volumio[1196]: info: explodeUri took 713 milliseconds Jul 11 18:54:22 volumio volumio[1196]: info: CoreCommandRouter::volumioPushQueue Jul 11 18:54:22 volumio volumio[1196]: info: CorePlayQueue::saveQueue Jul 11 18:54:22 volumio volumio[1196]: info: CoreStateMachine::updateTrackBlock Jul 11 18:54:22 volumio volumio[1196]: info: CorePlayQueue::getTrackBlock Jul 11 18:54:22 volumio volumio[1196]: info: CoreCommandRouter::volumioPlay Jul 11 18:54:22 volumio volumio[1196]: info: CoreStateMachine::play index 3 Jul 11 18:54:22 volumio volumio[1196]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 18:54:22 volumio volumio[1196]: info: CoreStateMachine::addQueueItems Jul 11 18:54:22 volumio volumio[1196]: info: CorePlayQueue::addQueueItems Jul 11 18:54:22 volumio volumio[1196]: info: Preload queue cleared Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/1565732 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/1565732 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/37878762 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/37878762 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/37878512 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/37878512 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/180125542 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/180125542 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/4824493 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/4824493 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/66104846 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/66104846 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/54650571 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/54650571 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/91140299 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/91140299 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/330603130 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/330603130 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/68232561 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/68232561 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/23402474 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/23402474 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/33989783 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/33989783 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/33989714 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/33989714 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/211594982 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/211594982 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/299469187 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/299469187 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/5711328 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/5711328 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/734519 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/734519 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/117005077 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/117005077 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/49192293 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/49192293 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/155749724 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/155749724 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/208358218 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/208358218 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/36390211 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/36390211 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/145130327 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/145130327 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/37100335 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/37100335 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/86099506 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/86099506 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/266353002 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/266353002 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/296090133 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/296090133 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/155749721 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/155749721 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/47683835 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/47683835 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/291648395 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/291648395 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/58576796 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/58576796 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/122513347 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/122513347 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/61710058 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/61710058 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/267256416 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/267256416 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/89008891 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/89008891 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/77469835 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/77469835 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/220649451 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/220649451 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/25849948 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/25849948 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/205906913 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/205906913 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/27923129 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/27923129 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/13179646 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/13179646 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/7400 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/7400 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/15387103 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/15387103 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/53662589 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/53662589 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/80758921 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/80758921 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/54091881 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/54091881 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/38933065 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/38933065 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/13079615 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/13079615 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/49282452 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/49282452 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/117519415 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/117519415 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/185992 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/185992 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/4852498 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/4852498 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/152169892 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/152169892 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/388626 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/388626 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/28168295 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/28168295 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/319363897 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/319363897 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/78292617 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/78292617 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/46176988 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/46176988 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/127039825 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/127039825 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/157843747 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/157843747 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/261245399 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/261245399 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/35853937 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/35853937 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/291163973 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/291163973 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/203360021 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/203360021 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/49025721 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/49025721 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/52588132 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/52588132 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/236720678 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/236720678 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/233864953 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/233864953 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/779455 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/779455 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/184744096 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/184744096 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/61710055 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/61710055 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/34043524 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/34043524 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/225330957 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/225330957 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/243241739 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/243241739 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/266451 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/266451 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/142597106 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/142597106 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/188599994 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/188599994 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/247432708 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/247432708 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/236721136 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/236721136 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/13254263 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/13254263 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/44045459 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/44045459 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/3113024 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/3113024 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/174773795 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/174773795 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/85416572 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/85416572 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/21452011 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/21452011 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/200804904 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/200804904 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/127844664 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/127844664 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/35853941 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/35853941 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/169770572 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/169770572 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/196708081 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/196708081 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/331983159 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/331983159 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/36114782 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/36114782 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/88015489 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/88015489 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/35466429 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/35466429 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/118050319 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/118050319 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/12186077 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/12186077 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/335352938 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/335352938 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/21471226 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/21471226 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/319363870 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/319363870 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/15957184 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/15957184 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/61898721 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/61898721 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/175929704 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/175929704 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/34043783 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/34043783 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/164490659 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/164490659 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/47683844 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/47683844 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/47683894 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/47683894 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/19906039 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/19906039 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/168853765 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/168853765 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/35528884 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/35528884 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/59672924 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/59672924 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/232147192 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/232147192 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/30445575 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/30445575 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/62008127 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/62008127 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/51211672 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/51211672 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/251688562 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/251688562 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/4754910 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/4754910 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/156900384 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/156900384 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/4683260 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/4683260 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/214391862 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/214391862 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/105345396 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/105345396 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/54915975 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/54915975 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/16014978 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/16014978 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/135238500 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/135238500 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/67594552 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/67594552 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/16304049 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/16304049 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/232148222 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/232148222 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/779441 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/779441 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/122687048 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/122687048 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/127856871 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/127856871 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/29794748 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/29794748 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/758735 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/758735 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/197320134 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/197320134 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/201866220 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/201866220 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/2719258 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/2719258 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/54944120 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/54944120 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/75491670 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/75491670 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/54091879 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/54091879 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/122805535 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/122805535 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/170904189 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/170904189 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/193958190 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/193958190 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/3852859 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/3852859 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/4754907 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/4754907 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/287600608 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/287600608 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/15644307 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/15644307 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/54380340 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/54380340 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/100421332 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/100421332 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/4754912 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/4754912 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/5382709 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/5382709 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/11321937 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/11321937 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/162073885 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/162073885 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/82167107 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/82167107 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/174088327 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/174088327 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/234684809 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/234684809 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/44075384 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/44075384 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/15679234 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/15679234 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/4849431 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/4849431 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/4680482 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/4680482 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/140408595 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/140408595 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/53665084 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/53665084 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/58419723 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/58419723 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/91863128 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/91863128 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/393922 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/393922 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/168182079 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/168182079 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/34735899 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/34735899 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/61710056 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/61710056 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/123647108 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/123647108 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/15495852 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/15495852 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/106751332 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/106751332 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/263740209 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/263740209 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/3526162 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/3526162 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/136648439 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/136648439 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/166179700 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/166179700 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/204757869 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/204757869 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/155391974 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/155391974 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/34110779 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/34110779 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/127028098 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/127028098 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/134651595 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/134651595 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/4754909 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/4754909 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/636455 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/636455 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/35853968 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/35853968 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/259272308 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/259272308 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/266353004 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/266353004 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/92622508 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/92622508 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/53162452 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/53162452 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/128195560 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/128195560 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/167889718 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/167889718 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/48527723 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/48527723 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/19907859 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/19907859 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/193099944 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/193099944 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/41057389 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/41057389 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/1407344 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/1407344 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/87219447 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/87219447 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/92622501 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/92622501 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/35853950 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/35853950 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/179083059 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/179083059 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/42994865 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/42994865 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/4850585 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/4850585 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/63850462 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/63850462 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/16028737 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/16028737 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/47946766 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/47946766 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/30572266 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/30572266 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/54740856 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/54740856 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/4855076 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/4855076 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/48711694 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/48711694 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/41420856 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/41420856 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/30369633 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/30369633 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/54380345 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/54380345 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/26332268 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/26332268 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/232890879 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/232890879 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/35564501 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/35564501 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/118763799 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/118763799 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/56279123 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/56279123 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/261244933 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/261244933 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/59709686 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/59709686 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/61710057 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/61710057 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/155749715 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/155749715 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/155749718 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/155749718 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/206706273 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/206706273 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/46240190 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/46240190 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/10488484 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/10488484 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/139264146 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/139264146 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/332553730 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/332553730 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/317318046 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/317318046 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/51048409 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/51048409 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/29548595 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/29548595 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/30416103 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/30416103 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/102219134 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/102219134 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/68698586 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/68698586 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/224931088 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/224931088 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/132769549 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/132769549 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/61920535 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/61920535 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/179129595 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/179129595 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/10488267 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/10488267 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/62893618 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/62893618 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/20244195 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/20244195 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/110930509 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/110930509 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/120278085 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/120278085 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/212689365 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/212689365 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/244367275 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/244367275 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/157338729 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/157338729 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/60441320 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/60441320 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/37571054 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/37571054 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/39803227 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/39803227 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/40268862 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/40268862 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/304084046 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/304084046 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/185428438 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/185428438 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/80219166 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/80219166 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/206088889 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/206088889 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/33989768 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/33989768 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/66343372 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/66343372 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/62476242 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/62476242 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/10271289 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/10271289 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/10271360 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/10271360 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/40546502 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/40546502 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/68697868 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/68697868 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/48168910 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/48168910 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/39803237 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/39803237 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/204253341 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/204253341 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/44723804 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/44723804 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/36049067 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/36049067 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/296463936 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/296463936 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/221369048 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/221369048 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/110812644 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/110812644 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/137851238 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/137851238 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/62257116 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/62257116 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/33992094 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/33992094 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/29548622 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/29548622 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/239086998 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/239086998 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/32248049 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/32248049 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/120827781 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/120827781 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/269820297 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/269820297 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/98958529 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/98958529 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/36512455 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/36512455 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/193566224 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/193566224 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/34004157 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/34004157 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/46088092 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/46088092 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/56767593 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/56767593 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/39803224 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/39803224 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/33992130 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/33992130 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/112628298 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/112628298 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/134908064 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/134908064 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/63201459 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/63201459 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/39803246 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/39803246 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/291380290 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/291380290 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/47009921 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/47009921 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/140039794 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/140039794 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/84531810 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/84531810 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/123525756 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/123525756 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/184550632 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/184550632 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/269820290 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/269820290 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/234140098 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/234140098 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/211930432 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/211930432 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/66373632 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/66373632 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/304084058 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/304084058 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/237235371 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/237235371 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/98282363 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/98282363 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/53893726 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/53893726 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/33990153 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/33990153 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/34003846 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/34003846 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/61027288 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/61027288 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/157338737 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/157338737 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/43652173 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/43652173 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/186994261 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/186994261 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/66343384 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/66343384 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/68692479 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/68692479 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/33992079 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/33992079 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/295330403 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/295330403 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/201572223 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/201572223 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/164261632 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/164261632 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/146754926 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/146754926 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/269830673 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/269830673 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/269820298 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/269820298 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/214999682 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/214999682 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/119291708 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/119291708 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/266263319 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/266263319 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/20244188 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/20244188 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/120827776 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/120827776 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/26827549 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/26827549 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/36545592 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/36545592 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/68697739 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/68697739 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: Adding Item to queue: qobuz://song/44900294 Jul 11 18:54:22 volumio volumio[1196]: info: Exploding uri qobuz://song/44900294 in service qobuz Jul 11 18:54:22 volumio volumio[1196]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jul 11 18:54:22 volumio volumio[1196]: info: CoreStateMachine::stop Jul 11 18:54:22 volumio volumio[1196]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 18:54:22 volumio volumio[1196]: info: CoreStateMachine::play index undefined Jul 11 18:54:22 volumio volumio[1196]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 18:54:22 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:22 volumio volumio[1196]: info: CoreStateMachine::startPlaybackTimer Jul 11 18:54:22 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:22 volumio volumio[1196]: info: CoreCommandRouter::volumioGetVisibleSources Jul 11 18:54:22 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 11 18:54:22 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 11 18:54:22 volumio volumio[1196]: info: [1752249262424] ControllerQobuz::clearAddPlayTrack Jul 11 18:54:22 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand stop Jul 11 18:54:22 volumio volumio[1196]: info: Jul 11 18:54:22 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:22 volumio volumio[1196]: info: sendMpdCommand stop took 247 milliseconds Jul 11 18:54:22 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:22 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:22 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand clear Jul 11 18:54:22 volumio volumio[1196]: info: Jul 11 18:54:22 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:22 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:22 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:22 volumio volumio[1196]: info: Jul 11 18:54:22 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:22 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:22 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:22 volumio volumio[1196]: info: Jul 11 18:54:22 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:22 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:22 volumio volumio[1196]: info: sendMpdCommand status took 2 milliseconds Jul 11 18:54:22 volumio volumio[1196]: info: sendMpdCommand clear took 2 milliseconds Jul 11 18:54:22 volumio volumio[1196]: info: sendMpdCommand status took 1 milliseconds Jul 11 18:54:22 volumio volumio[1196]: info: sendMpdCommand status took 1 milliseconds Jul 11 18:54:22 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:22 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 18:54:22 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/1570124" Jul 11 18:54:22 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:22 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:22 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:22 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:22 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:22 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:22 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 18:54:22 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:22 volumio volumio[1196]: STREAMING PROXY: Handling url /?data=qobuz://song/1570124 Jul 11 18:54:22 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:22 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:22 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:22 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:22 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:22 volumio volumio[1196]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jul 11 18:54:22 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:22 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:22 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:22 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:22 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:22 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:22 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:22 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:22 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:22 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:22 volumio volumio[1196]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jul 11 18:54:22 volumio volumio[1196]: info: ------------------------------ 13ms Jul 11 18:54:22 volumio volumio[1196]: info: ------------------------------ 13ms Jul 11 18:54:22 volumio volumio[1196]: info: Jul 11 18:54:22 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:22 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:22 volumio volumio[1196]: info: Jul 11 18:54:22 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:22 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:22 volumio volumio[1196]: error: updateQueue error: null Jul 11 18:54:22 volumio volumio[1196]: info: ------------------------------ 14ms Jul 11 18:54:22 volumio volumio[1196]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 11 18:54:22 volumio volumio[1196]: verbose: ControllerMpd::parseTrackInfo Jul 11 18:54:22 volumio volumio[1196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 11 18:54:22 volumio volumio[1196]: info: ------------------------------ 15ms Jul 11 18:54:22 volumio volumio[1196]: info: [ASDebug] CurState: stop PrevState: undefined Jul 11 18:54:22 volumio volumio[1196]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jul 11 18:54:22 volumio volumio[1196]: info: [ASDebug] CurState: stop PrevState: undefined Jul 11 18:54:22 volumio volumio[1196]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jul 11 18:54:22 volumio volumio[1196]: info: [GPIO_Control] Status changed: stop Jul 11 18:54:22 volumio volumio[1196]: info: [GPIO_Control] Handling event: musicStop Jul 11 18:54:22 volumio volumio[1196]: info: [GPIO_Control] Status changed: stop Jul 11 18:54:22 volumio volumio[1196]: info: Executing endpoint getStreamUrlqobuz Jul 11 18:54:22 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jul 11 18:54:23 volumio volumio[1196]: info: [ASDebug] Togle GPIO: OFF Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1120 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1138 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1161 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1163 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1162 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1159 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1163 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1168 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1219 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1214 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1221 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1217 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1220 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1219 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1222 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1226 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1264 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1271 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1287 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1293 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1308 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1311 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1311 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1319 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1331 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1358 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1358 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1373 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1378 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1372 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1373 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1374 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1420 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1419 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1436 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1444 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1458 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1465 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1477 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1533 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1534 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1537 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1552 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1580 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1630 milliseconds Jul 11 18:54:23 volumio volumio[1196]: info: explodeUri took 1633 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 1681 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 11 18:54:24 volumio volumio[1196]: info: Received Get System Info Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 18:54:24 volumio volumio[1196]: info: Discovery: Getting this device information Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:24 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 11 18:54:24 volumio volumio[1196]: info: Received Get System Info Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 18:54:24 volumio volumio[1196]: info: Discovery: Getting this device information Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:24 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 1841 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 1842 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 1842 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 1988 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 1992 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 1997 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2035 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2036 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2043 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2044 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2046 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2045 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2046 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2046 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2047 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2063 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2065 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2067 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2067 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2079 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2079 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2075 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2086 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2117 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2160 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2164 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2190 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2195 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 11 18:54:24 volumio volumio[1196]: info: Received Get System Info Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 18:54:24 volumio volumio[1196]: info: Discovery: Getting this device information Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:24 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:24 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2223 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2240 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2243 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2298 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2425 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2434 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2431 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2452 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2451 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2453 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2452 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2452 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2453 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2452 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2465 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2464 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2465 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2463 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2472 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2470 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2472 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2473 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2472 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2480 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2478 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2479 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2485 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2570 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2569 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2623 milliseconds Jul 11 18:54:24 volumio volumio[1196]: info: explodeUri took 2639 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2661 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2745 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2762 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2784 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2804 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2810 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2810 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2813 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2820 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2822 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2834 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2855 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2858 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2869 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2872 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2867 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2891 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2901 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2895 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2898 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2897 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2899 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2899 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2903 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2898 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2903 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2912 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2905 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2924 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2959 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2955 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2960 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 2960 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3004 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3006 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3007 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3013 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3017 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3013 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3016 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3023 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3023 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3052 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3057 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3155 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3188 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3188 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3188 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3188 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3190 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3214 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3225 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3233 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3238 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3240 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3240 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3367 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3388 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3388 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3391 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3391 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3394 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3389 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3390 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3390 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3413 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3415 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3424 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3420 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3424 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3423 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3423 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3423 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3451 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3464 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3466 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3504 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3505 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: CoreCommandRouter::volumioPlay Jul 11 18:54:25 volumio volumio[1196]: info: CoreStateMachine::play index undefined Jul 11 18:54:25 volumio volumio[1196]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 18:54:25 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:25 volumio volumio[1196]: info: CoreStateMachine::startPlaybackTimer Jul 11 18:54:25 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:25 volumio volumio[1196]: info: CoreCommandRouter::volumioGetVisibleSources Jul 11 18:54:25 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 11 18:54:25 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 11 18:54:25 volumio volumio[1196]: info: [1752249265892] ControllerQobuz::clearAddPlayTrack Jul 11 18:54:25 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand stop Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3511 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3561 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3560 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3567 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3586 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3587 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3589 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3600 milliseconds Jul 11 18:54:25 volumio volumio[1196]: info: explodeUri took 3603 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 3612 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 3622 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 3662 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 3664 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 3666 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 3667 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 3664 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 3717 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 3878 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 3908 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4011 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4114 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4115 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4219 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4230 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4404 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4541 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4544 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4544 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4578 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4581 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4581 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4582 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4606 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4607 milliseconds Jul 11 18:54:26 volumio volumio[1196]: info: explodeUri took 4603 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4611 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4612 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4612 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4620 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4623 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4638 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4646 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4645 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4646 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4646 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4649 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4647 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4728 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4729 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4750 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4777 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4780 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4886 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4886 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4938 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4952 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4953 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4973 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4976 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4976 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4975 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4975 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4985 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4993 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4992 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4993 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 4994 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5019 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5018 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5018 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5047 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5048 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5073 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5093 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5122 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5125 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5135 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5146 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5146 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5151 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5185 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5225 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5232 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5233 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5249 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5250 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5250 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5253 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5256 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5268 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5268 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: Executing endpoint metavolumio Jul 11 18:54:27 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 11 18:54:27 volumio volumio[1196]: info: Executing endpoint metavolumio Jul 11 18:54:27 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5284 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5292 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5285 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: Executing endpoint metavolumio Jul 11 18:54:27 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5295 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5299 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5310 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5315 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5332 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5342 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5344 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5370 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5371 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5369 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5369 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5381 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5380 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5384 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5388 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5391 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5420 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5421 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5421 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5422 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5435 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5438 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5479 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5482 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5483 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: CoreCommandRouter::volumioPlay Jul 11 18:54:27 volumio volumio[1196]: info: CoreStateMachine::play index undefined Jul 11 18:54:27 volumio volumio[1196]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 18:54:27 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:27 volumio volumio[1196]: info: CoreStateMachine::startPlaybackTimer Jul 11 18:54:27 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:27 volumio volumio[1196]: info: CoreCommandRouter::volumioGetVisibleSources Jul 11 18:54:27 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 11 18:54:27 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 11 18:54:27 volumio volumio[1196]: info: [1752249267904] ControllerQobuz::clearAddPlayTrack Jul 11 18:54:27 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand stop Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5490 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5491 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5502 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5502 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5510 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: getStreamUrl took 5237 milliseconds Jul 11 18:54:27 volumio volumio[1196]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=3484566&eid=1570124&fmt=6&profile=raw&app_id=539451548&cid=2886452&etsp=1752252867&hmac=PzYqiwpUz_33rmRx8wy2-7XbDho Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5522 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5528 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5537 milliseconds Jul 11 18:54:27 volumio volumio[1196]: info: explodeUri took 5571 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: explodeUri took 5581 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: explodeUri took 5592 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: explodeUri took 5593 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: explodeUri took 5600 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: explodeUri took 5601 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: explodeUri took 5608 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: explodeUri took 5616 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: explodeUri took 5634 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: CoreCommandRouter::volumioPushQueue Jul 11 18:54:28 volumio volumio[1196]: info: CorePlayQueue::saveQueue Jul 11 18:54:28 volumio volumio[1196]: info: CoreStateMachine::updateTrackBlock Jul 11 18:54:28 volumio volumio[1196]: info: CorePlayQueue::getTrackBlock Jul 11 18:54:28 volumio volumio[1196]: STREAMING PROXY: Response: 200, length: 28188537 Jul 11 18:54:28 volumio volumio[1196]: STREAMING PROXY: Client dropped request, destroying Jul 11 18:54:28 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/1570124" Jul 11 18:54:28 volumio volumio[1196]: error: updateQueue error: null Jul 11 18:54:28 volumio volumio[1196]: error: updateQueue error: null Jul 11 18:54:28 volumio volumio[1196]: info: Jul 11 18:54:28 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:28 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:28 volumio volumio[1196]: info: ------------------------------ 5656ms Jul 11 18:54:28 volumio volumio[1196]: info: ------------------------------ 5656ms Jul 11 18:54:28 volumio volumio[1196]: info: sendMpdCommand stop took 2449 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: sendMpdCommand stop took 437 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/1570124" took 0 milliseconds Jul 11 18:54:28 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand clear Jul 11 18:54:28 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand clear Jul 11 18:54:28 volumio volumio[1196]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 11 18:54:28 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand play Jul 11 18:54:28 volumio volumio[1196]: info: Jul 11 18:54:28 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:28 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:28 volumio volumio[1196]: info: Jul 11 18:54:28 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:28 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:28 volumio volumio[1196]: info: Jul 11 18:54:28 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:28 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:28 volumio volumio[1196]: info: Jul 11 18:54:28 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:28 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:28 volumio volumio[1196]: error: updateQueue error: null Jul 11 18:54:28 volumio volumio[1196]: error: updateQueue error: null Jul 11 18:54:28 volumio volumio[1196]: info: ------------------------------ 2ms Jul 11 18:54:28 volumio volumio[1196]: info: sendMpdCommand clear took 1 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: sendMpdCommand clear took 1 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: sendMpdCommand play took 1 milliseconds Jul 11 18:54:28 volumio volumio[1196]: info: ------------------------------ 1ms Jul 11 18:54:28 volumio volumio[1196]: info: ------------------------------ 1ms Jul 11 18:54:28 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/1570124" Jul 11 18:54:28 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/1570124" Jul 11 18:54:28 volumio volumio[1196]: info: Jul 11 18:54:28 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:28 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:28 volumio volumio[1196]: STREAMING PROXY: Handling url /?data=qobuz://song/1570124 Jul 11 18:54:28 volumio volumio[1196]: info: Jul 11 18:54:28 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:28 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:28 volumio volumio[1196]: error: updateQueue error: null Jul 11 18:54:28 volumio volumio[1196]: error: updateQueue error: null Jul 11 18:54:28 volumio volumio[1196]: info: ------------------------------ 2ms Jul 11 18:54:28 volumio volumio[1196]: info: ------------------------------ 2ms Jul 11 18:54:28 volumio volumio[1196]: info: Executing endpoint getStreamUrlqobuz Jul 11 18:54:28 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jul 11 18:54:28 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 11 18:54:28 volumio volumio[1196]: info: getStreamUrl took 564 milliseconds Jul 11 18:54:28 volumio volumio[1196]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=3484566&eid=1570124&fmt=6&profile=raw&app_id=539451548&cid=2886452&etsp=1752252868&hmac=omx8MDvN2_Ai5mtZjiv0RDgmkss Jul 11 18:54:29 volumio volumio[1196]: STREAMING PROXY: Response: 200, length: 28188537 Jul 11 18:54:29 volumio volumio[1196]: STREAMING PROXY: Client dropped request, destroying Jul 11 18:54:29 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/1570124" Jul 11 18:54:29 volumio volumio[1196]: STREAMING PROXY: Handling url /?data=qobuz://song/1570124 Jul 11 18:54:29 volumio volumio[1196]: info: Executing endpoint getStreamUrlqobuz Jul 11 18:54:29 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jul 11 18:54:29 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 18:54:29 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 18:54:29 volumio volumio[1196]: info: Discovery: Getting this device information Jul 11 18:54:29 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:29 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 18:54:29 volumio volumio[1196]: info: getStreamUrl took 592 milliseconds Jul 11 18:54:29 volumio volumio[1196]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=3484566&eid=1570124&fmt=6&profile=raw&app_id=539451548&cid=2886452&etsp=1752252869&hmac=ILrFMPI72nJ5CYplzGIeVaswS7c Jul 11 18:54:30 volumio volumio[1196]: STREAMING PROXY: Response: 200, length: 28188537 Jul 11 18:54:30 volumio volumio[1196]: STREAMING PROXY: Client dropped request, destroying Jul 11 18:54:30 volumio volumio[1196]: error: updateQueue error: null Jul 11 18:54:30 volumio volumio[1196]: error: updateQueue error: null Jul 11 18:54:30 volumio volumio[1196]: info: Jul 11 18:54:30 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:30 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/1570124" Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 1696ms Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 1696ms Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/1570124" took 909 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand play Jul 11 18:54:30 volumio volumio[1196]: info: Jul 11 18:54:30 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:30 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/1570124" took 1 milliseconds Jul 11 18:54:30 volumio volumio[1196]: STREAMING PROXY: Handling url /?data=qobuz://song/1570124 Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 2ms Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand play Jul 11 18:54:30 volumio volumio[1196]: info: Jul 11 18:54:30 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:30 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:30 volumio volumio[1196]: info: Jul 11 18:54:30 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:30 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand play took 2 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 2ms Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand play took 1 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: Jul 11 18:54:30 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:30 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 2ms Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 1ms Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 1ms Jul 11 18:54:30 volumio volumio[1196]: info: Jul 11 18:54:30 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:30 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 1ms Jul 11 18:54:30 volumio volumio[1196]: info: Executing endpoint getStreamUrlqobuz Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jul 11 18:54:30 volumio volumio[1196]: info: getStreamUrl took 618 milliseconds Jul 11 18:54:30 volumio volumio[1196]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=3484566&eid=1570124&fmt=6&profile=raw&app_id=539451548&cid=2886452&etsp=1752252870&hmac=xFUQK-UQHHxhjXI3OFo-DECX5Fc Jul 11 18:54:30 volumio volumio[1196]: STREAMING PROXY: Response: 200, length: 28188537 Jul 11 18:54:30 volumio volumio[1196]: info: Jul 11 18:54:30 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:30 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:30 volumio volumio[1196]: info: Jul 11 18:54:30 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:30 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:30 volumio volumio[1196]: info: Jul 11 18:54:30 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:30 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:30 volumio volumio[1196]: info: Jul 11 18:54:30 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:30 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand status took 4 milliseconds Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand status took 5 milliseconds Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 18:54:30 volumio volumio[1196]: info: Jul 11 18:54:30 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:30 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:30 volumio volumio[1196]: info: Jul 11 18:54:30 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:30 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand status took 10 milliseconds Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand status took 10 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand clearerror took 7 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand clearerror took 7 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand status took 4 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand status took 4 milliseconds Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::parseTrackInfo Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::parseTrackInfo Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 18:54:30 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:30 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:30 volumio volumio[1196]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1570124","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/1570124","trackType":"qobuz"} Jul 11 18:54:30 volumio volumio[1196]: verbose: CURRENT POSITION 3 Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::syncState stateService pause Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::syncState currentStatus stop Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:30 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:30 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:30 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:30 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:30 volumio volumio[1196]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1570124","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/1570124","trackType":"qobuz"} Jul 11 18:54:30 volumio volumio[1196]: verbose: CURRENT POSITION 3 Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::syncState stateService pause Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::syncState currentStatus stop Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:30 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:30 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 33ms Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 33ms Jul 11 18:54:30 volumio volumio[1196]: info: [ASDebug] CurState: PrevState: stop Jul 11 18:54:30 volumio volumio[1196]: info: [ASDebug] Togle GPIO: ON Jul 11 18:54:30 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: Jul 11 18:54:30 volumio volumio[1196]: info: [ASDebug] Togle GPIO: ON Jul 11 18:54:30 volumio volumio[1196]: info: [GPIO_Control] Status changed: Jul 11 18:54:30 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:30 volumio volumio[1196]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.m5jZmMFQXcevtGMdsuUnNXW40TA3.4c0df8ce650528dca989cf901e9d1733.state.status' Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand clearerror took 33 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand clearerror took 33 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand playlistinfo took 30 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand playlistinfo took 30 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand playlistinfo took 29 milliseconds Jul 11 18:54:30 volumio volumio[1196]: info: sendMpdCommand playlistinfo took 29 milliseconds Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::parseTrackInfo Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::parseTrackInfo Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::parseTrackInfo Jul 11 18:54:30 volumio volumio[1196]: verbose: ControllerMpd::parseTrackInfo Jul 11 18:54:30 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:30 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:30 volumio volumio[1196]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1570124","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/1570124","trackType":"qobuz"} Jul 11 18:54:30 volumio volumio[1196]: verbose: CURRENT POSITION 3 Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::syncState stateService pause Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::syncState currentStatus stop Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:30 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:30 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:30 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:30 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:30 volumio volumio[1196]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1570124","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/1570124","trackType":"qobuz"} Jul 11 18:54:30 volumio volumio[1196]: verbose: CURRENT POSITION 3 Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::syncState stateService pause Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::syncState currentStatus stop Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:30 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:30 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:30 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:30 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:30 volumio volumio[1196]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1570124","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/1570124","trackType":"qobuz"} Jul 11 18:54:30 volumio volumio[1196]: verbose: CURRENT POSITION 3 Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::syncState stateService pause Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::syncState currentStatus stop Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:30 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:30 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:30 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:30 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:30 volumio volumio[1196]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1570124","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/1570124","trackType":"qobuz"} Jul 11 18:54:30 volumio volumio[1196]: verbose: CURRENT POSITION 3 Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::syncState stateService pause Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::syncState currentStatus stop Jul 11 18:54:30 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:30 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:30 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:30 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 65ms Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 65ms Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 58ms Jul 11 18:54:30 volumio volumio[1196]: info: ------------------------------ 58ms Jul 11 18:54:30 volumio volumio[1196]: info: [ASDebug] CurState: PrevState: undefined Jul 11 18:54:30 volumio volumio[1196]: info: [ASDebug] Togle GPIO: ON Jul 11 18:54:30 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: Jul 11 18:54:30 volumio volumio[1196]: info: [ASDebug] Togle GPIO: ON Jul 11 18:54:30 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: undefined Jul 11 18:54:30 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: undefined Jul 11 18:54:30 volumio volumio[1196]: info: [GPIO_Control] Status changed: Jul 11 18:54:30 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:30 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:30 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:30 volumio volumio[1196]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.m5jZmMFQXcevtGMdsuUnNXW40TA3.4c0df8ce650528dca989cf901e9d1733.state.status' Jul 11 18:54:30 volumio volumio[1196]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.m5jZmMFQXcevtGMdsuUnNXW40TA3.4c0df8ce650528dca989cf901e9d1733.state.status' Jul 11 18:54:30 volumio volumio[1196]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.m5jZmMFQXcevtGMdsuUnNXW40TA3.4c0df8ce650528dca989cf901e9d1733.state.status' Jul 11 18:54:32 volumio kernel: hwmon hwmon3: Undervoltage detected! Jul 11 18:54:33 volumio volumio[1196]: info: Executing endpoint metavolumio Jul 11 18:54:33 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 11 18:54:34 volumio kernel: hwmon hwmon3: Voltage normalised Jul 11 18:54:35 volumio volumio[1196]: info: CoreCommandRouter::volumioPlay Jul 11 18:54:35 volumio volumio[1196]: info: CoreStateMachine::play index undefined Jul 11 18:54:35 volumio volumio[1196]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 18:54:35 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:35 volumio volumio[1196]: info: CoreStateMachine::startPlaybackTimer Jul 11 18:54:35 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:35 volumio volumio[1196]: info: [1752249275674] ControllerQobuz::clearAddPlayTrack Jul 11 18:54:35 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand stop Jul 11 18:54:35 volumio volumio[1196]: STREAMING PROXY: Client dropped request, destroying Jul 11 18:54:35 volumio volumio[1196]: info: Jul 11 18:54:35 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:35 volumio volumio[1196]: info: sendMpdCommand stop took 2 milliseconds Jul 11 18:54:35 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:35 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:35 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand clear Jul 11 18:54:35 volumio volumio[1196]: info: Jul 11 18:54:35 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:35 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:35 volumio volumio[1196]: info: sendMpdCommand status took 1 milliseconds Jul 11 18:54:35 volumio volumio[1196]: info: sendMpdCommand clear took 1 milliseconds Jul 11 18:54:35 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:35 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 18:54:35 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/1570124" Jul 11 18:54:35 volumio volumio[1196]: info: Jul 11 18:54:35 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:35 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:35 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:35 volumio volumio[1196]: STREAMING PROXY: Handling url /?data=qobuz://song/1570124 Jul 11 18:54:35 volumio volumio[1196]: info: Jul 11 18:54:35 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:35 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:35 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:35 volumio volumio[1196]: error: updateQueue error: null Jul 11 18:54:35 volumio volumio[1196]: info: ------------------------------ 2ms Jul 11 18:54:35 volumio volumio[1196]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 11 18:54:35 volumio volumio[1196]: verbose: ControllerMpd::parseTrackInfo Jul 11 18:54:35 volumio volumio[1196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 11 18:54:35 volumio volumio[1196]: info: ------------------------------ 4ms Jul 11 18:54:35 volumio volumio[1196]: info: Executing endpoint getStreamUrlqobuz Jul 11 18:54:35 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jul 11 18:54:36 volumio volumio[1196]: info: getStreamUrl took 911 milliseconds Jul 11 18:54:36 volumio volumio[1196]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=3484566&eid=1570124&fmt=6&profile=raw&app_id=539451548&cid=2886452&etsp=1752252876&hmac=tYbZoYDPq1Wj96ry-pfFM2JTSx4 Jul 11 18:54:36 volumio volumio[1196]: STREAMING PROXY: Response: 200, length: 28188537 Jul 11 18:54:36 volumio volumio[1196]: STREAMING PROXY: Client dropped request, destroying Jul 11 18:54:36 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/1570124" Jul 11 18:54:36 volumio volumio[1196]: info: Jul 11 18:54:36 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:36 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:36 volumio volumio[1196]: info: sendMpdCommand status took 1140 milliseconds Jul 11 18:54:36 volumio volumio[1196]: info: sendMpdCommand status took 1139 milliseconds Jul 11 18:54:36 volumio volumio[1196]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/1570124" took 1 milliseconds Jul 11 18:54:36 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:36 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 11 18:54:36 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand play Jul 11 18:54:36 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:36 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:36 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:36 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:36 volumio volumio[1196]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 11 18:54:36 volumio volumio[1196]: verbose: CURRENT POSITION 3 Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::syncState stateService stop Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::syncState currentStatus stop Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:36 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:36 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:36 volumio volumio[1196]: info: No code Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:36 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:36 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:36 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:36 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:36 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:36 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:36 volumio volumio[1196]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 11 18:54:36 volumio volumio[1196]: verbose: CURRENT POSITION 3 Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::syncState stateService stop Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::syncState currentStatus stop Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:36 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:36 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:36 volumio volumio[1196]: info: No code Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:36 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:36 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:36 volumio volumio[1196]: STREAMING PROXY: Handling url /?data=qobuz://song/1570124 Jul 11 18:54:36 volumio volumio[1196]: info: ------------------------------ 1179ms Jul 11 18:54:36 volumio volumio[1196]: info: ------------------------------ 1179ms Jul 11 18:54:36 volumio volumio[1196]: info: Jul 11 18:54:36 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:36 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:36 volumio volumio[1196]: info: Jul 11 18:54:36 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:36 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:36 volumio volumio[1196]: info: ------------------------------ 40ms Jul 11 18:54:36 volumio volumio[1196]: info: sendMpdCommand play took 40 milliseconds Jul 11 18:54:36 volumio volumio[1196]: info: ------------------------------ 1ms Jul 11 18:54:36 volumio volumio[1196]: info: ------------------------------ 1ms Jul 11 18:54:36 volumio volumio[1196]: info: Jul 11 18:54:36 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:36 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:36 volumio volumio[1196]: info: Jul 11 18:54:36 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:36 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:36 volumio volumio[1196]: info: [ASDebug] CurState: PrevState: undefined Jul 11 18:54:36 volumio volumio[1196]: info: [ASDebug] Togle GPIO: ON Jul 11 18:54:36 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: Jul 11 18:54:36 volumio volumio[1196]: info: [ASDebug] Togle GPIO: ON Jul 11 18:54:36 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: undefined Jul 11 18:54:36 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: undefined Jul 11 18:54:36 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: undefined Jul 11 18:54:36 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: undefined Jul 11 18:54:36 volumio volumio[1196]: info: [GPIO_Control] Status changed: Jul 11 18:54:36 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:36 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:36 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:36 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:36 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:36 volumio volumio[1196]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.m5jZmMFQXcevtGMdsuUnNXW40TA3.4c0df8ce650528dca989cf901e9d1733.state.status' Jul 11 18:54:36 volumio volumio[1196]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.m5jZmMFQXcevtGMdsuUnNXW40TA3.4c0df8ce650528dca989cf901e9d1733.state.status' Jul 11 18:54:36 volumio volumio[1196]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.m5jZmMFQXcevtGMdsuUnNXW40TA3.4c0df8ce650528dca989cf901e9d1733.state.status' Jul 11 18:54:36 volumio volumio[1196]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.m5jZmMFQXcevtGMdsuUnNXW40TA3.4c0df8ce650528dca989cf901e9d1733.state.status' Jul 11 18:54:36 volumio volumio[1196]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.m5jZmMFQXcevtGMdsuUnNXW40TA3.4c0df8ce650528dca989cf901e9d1733.state.status' Jul 11 18:54:36 volumio volumio[1196]: info: ------------------------------ 12ms Jul 11 18:54:36 volumio volumio[1196]: info: ------------------------------ 13ms Jul 11 18:54:36 volumio volumio[1196]: info: Executing endpoint getStreamUrlqobuz Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::volumioPlay Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::play index undefined Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 18:54:36 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:36 volumio volumio[1196]: info: CoreStateMachine::startPlaybackTimer Jul 11 18:54:36 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:36 volumio volumio[1196]: info: [1752249276909] ControllerQobuz::clearAddPlayTrack Jul 11 18:54:36 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand stop Jul 11 18:54:36 volumio volumio[1196]: info: Jul 11 18:54:36 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:36 volumio volumio[1196]: info: sendMpdCommand stop took 0 milliseconds Jul 11 18:54:36 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:36 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:36 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand clear Jul 11 18:54:36 volumio volumio[1196]: info: Jul 11 18:54:36 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:36 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:36 volumio volumio[1196]: info: sendMpdCommand status took 1 milliseconds Jul 11 18:54:36 volumio volumio[1196]: info: sendMpdCommand clear took 1 milliseconds Jul 11 18:54:36 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:36 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 18:54:36 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/1570124" Jul 11 18:54:36 volumio volumio[1196]: info: Jul 11 18:54:36 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:36 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:36 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:36 volumio volumio[1196]: info: Jul 11 18:54:36 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:36 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:36 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:36 volumio volumio[1196]: STREAMING PROXY: Handling url /?data=qobuz://song/1570124 Jul 11 18:54:36 volumio volumio[1196]: error: updateQueue error: null Jul 11 18:54:36 volumio volumio[1196]: info: ------------------------------ 1ms Jul 11 18:54:36 volumio volumio[1196]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 11 18:54:36 volumio volumio[1196]: verbose: ControllerMpd::parseTrackInfo Jul 11 18:54:36 volumio volumio[1196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 11 18:54:36 volumio volumio[1196]: info: ------------------------------ 2ms Jul 11 18:54:36 volumio volumio[1196]: info: Executing endpoint getStreamUrlqobuz Jul 11 18:54:36 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jul 11 18:54:37 volumio volumio[1196]: info: getStreamUrl took 592 milliseconds Jul 11 18:54:37 volumio volumio[1196]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=3484566&eid=1570124&fmt=6&profile=raw&app_id=539451548&cid=2886452&etsp=1752252877&hmac=-klqeZDPhxVGz3UqmIxA_qka_EA Jul 11 18:54:37 volumio volumio[1196]: info: getStreamUrl took 712 milliseconds Jul 11 18:54:37 volumio volumio[1196]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=3484566&eid=1570124&fmt=6&profile=raw&app_id=539451548&cid=2886452&etsp=1752252877&hmac=-klqeZDPhxVGz3UqmIxA_qka_EA Jul 11 18:54:37 volumio volumio[1196]: STREAMING PROXY: Response: 200, length: 28188537 Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 11 18:54:37 volumio volumio[1196]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 11 18:54:37 volumio volumio[1196]: info: Received Get System Version Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 11 18:54:37 volumio volumio[1196]: info: Received Get System Info Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 18:54:37 volumio volumio[1196]: info: Discovery: Getting this device information Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:37 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 18:54:37 volumio volumio[1196]: STREAMING PROXY: Response: 200, length: 28188537 Jul 11 18:54:37 volumio volumio[1196]: STREAMING PROXY: Client dropped request, destroying Jul 11 18:54:37 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/1570124" Jul 11 18:54:37 volumio volumio[1196]: info: sendMpdCommand status took 974 milliseconds Jul 11 18:54:37 volumio volumio[1196]: info: sendMpdCommand status took 973 milliseconds Jul 11 18:54:37 volumio volumio[1196]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/1570124" took 0 milliseconds Jul 11 18:54:37 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:37 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:37 volumio volumio[1196]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 11 18:54:37 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand play Jul 11 18:54:37 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:37 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:37 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:37 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:37 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:37 volumio volumio[1196]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 11 18:54:37 volumio volumio[1196]: verbose: CURRENT POSITION 3 Jul 11 18:54:37 volumio volumio[1196]: info: CoreStateMachine::syncState stateService stop Jul 11 18:54:37 volumio volumio[1196]: info: CoreStateMachine::syncState currentStatus stop Jul 11 18:54:37 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:37 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:37 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:37 volumio volumio[1196]: info: No code Jul 11 18:54:37 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:37 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:37 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:37 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:37 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:37 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:37 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:37 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:37 volumio volumio[1196]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 11 18:54:37 volumio volumio[1196]: verbose: CURRENT POSITION 3 Jul 11 18:54:37 volumio volumio[1196]: info: CoreStateMachine::syncState stateService stop Jul 11 18:54:37 volumio volumio[1196]: info: CoreStateMachine::syncState currentStatus stop Jul 11 18:54:37 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:37 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:37 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:37 volumio volumio[1196]: info: No code Jul 11 18:54:37 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:37 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:37 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:37 volumio volumio[1196]: STREAMING PROXY: Handling url /?data=qobuz://song/1570124 Jul 11 18:54:37 volumio volumio[1196]: info: ------------------------------ 1013ms Jul 11 18:54:37 volumio volumio[1196]: info: ------------------------------ 1013ms Jul 11 18:54:37 volumio volumio[1196]: info: Jul 11 18:54:37 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:37 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:37 volumio volumio[1196]: info: Jul 11 18:54:37 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:37 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:37 volumio volumio[1196]: info: Jul 11 18:54:37 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:37 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:37 volumio volumio[1196]: info: sendMpdCommand play took 39 milliseconds Jul 11 18:54:37 volumio volumio[1196]: info: ------------------------------ 1ms Jul 11 18:54:37 volumio volumio[1196]: info: ------------------------------ 1ms Jul 11 18:54:37 volumio volumio[1196]: info: Jul 11 18:54:37 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:37 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:37 volumio volumio[1196]: info: Jul 11 18:54:37 volumio volumio[1196]: ---------------------------- MPD announces system playlist update Jul 11 18:54:37 volumio volumio[1196]: info: Ignoring MPD Status Update Jul 11 18:54:37 volumio volumio[1196]: info: [ASDebug] CurState: PrevState: undefined Jul 11 18:54:37 volumio volumio[1196]: info: [ASDebug] Togle GPIO: ON Jul 11 18:54:37 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: Jul 11 18:54:37 volumio volumio[1196]: info: [ASDebug] Togle GPIO: ON Jul 11 18:54:37 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: undefined Jul 11 18:54:37 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: undefined Jul 11 18:54:37 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: undefined Jul 11 18:54:37 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: undefined Jul 11 18:54:37 volumio volumio[1196]: info: [GPIO_Control] Status changed: Jul 11 18:54:37 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:37 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:37 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:37 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:37 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:37 volumio volumio[1196]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.m5jZmMFQXcevtGMdsuUnNXW40TA3.4c0df8ce650528dca989cf901e9d1733.state.status' Jul 11 18:54:37 volumio volumio[1196]: info: ------------------------------ 14ms Jul 11 18:54:37 volumio volumio[1196]: info: ------------------------------ 13ms Jul 11 18:54:37 volumio volumio[1196]: info: ------------------------------ 13ms Jul 11 18:54:37 volumio volumio[1196]: info: Executing endpoint getStreamUrlqobuz Jul 11 18:54:37 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jul 11 18:54:38 volumio volumio[1196]: info: getStreamUrl took 653 milliseconds Jul 11 18:54:38 volumio volumio[1196]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=3484566&eid=1570124&fmt=6&profile=raw&app_id=539451548&cid=2886452&etsp=1752252878&hmac=Y8Z5D5GVbj02mojUHJQxmTEdNaM Jul 11 18:54:38 volumio volumio[1196]: STREAMING PROXY: Response: 200, length: 28188537 Jul 11 18:54:38 volumio volumio[1196]: info: Jul 11 18:54:38 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:38 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:38 volumio volumio[1196]: info: Jul 11 18:54:38 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:38 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:38 volumio volumio[1196]: info: Jul 11 18:54:38 volumio volumio[1196]: ---------------------------- MPD announces state update: player Jul 11 18:54:38 volumio volumio[1196]: info: ControllerMpd::getState Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand status Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 11 18:54:38 volumio volumio[1196]: info: sendMpdCommand status took 4 milliseconds Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 11 18:54:38 volumio volumio[1196]: info: sendMpdCommand status took 4 milliseconds Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 11 18:54:38 volumio volumio[1196]: info: sendMpdCommand status took 9 milliseconds Jul 11 18:54:38 volumio volumio[1196]: info: sendMpdCommand clearerror took 6 milliseconds Jul 11 18:54:38 volumio volumio[1196]: info: sendMpdCommand clearerror took 6 milliseconds Jul 11 18:54:38 volumio volumio[1196]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 11 18:54:38 volumio volumio[1196]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::parseState Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::parseTrackInfo Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::parseTrackInfo Jul 11 18:54:38 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:38 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:38 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:38 volumio volumio[1196]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1570124","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/1570124","trackType":"qobuz"} Jul 11 18:54:38 volumio volumio[1196]: verbose: CURRENT POSITION 3 Jul 11 18:54:38 volumio volumio[1196]: info: CoreStateMachine::syncState stateService pause Jul 11 18:54:38 volumio volumio[1196]: info: CoreStateMachine::syncState currentStatus stop Jul 11 18:54:38 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:38 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 18:54:38 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:38 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:38 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:38 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:38 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:38 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:38 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:38 volumio volumio[1196]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1570124","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/1570124","trackType":"qobuz"} Jul 11 18:54:38 volumio volumio[1196]: verbose: CURRENT POSITION 3 Jul 11 18:54:38 volumio volumio[1196]: info: CoreStateMachine::syncState stateService pause Jul 11 18:54:38 volumio volumio[1196]: info: CoreStateMachine::syncState currentStatus stop Jul 11 18:54:38 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:38 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:38 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:38 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:38 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:38 volumio volumio[1196]: info: ------------------------------ 26ms Jul 11 18:54:38 volumio volumio[1196]: info: ------------------------------ 26ms Jul 11 18:54:38 volumio volumio[1196]: info: [ASDebug] CurState: PrevState: undefined Jul 11 18:54:38 volumio volumio[1196]: info: [ASDebug] Togle GPIO: ON Jul 11 18:54:38 volumio volumio[1196]: info: [ASDebug] CurState: undefined PrevState: Jul 11 18:54:38 volumio volumio[1196]: info: [ASDebug] Togle GPIO: ON Jul 11 18:54:38 volumio volumio[1196]: info: [GPIO_Control] Status changed: Jul 11 18:54:38 volumio volumio[1196]: info: [GPIO_Control] Status changed: undefined Jul 11 18:54:38 volumio volumio[1196]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.m5jZmMFQXcevtGMdsuUnNXW40TA3.4c0df8ce650528dca989cf901e9d1733.state.status' Jul 11 18:54:38 volumio volumio[1196]: info: sendMpdCommand clearerror took 24 milliseconds Jul 11 18:54:38 volumio volumio[1196]: info: sendMpdCommand playlistinfo took 23 milliseconds Jul 11 18:54:38 volumio volumio[1196]: verbose: ControllerMpd::parseTrackInfo Jul 11 18:54:38 volumio volumio[1196]: info: ControllerMpd::pushState Jul 11 18:54:38 volumio volumio[1196]: info: CoreCommandRouter::servicePushState Jul 11 18:54:38 volumio volumio[1196]: info: CorePlayQueue::getTrack 3 Jul 11 18:54:38 volumio volumio[1196]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1570124","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/1570124","trackType":"qobuz"} Jul 11 18:54:38 volumio volumio[1196]: verbose: CURRENT POSITION 3 Jul 11 18:54:38 volumio volumio[1196]: info: CoreStateMachine::syncState stateService pause Jul 11 18:54:38 volumio volumio[1196]: info: CoreStateMachine::syncState currentStatus stop Jul 11 18:54:38 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:38 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 18:54:38 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:38 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:38 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:38 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:38 volumio volumio[1196]: info: ------------------------------ 41ms Jul 11 18:54:38 volumio volumio[1196]: info: [ASDebug] CurState: PrevState: undefined Jul 11 18:54:38 volumio volumio[1196]: info: [ASDebug] Togle GPIO: ON Jul 11 18:54:38 volumio volumio[1196]: info: [GPIO_Control] Status changed: Jul 11 18:54:41 volumio volumio[1196]: info: Executing endpoint metavolumio Jul 11 18:54:41 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 11 18:54:42 volumio volumio[1196]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 18:54:42 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:42 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 11 18:54:42 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:42 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 11 18:54:42 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:42 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:42 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:42 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:42 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:42 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:42 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:42 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:42 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 11 18:54:42 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 11 18:54:50 volumio volumio[1196]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 11 18:54:50 volumio volumio[1196]: info: Preparing to save Alsa Options, stopping services first Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:50 volumio volumio[1196]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Amanero Combo768"},"i2s":true,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:50 volumio volumio[1196]: info: Enabling I2S DAC: Adafruit MAX98357 Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:50 volumio sudo[2224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jul 11 18:54:50 volumio sudo[2224]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:50 volumio sudo[2224]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:50 volumio volumio[1196]: info: No Overlays Loaded Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:50 volumio sudo[2227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay max98357a Jul 11 18:54:50 volumio sudo[2227]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:50 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2s@a0000/status Jul 11 18:54:50 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Jul 11 18:54:50 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/simple-audio-card,format Jul 11 18:54:50 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/simple-audio-card,name Jul 11 18:54:50 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Jul 11 18:54:50 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:50 volumio volumio[1196]: warn: Unable to locate the device Amanero Combo768 a reboot may be required. Jul 11 18:54:50 volumio kernel: pinctrl-rp1 1f000d0000.gpio: pin gpio18 already requested by ir-receiver@12; cannot claim for 1f000a0000.i2s Jul 11 18:54:50 volumio kernel: pinctrl-rp1 1f000d0000.gpio: pin-18 (1f000a0000.i2s) status -22 Jul 11 18:54:50 volumio kernel: pinctrl-rp1 1f000d0000.gpio: could not request pin 18 (gpio18) from group gpio18 on device pinctrl-rp1 Jul 11 18:54:50 volumio kernel: designware-i2s 1f000a0000.i2s: Error applying setting, reverse things back Jul 11 18:54:50 volumio sudo[2227]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:50 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:50 volumio volumio[1196]: Invalid card number. Jul 11 18:54:50 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 11 18:54:50 volumio volumio[1196]: info: Updating Volume Controller Parameters: Device: 2 Name: Adafruit MAX98357 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 11 18:54:50 volumio volumio[1196]: info: Disabling external Volume Control Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Jul 11 18:54:50 volumio volumio[1196]: info: Preparing to generate the ALSA configuration file Jul 11 18:54:50 volumio volumio[1196]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 11 18:54:50 volumio volumio[1196]: info: Reading ALSA contributions from plugins. Jul 11 18:54:50 volumio volumio[1196]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jul 11 18:54:50 volumio volumio[1196]: info: I2S Param [object Object] successfully enabled Jul 11 18:54:50 volumio volumio[1196]: info: VolumeController:: Volume=undefined Mute =false Jul 11 18:54:50 volumio volumio[1196]: info: CoreStateMachine::pushState Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::volumioPushState Jul 11 18:54:50 volumio volumio[1196]: info: MRS: Pushing multiroomSync output update for this device Jul 11 18:54:50 volumio volumio[1196]: info: MRS: Pushing multiroomSync output Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:50 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 11 18:54:50 volumio volumio[1196]: info: Getting Alsa Cards List without I2S DAC Jul 11 18:54:50 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:50 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:50 volumio volumio[1196]: Invalid card number. Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 11 18:54:50 volumio volumio[1196]: info: [ASDebug] CurState: PrevState: Jul 11 18:54:50 volumio volumio[1196]: info: [GPIO_Control] Status changed: Jul 11 18:54:50 volumio volumio[1196]: info: Asound.conf file written Jul 11 18:54:50 volumio sudo[2260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 11 18:54:50 volumio sudo[2260]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:50 volumio sudo[2260]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:50 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:50 volumio volumio[1196]: No state is present for card Combo768 Jul 11 18:54:50 volumio volumio[1196]: Found hardware: "USB-Audio" "USB Mixer" "USB16d0:0a23" "" "" Jul 11 18:54:50 volumio volumio[1196]: Hardware is initialized using a generic method Jul 11 18:54:50 volumio volumio[1196]: No state is present for card Combo768 Jul 11 18:54:50 volumio volumio[1196]: info: Output device has changed, restarting MPD Jul 11 18:54:50 volumio sudo[2265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 11 18:54:50 volumio sudo[2265]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:50 volumio sudo[2265]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:50 volumio volumio[1196]: info: Output device has changed, restarting Shairport Sync Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:50 volumio sudo[2268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 11 18:54:50 volumio sudo[2268]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:50 volumio systemd[1]: Stopping Music Player Daemon... Jul 11 18:54:50 volumio volumio[1196]: STREAMING PROXY: Client dropped request, destroying Jul 11 18:54:50 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:50 volumio volumio[1196]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 11 18:54:50 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:50 volumio volumio[1196]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:50 volumio systemd[1]: mpd.service: Succeeded. Jul 11 18:54:50 volumio systemd[1]: Stopped Music Player Daemon. Jul 11 18:54:50 volumio volumio[1196]: info: QobuzConnect: setDeactiveState invoked Jul 11 18:54:50 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:50 volumio vtcs[1730]: [2025-07-11 18:54:50.991] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jul 11 18:54:51 volumio vtcs[1730]: [2025-07-11 18:54:50.991] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jul 11 18:54:51 volumio sudo[2277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 11 18:54:51 volumio volumio[1196]: info: Output device has changed, restarting MPD Jul 11 18:54:51 volumio systemd[1]: Starting Music Player Daemon... Jul 11 18:54:51 volumio sudo[2277]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 11 18:54:51 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Jul 11 18:54:51 volumio sudo[2280]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2280]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jul 11 18:54:51 volumio volumio[1196]: info: Output device has changed, restarting Shairport Sync Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:51 volumio sudo[2283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 11 18:54:51 volumio sudo[2283]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio systemd[1]: vtcs.service: Succeeded. Jul 11 18:54:51 volumio sudo[2277]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jul 11 18:54:51 volumio sudo[2273]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 11 18:54:51 volumio sudo[2273]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2273]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 11 18:54:51 volumio systemd[1]: mpd.service: Succeeded. Jul 11 18:54:51 volumio systemd[1]: Stopped Music Player Daemon. Jul 11 18:54:51 volumio systemd[1]: Starting Music Player Daemon... Jul 11 18:54:51 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:51 volumio volumio[1196]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 11 18:54:51 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:51 volumio volumio[1196]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: setDeactiveState invoked Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:51 volumio sudo[2290]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 11 18:54:51 volumio sudo[2290]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2290]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 11 18:54:51 volumio sudo[2295]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 11 18:54:51 volumio sudo[2299]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 11 18:54:51 volumio sudo[2302]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 11 18:54:51 volumio sudo[2308]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2295]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2302]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2308]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 11 18:54:51 volumio sudo[2330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 11 18:54:51 volumio sudo[2329]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2330]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2299]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio sudo[2329]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Jul 11 18:54:51 volumio qobuz-connect[1700]: 20250711 18:54:51.147 [1700.1700] INFO SampleApp: Stopping Local configuration server Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio sudo[2335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 11 18:54:51 volumio sudo[2335]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio qobuz-connect[1700]: 20250711 18:54:51.158 [1700.1700] INFO SampleApp: shat down connection on UNIX socket Jul 11 18:54:51 volumio volumio[1196]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jul 11 18:54:51 volumio systemd[1]: qobuz-connect.service: Succeeded. Jul 11 18:54:51 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Jul 11 18:54:51 volumio volumio[1196]: info: MPD Permissions set Jul 11 18:54:51 volumio volumio[1196]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jul 11 18:54:51 volumio volumio[1196]: info: MPD Permissions set Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: setDeactiveState invoked Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio systemd[1]: Started Volumio Qobuz Connect Service. Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:51 volumio sudo[2330]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio sudo[2335]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: Executing endpoint qc_getconfig Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jul 11 18:54:51 volumio qobuz-connect[2337]: 20250711 18:54:51.213 [2337.2337] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jul 11 18:54:51 volumio volumio[1196]: info: Starting Shairport Sync Jul 11 18:54:51 volumio qobuz-connect[2337]: 20250711 18:54:51.214 [2337.2337] INFO VolumeManager: [0x23948a8]: Setting new playback volume: 75 Jul 11 18:54:51 volumio qobuz-connect[2337]: 20250711 18:54:51.214 [2337.2337] INFO VolumeManager: [0x23948a8]: Setting new mute state: 0 Jul 11 18:54:51 volumio qobuz-connect[2337]: 20250711 18:54:51.214 [2337.2337] INFO QobuzConnect: [0x2395278]: Client initialized! Jul 11 18:54:51 volumio qobuz-connect[2337]: 20250711 18:54:51.214 [2337.2337] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Jul 11 18:54:51 volumio qobuz-connect[2337]: 20250711 18:54:51.217 [2337.2337] INFO LocalConfigManager: [0x2394188]: Starting Local Configuration server Jul 11 18:54:51 volumio qobuz-connect[2337]: 20250711 18:54:51.217 [2337.2337] INFO SampleApp: Starting Local configuration server Jul 11 18:54:51 volumio qobuz-connect[2337]: 20250711 18:54:51.217 [2337.2337] INFO SampleApp: Connected to UNIX socket client 0x2389f60 Jul 11 18:54:51 volumio volumio[1196]: info: Starting Shairport Sync Jul 11 18:54:51 volumio sudo[2349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 11 18:54:51 volumio sudo[2349]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio volumio[1196]: info: Preparing to generate the ALSA configuration file Jul 11 18:54:51 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 11 18:54:51 volumio sudo[2352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 11 18:54:51 volumio sudo[2352]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 11 18:54:51 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: QOBUZ Connect daemon connected Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio volumio[1196]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 11 18:54:51 volumio volumio[1196]: info: Reading ALSA contributions from plugins. Jul 11 18:54:51 volumio volumio[1196]: info: Asound.conf file written Jul 11 18:54:51 volumio sudo[2356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 11 18:54:51 volumio sudo[2356]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 11 18:54:51 volumio sudo[2356]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2349]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 11 18:54:51 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 11 18:54:51 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 11 18:54:51 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 11 18:54:51 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 11 18:54:51 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:51 volumio volumio[1196]: No state is present for card Combo768 Jul 11 18:54:51 volumio volumio[1196]: Found hardware: "USB-Audio" "USB Mixer" "USB16d0:0a23" "" "" Jul 11 18:54:51 volumio volumio[1196]: Hardware is initialized using a generic method Jul 11 18:54:51 volumio volumio[1196]: No state is present for card Combo768 Jul 11 18:54:51 volumio volumio[1196]: info: Output device has changed, restarting MPD Jul 11 18:54:51 volumio sudo[2352]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 11 18:54:51 volumio sudo[2362]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2362]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio volumio[1196]: info: Output device has changed, restarting Shairport Sync Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:51 volumio sudo[2367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 11 18:54:51 volumio sudo[2367]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 11 18:54:51 volumio systemd[1]: mpd.service: Succeeded. Jul 11 18:54:51 volumio systemd[1]: Stopped Music Player Daemon. Jul 11 18:54:51 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:51 volumio volumio[1196]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 11 18:54:51 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:51 volumio volumio[1196]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: setDeactiveState invoked Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:51 volumio volumio[1196]: info: Preparing to generate the ALSA configuration file Jul 11 18:54:51 volumio sudo[2376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 11 18:54:51 volumio systemd[1]: Starting Music Player Daemon... Jul 11 18:54:51 volumio sudo[2376]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2376]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 11 18:54:51 volumio sudo[2379]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio qobuz-connect[2337]: 20250711 18:54:51.362 [2337.2337] INFO SampleApp: Playback volume changed: 75 Jul 11 18:54:51 volumio sudo[2372]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 11 18:54:51 volumio sudo[2372]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2372]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2379]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 11 18:54:51 volumio sudo[2389]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio volumio[1196]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 11 18:54:51 volumio volumio[1196]: info: Reading ALSA contributions from plugins. Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:51 volumio volumio[1196]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jul 11 18:54:51 volumio volumio[1196]: info: MPD Permissions set Jul 11 18:54:51 volumio volumio[1196]: info: Shairport-Sync Started Jul 11 18:54:51 volumio volumio[1196]: info: Shairport-Sync Started Jul 11 18:54:51 volumio sudo[2389]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 11 18:54:51 volumio sudo[2391]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Jul 11 18:54:51 volumio qobuz-connect[2337]: 20250711 18:54:51.408 [2337.2337] INFO SampleApp: Stopping Local configuration server Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio volumio[1196]: info: Starting Shairport Sync Jul 11 18:54:51 volumio qobuz-connect[2337]: 20250711 18:54:51.418 [2337.2337] INFO SampleApp: shat down connection on UNIX socket Jul 11 18:54:51 volumio systemd[1]: qobuz-connect.service: Succeeded. Jul 11 18:54:51 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: setDeactiveState invoked Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:51 volumio volumio[1196]: info: Asound.conf file unchanged, so no further update is needed Jul 11 18:54:51 volumio volumio[1196]: info: Output device has changed, restarting MPD Jul 11 18:54:51 volumio sudo[2399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 11 18:54:51 volumio sudo[2399]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio volumio[1196]: info: Output device has changed, restarting Shairport Sync Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:51 volumio systemd[1]: Started Volumio Qobuz Connect Service. Jul 11 18:54:51 volumio sudo[2402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 11 18:54:51 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 11 18:54:51 volumio sudo[2402]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2402]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 11 18:54:51 volumio sudo[2405]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2391]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 11 18:54:51 volumio systemd[1]: mpd.service: Succeeded. Jul 11 18:54:51 volumio systemd[1]: Stopped Music Player Daemon. Jul 11 18:54:51 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 11 18:54:51 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 11 18:54:51 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 11 18:54:51 volumio sudo[2399]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:51 volumio volumio[1196]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 11 18:54:51 volumio volumio[1196]: xcb_connection_has_error() returned true Jul 11 18:54:51 volumio volumio[1196]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio systemd[1]: Starting Music Player Daemon... Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: setDeactiveState invoked Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:51 volumio sudo[2412]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 11 18:54:51 volumio sudo[2412]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2412]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 11 18:54:51 volumio sudo[2418]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio sudo[2423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 11 18:54:51 volumio sudo[2423]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio sudo[2429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio sudo[2429]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio volumio[1196]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jul 11 18:54:51 volumio volumio[1196]: info: MPD Permissions set Jul 11 18:54:51 volumio sudo[2429]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio volumio[1196]: info: Shairport-Sync Started Jul 11 18:54:51 volumio sudo[2423]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2418]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio volumio[1196]: info: Executing endpoint qc_getconfig Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jul 11 18:54:51 volumio qobuz-connect[2398]: 20250711 18:54:51.550 [2398.2398] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio qobuz-connect[2398]: 20250711 18:54:51.551 [2398.2398] INFO VolumeManager: [0x29b08a8]: Setting new playback volume: 75 Jul 11 18:54:51 volumio qobuz-connect[2398]: 20250711 18:54:51.551 [2398.2398] INFO VolumeManager: [0x29b08a8]: Setting new mute state: 0 Jul 11 18:54:51 volumio qobuz-connect[2398]: 20250711 18:54:51.551 [2398.2398] INFO QobuzConnect: [0x29b1278]: Client initialized! Jul 11 18:54:51 volumio qobuz-connect[2398]: 20250711 18:54:51.551 [2398.2398] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Jul 11 18:54:51 volumio qobuz-connect[2398]: 20250711 18:54:51.555 [2398.2398] INFO LocalConfigManager: [0x29b0188]: Starting Local Configuration server Jul 11 18:54:51 volumio qobuz-connect[2398]: 20250711 18:54:51.555 [2398.2398] INFO SampleApp: Starting Local configuration server Jul 11 18:54:51 volumio qobuz-connect[2398]: 20250711 18:54:51.555 [2398.2398] INFO SampleApp: Connected to UNIX socket client 0x29a5f60 Jul 11 18:54:51 volumio sudo[2433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 11 18:54:51 volumio sudo[2433]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: QOBUZ Connect daemon connected Jul 11 18:54:51 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Jul 11 18:54:51 volumio qobuz-connect[2398]: 20250711 18:54:51.569 [2398.2398] INFO SampleApp: Stopping Local configuration server Jul 11 18:54:51 volumio volumio[1196]: info: Starting Shairport Sync Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio qobuz-connect[2398]: 20250711 18:54:51.579 [2398.2398] INFO SampleApp: shat down connection on UNIX socket Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: setDeactiveState invoked Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:51 volumio systemd[1]: qobuz-connect.service: Succeeded. Jul 11 18:54:51 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Jul 11 18:54:51 volumio sudo[2441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 11 18:54:51 volumio sudo[2441]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 18:54:51 volumio systemd[1]: Started Volumio Qobuz Connect Service. Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio sudo[2433]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 18:54:51 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 11 18:54:51 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 11 18:54:51 volumio volumio[1196]: info: Executing endpoint qc_getconfig Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jul 11 18:54:51 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 11 18:54:51 volumio volumio[1196]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 11 18:54:51 volumio qobuz-connect[2442]: 20250711 18:54:51.625 [2442.2442] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jul 11 18:54:51 volumio volumio[1196]: info: QobuzConnect: QOBUZ Connect daemon connected Jul 11 18:54:51 volumio sudo[2441]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio qobuz-connect[2442]: 20250711 18:54:51.627 [2442.2442] INFO VolumeManager: [0x12e98a8]: Setting new playback volume: 75 Jul 11 18:54:51 volumio qobuz-connect[2442]: 20250711 18:54:51.627 [2442.2442] INFO VolumeManager: [0x12e98a8]: Setting new mute state: 0 Jul 11 18:54:51 volumio qobuz-connect[2442]: 20250711 18:54:51.627 [2442.2442] INFO QobuzConnect: [0x12ea278]: Client initialized! Jul 11 18:54:51 volumio qobuz-connect[2442]: 20250711 18:54:51.627 [2442.2442] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Jul 11 18:54:51 volumio volumio[1196]: info: Shairport-Sync Started Jul 11 18:54:51 volumio qobuz-connect[2442]: 20250711 18:54:51.633 [2442.2442] INFO LocalConfigManager: [0x12e9188]: Starting Local Configuration server Jul 11 18:54:51 volumio qobuz-connect[2442]: 20250711 18:54:51.633 [2442.2442] INFO SampleApp: Starting Local configuration server Jul 11 18:54:51 volumio qobuz-connect[2442]: 20250711 18:54:51.633 [2442.2442] INFO SampleApp: Connected to UNIX socket client 0x12def60 Jul 11 18:54:51 volumio mpd[2421]: Jul 11 18:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 11 18:54:51 volumio systemd[1]: Started Music Player Daemon. Jul 11 18:54:51 volumio sudo[2283]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2268]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2405]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio sudo[2367]: pam_unix(sudo:session): session closed for user root Jul 11 18:54:51 volumio volumio[1196]: error: MPD error: The expression evaluated to a falsy value: Jul 11 18:54:51 volumio volumio[1196]: assert.ok(self.idling) Jul 11 18:54:51 volumio volumio[1196]: error: The expression evaluated to a falsy value: Jul 11 18:54:51 volumio volumio[1196]: assert.ok(self.idling) Jul 11 18:54:51 volumio volumio[1196]: error: MPD error: The expression evaluated to a falsy value: Jul 11 18:54:51 volumio volumio[1196]: assert.ok(self.idling) Jul 11 18:54:51 volumio volumio[1196]: error: The expression evaluated to a falsy value: Jul 11 18:54:51 volumio volumio[1196]: assert.ok(self.idling) Jul 11 18:54:51 volumio volumio[1196]: error: MPD error: The expression evaluated to a falsy value: Jul 11 18:54:51 volumio volumio[1196]: assert.ok(self.idling) Jul 11 18:54:51 volumio volumio[1196]: error: The expression evaluated to a falsy value: Jul 11 18:54:51 volumio volumio[1196]: assert.ok(self.idling) Jul 11 18:54:51 volumio volumio[1196]: error: updateQueue error: null Jul 11 18:54:51 volumio qobuz-connect[2442]: 20250711 18:54:51.774 [2442.2442] INFO SampleApp: Playback volume changed: 75 Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 18:54:51 volumio volumio[1196]: info: Discovery: Getting this device information Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::volumioGetState Jul 11 18:54:51 volumio volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 18:54:53 volumio volumio[1196]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Jul 11 18:54:53 volumio volumio[1196]: info: PLUGIN onReboot : networkfs Jul 11 18:54:53 volumio volumio[1196]: info: PLUGIN onReboot : audiophonicsonoff Jul 11 18:54:53 volumio volumio[1196]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 18:54:53 volumio volumio[1196]: TypeError: Cannot read property 'writeSync' of undefined Jul 11 18:54:53 volumio volumio[1196]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_hardware/audiophonicsonoff/index.js:40:25) Jul 11 18:54:53 volumio volumio[1196]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Jul 11 18:54:53 volumio volumio[1196]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Jul 11 18:54:53 volumio volumio[1196]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Jul 11 18:54:53 volumio volumio[1196]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Jul 11 18:54:53 volumio volumio[1196]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Jul 11 18:54:53 volumio volumio[1196]: at CoreCommandRouter.reboot (/volumio/app/index.js:1350:22) Jul 11 18:54:53 volumio volumio[1196]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:870:33) Jul 11 18:54:53 volumio volumio[1196]: at Socket.emit (events.js:315:20) Jul 11 18:54:53 volumio volumio[1196]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 11 18:54:53 volumio volumio[1196]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 11 18:54:53 volumio volumio[1196]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 18:54:53 volumio sudo[2460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-11 18:53 Jul 11 18:54:53 volumio sudo[2460]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"