-- Logs begin at Fri 2022-04-08 15:29:57 UTC, end at Wed 2025-12-10 04:05:35 UTC. -- Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:19 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:19 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:19 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:19 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:19 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:19 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:19 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:19 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:19 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:19 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:19 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:19 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:19 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:20 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:20 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:20 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:20 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:20 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:20 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:20 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:20 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:20 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:20 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:20 opera volumio[4066]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Out%20Of%2FInto/Motion%20II/962f4da3-f524-4222-9209-2b7185966155.jpg' Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:21 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:21 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:21 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:21 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:21 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:21 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:21 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:21 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:21 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:21 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:21 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:22 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:22 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:22 opera shairport-sync[4293]: {"time":1765339423448,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Dec 10 04:04:22 opera shairport-sync[4293]: Dload Upload Total Spent Left Speed Dec 10 04:04:22 opera volumio[4066]: info: Dec 10 04:04:22 opera volumio[4066]: ---------------------------- Client requests Stop Airplay Playback Dec 10 04:04:22 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Dec 10 04:04:22 opera volumio[4066]: info: Airplay playback stop Dec 10 04:04:22 opera volumio[4066]: info: Airplay Playback Stopped, clearing state Dec 10 04:04:22 opera volumio[4066]: info: CoreStateMachine::resetVolumioState Dec 10 04:04:22 opera volumio[4066]: info: CoreStateMachine::getcurrentVolume Dec 10 04:04:22 opera volumio[4066]: info: CoreCommandRouter::volumioRetrievevolume Dec 10 04:04:22 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:22 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:22 opera shairport-sync[4293]: [155B blob data] Dec 10 04:04:22 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:22 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:24 opera volumio[4066]: info: Airplay started streaming, receiving metadatas Dec 10 04:04:24 opera volumio[4066]: info: Airplay started streaming, receiving metadatas Dec 10 04:04:24 opera shairport-sync[4293]: {"time":1765339462012,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Dec 10 04:04:24 opera shairport-sync[4293]: Dload Upload Total Spent Left Speed Dec 10 04:04:24 opera volumio[4066]: info: Dec 10 04:04:24 opera volumio[4066]: ---------------------------- Client requests Start Airplay PlaybackRoutine Dec 10 04:04:24 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Dec 10 04:04:24 opera volumio[4066]: info: Airplay playback start Dec 10 04:04:24 opera shairport-sync[4293]: [155B blob data] Dec 10 04:04:25 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:25 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:25 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:25 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:25 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:25 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:25 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:25 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:25 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:25 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:25 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:25 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:25 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:25 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:25 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:26 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:26 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:26 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:26 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:26 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:26 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:26 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:26 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:26 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:26 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:26 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:26 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:26 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:26 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:26 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:26 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:26 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:26 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:26 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:26 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:41 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:41 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:41 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:41 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:41 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:41 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:41 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:41 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:41 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:41 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:41 opera shairport-sync[4293]: {"time":1765339464822,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Dec 10 04:04:41 opera shairport-sync[4293]: Dload Upload Total Spent Left Speed Dec 10 04:04:41 opera volumio[4066]: info: Dec 10 04:04:41 opera volumio[4066]: ---------------------------- Client requests Stop Airplay Playback Dec 10 04:04:41 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Dec 10 04:04:41 opera volumio[4066]: info: Airplay playback stop Dec 10 04:04:41 opera volumio[4066]: info: Airplay Playback Stopped, clearing state Dec 10 04:04:41 opera volumio[4066]: info: CoreStateMachine::resetVolumioState Dec 10 04:04:41 opera volumio[4066]: info: CoreStateMachine::getcurrentVolume Dec 10 04:04:41 opera volumio[4066]: info: CoreCommandRouter::volumioRetrievevolume Dec 10 04:04:41 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:41 opera shairport-sync[4293]: [155B blob data] Dec 10 04:04:41 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:41 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:41 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:51 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:51 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:51 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:51 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:51 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:04:51 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:04:51 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:04:51 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:04:51 opera shairport-sync[4293]: {"time":1765339481414,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Dec 10 04:04:51 opera shairport-sync[4293]: Dload Upload Total Spent Left Speed Dec 10 04:04:51 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:51 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:04:51 opera volumio[4066]: info: Dec 10 04:04:51 opera volumio[4066]: ---------------------------- Client requests AirplayInactive Dec 10 04:04:51 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayInctive Dec 10 04:04:51 opera shairport-sync[4293]: [155B blob data] Dec 10 04:04:54 opera sudo[4637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 10 04:04:54 opera sudo[4637]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 04:04:54 opera sudo[4637]: pam_unix(sudo:session): session closed for user root Dec 10 04:04:54 opera sudo[4640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 10 04:04:54 opera sudo[4640]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 04:04:54 opera sudo[4640]: pam_unix(sudo:session): session closed for user root Dec 10 04:04:54 opera volumio[4066]: info: CoreCommandRouter::volumioGetVisibleSources Dec 10 04:04:54 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 04:04:54 opera volumio[4066]: info: CoreCommandRouter::volumioGetState Dec 10 04:04:54 opera volumio[4066]: info: CoreCommandRouter::volumioGetQueue Dec 10 04:04:54 opera volumio[4066]: info: CoreStateMachine::getQueue Dec 10 04:04:54 opera volumio[4066]: info: CorePlayQueue::getQueue Dec 10 04:04:54 opera volumio[4066]: info: Listing playlists Dec 10 04:04:54 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 10 04:04:54 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 10 04:04:54 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 10 04:04:54 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 10 04:04:54 opera volumio[1622]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.3:5353): query type 65 is invalid Dec 10 04:04:54 opera volumio[1622]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.3:5353): query type 65 is invalid Dec 10 04:04:55 opera volumio[1622]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.3:5353): query type 65 is invalid Dec 10 04:04:55 opera volumio[1622]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.3:5353): query type 65 is invalid Dec 10 04:04:56 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Dec 10 04:04:58 opera volumio[4066]: info: handleBrowseUri took 1834 milliseconds Dec 10 04:05:01 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Dec 10 04:05:02 opera volumio[4066]: info: handleBrowseUri took 619 milliseconds Dec 10 04:05:07 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Dec 10 04:05:09 opera volumio[4066]: info: handleBrowseUri took 2382 milliseconds Dec 10 04:05:13 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Dec 10 04:05:15 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 10 04:05:15 opera volumio[4066]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 10 04:05:15 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 10 04:05:15 opera volumio[4066]: error: Could not retrieve plugin system_controller my_volumio Dec 10 04:05:15 opera volumio[4066]: info: Received Get System Version Dec 10 04:05:15 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 10 04:05:15 opera volumio[4066]: info: handleBrowseUri took 1322 milliseconds Dec 10 04:05:16 opera volumio[4066]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 10 04:05:16 opera volumio[4066]: info: CoreStateMachine::ClearQueue Dec 10 04:05:16 opera volumio[4066]: info: CoreStateMachine::stop Dec 10 04:05:16 opera volumio[4066]: info: CoreStateMachine::serviceStop Dec 10 04:05:16 opera volumio[4066]: info: CoreCommandRouter::serviceStop Dec 10 04:05:16 opera volumio[4066]: info: Airplay Stop Dec 10 04:05:16 opera volumio[4066]: info: Stopping Airplay Playback and sending pause command to client via USR2 Dec 10 04:05:16 opera volumio[4066]: info: CorePlayQueue::clearPlayQueue Dec 10 04:05:16 opera volumio[4066]: info: CorePlayQueue::saveQueue Dec 10 04:05:16 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:05:16 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:05:16 opera volumio[4066]: info: CoreCommandRouter::volumioPushQueue Dec 10 04:05:16 opera volumio[4066]: info: CoreStateMachine::addQueueItems Dec 10 04:05:16 opera volumio[4066]: info: CorePlayQueue::addQueueItems Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/354082105 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/354082105 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/352399361 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/352399361 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/347627740 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/347627740 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/351836232 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/351836232 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/334339934 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/334339934 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/335477308 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/335477308 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/343028126 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/343028126 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/306567681 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/306567681 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/353014492 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/353014492 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355836931 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/355836931 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/350249796 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/350249796 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/361396574 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/361396574 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355281076 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/355281076 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/337591082 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/337591082 in service qobuz Dec 10 04:05:16 opera sudo[4709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 4293 Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/341795531 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/341795531 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/335016915 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/335016915 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/324746043 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/324746043 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/358787235 Dec 10 04:05:16 opera sudo[4709]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/358787235 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355852821 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/355852821 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/352692873 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/352692873 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/360753003 Dec 10 04:05:16 opera sudo[4709]: pam_unix(sudo:session): session closed for user root Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/360753003 in service qobuz Dec 10 04:05:16 opera systemd[1]: shairport-sync.service: main process exited, code=killed, status=12/USR2 Dec 10 04:05:16 opera shairport-sync[4293]: {"time":1765339491418,"response":"airplayInactive Success"} Dec 10 04:05:16 opera systemd[1]: Unit shairport-sync.service entered failed state. Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/347472325 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/347472325 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/343665756 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/343665756 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/329507367 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/329507367 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/316581655 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/316581655 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355854429 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/355854429 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/368760701 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/368760701 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/349884089 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/349884089 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/345650448 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/345650448 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/335572747 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/335572747 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/319186373 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/319186373 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/337100433 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/337100433 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/354660916 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/354660916 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/345388330 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/345388330 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355738893 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/355738893 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/356868535 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/356868535 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/345612397 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/345612397 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355646615 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/355646615 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/11091740 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/11091740 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/302433444 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/302433444 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/339884045 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/339884045 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/312575213 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/312575213 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/316759196 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/316759196 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/365451252 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/365451252 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/330139809 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/330139809 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/292720942 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/292720942 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/323129425 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/323129425 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/351520959 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/351520959 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355694761 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/355694761 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/358152893 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/358152893 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/317986726 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/317986726 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/349113453 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/349113453 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/328951803 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/328951803 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/329099983 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/329099983 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/327749532 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/327749532 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/335709284 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/335709284 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/356687932 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/356687932 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/332369121 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/332369121 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/325765792 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/325765792 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/338023591 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/338023591 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355337391 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/355337391 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/279171734 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/279171734 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/362966352 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/362966352 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/324601034 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/324601034 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/329123660 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/329123660 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/316363486 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/316363486 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/314061681 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/314061681 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/356354941 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/356354941 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/302548615 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/302548615 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/328069826 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/328069826 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/344451091 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/344451091 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/354396531 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/354396531 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/230877061 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/230877061 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/341402456 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/341402456 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/358121311 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/358121311 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/360162340 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/360162340 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/361403970 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/361403970 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/368761248 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/368761248 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/363785254 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/363785254 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/363503187 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/363503187 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/343052552 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/343052552 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/316912588 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/316912588 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/332887867 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/332887867 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/320713507 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/320713507 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/353286479 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/353286479 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/318342367 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/318342367 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/356294432 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/356294432 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/75606452 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/75606452 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/346768285 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/346768285 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/336220296 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/336220296 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/354931229 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/354931229 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/358860377 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/358860377 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/371168385 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/371168385 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/370305755 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/370305755 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/319185491 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/319185491 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/308277365 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/308277365 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/368760689 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/368760689 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/363414142 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/363414142 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/364077406 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/364077406 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/308274628 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/308274628 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/308977768 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/308977768 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/354388286 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/354388286 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/357995608 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/357995608 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/356962308 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/356962308 in service qobuz Dec 10 04:05:16 opera volumio[4066]: info: Adding Item to queue: qobuz://song/344456385 Dec 10 04:05:16 opera volumio[4066]: info: Exploding uri qobuz://song/344456385 in service qobuz Dec 10 04:05:17 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:05:17 opera volumio[4066]: info: Shairport-Sync paused with USR2 Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1087 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1150 milliseconds Dec 10 04:05:18 opera volumio[4066]: error: Cannot explode uri qobuz://song/323129425 from service qobuz: failed to get track: got 404: {"status":"error","code":404,"message":"No result matching given argument"} Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1362 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1272 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: Restarting Shairport-Sync after stop Dec 10 04:05:18 opera sudo[4721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 10 04:05:18 opera sudo[4721]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 04:05:18 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 10 04:05:18 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 10 04:05:18 opera sudo[4721]: pam_unix(sudo:session): session closed for user root Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1757 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1700 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1741 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1762 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1804 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1748 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1751 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1722 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1808 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1745 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1768 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1711 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1760 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1769 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1756 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1779 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1790 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1800 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1787 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1749 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1754 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1757 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1803 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1820 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1777 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1831 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1806 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1892 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1846 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1847 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1785 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1830 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1890 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1878 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1858 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1857 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1864 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1847 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1903 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1817 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1840 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1825 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1823 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1805 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1921 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1866 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1817 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1915 milliseconds Dec 10 04:05:18 opera volumio[4066]: error: Cannot explode uri qobuz://song/355836931 from service qobuz: failed to get track: got 404: {"status":"error","code":404,"message":"No result matching given argument"} Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1811 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1825 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1909 milliseconds Dec 10 04:05:18 opera volumio[4066]: error: Cannot explode uri qobuz://song/324746043 from service qobuz: failed to get track: got 404: {"status":"error","code":404,"message":"No result matching given argument"} Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1889 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1885 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1932 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1844 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1892 milliseconds Dec 10 04:05:18 opera volumio[4066]: error: Cannot explode uri qobuz://song/356868535 from service qobuz: failed to get track: got 404: {"status":"error","code":404,"message":"No result matching given argument"} Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1874 milliseconds Dec 10 04:05:18 opera volumio[4066]: error: Cannot explode uri qobuz://song/329099983 from service qobuz: failed to get track: got 404: {"status":"error","code":404,"message":"No result matching given argument"} Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1922 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1830 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1892 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: Shairport-Sync retarted Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1924 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1956 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1971 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1984 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 2003 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1970 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 2078 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 1979 milliseconds Dec 10 04:05:18 opera volumio[4066]: info: explodeUri took 2010 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2093 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2097 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2149 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2139 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2229 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2259 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2324 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2395 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2344 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2348 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2352 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2362 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2342 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2346 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2378 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: CoreCommandRouter::volumioPlay Dec 10 04:05:19 opera volumio[4066]: verbose: UNSET VOLATILE Dec 10 04:05:19 opera volumio[4066]: info: Stopping Airplay Playback and sending pause command to client via USR2 Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::play index undefined Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 04:05:19 opera volumio[4066]: info: CorePlayQueue::getTrack 0 Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2470 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2410 milliseconds Dec 10 04:05:19 opera sudo[4744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 4726 Dec 10 04:05:19 opera sudo[4744]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 04:05:19 opera sudo[4744]: pam_unix(sudo:session): session closed for user root Dec 10 04:05:19 opera systemd[1]: shairport-sync.service: main process exited, code=killed, status=12/USR2 Dec 10 04:05:19 opera systemd[1]: Unit shairport-sync.service entered failed state. Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2471 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: Shairport-Sync paused with USR2 Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2477 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2493 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2509 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2429 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2541 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2458 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2545 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2573 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2642 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2688 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2782 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2917 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 3049 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: explodeUri took 2974 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: CorePlayQueue::saveQueue Dec 10 04:05:19 opera volumio[4066]: info: CoreCommandRouter::volumioPushQueue Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::updateTrackBlock Dec 10 04:05:19 opera volumio[4066]: info: CorePlayQueue::getTrackBlock Dec 10 04:05:19 opera volumio[4066]: info: CoreCommandRouter::volumioPlay Dec 10 04:05:19 opera volumio[4066]: verbose: UNSET VOLATILE Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::play index 3 Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::stop Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 04:05:19 opera volumio[4066]: verbose: UNSET VOLATILE Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::stPlaybackTimer Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::updateTrackBlock Dec 10 04:05:19 opera volumio[4066]: info: CorePlayQueue::getTrackBlock Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:05:19 opera volumio[4066]: info: CorePlayQueue::getTrack 0 Dec 10 04:05:19 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:05:19 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::serviceStop Dec 10 04:05:19 opera volumio[4066]: info: CorePlayQueue::getTrack 0 Dec 10 04:05:19 opera volumio[4066]: info: CoreCommandRouter::serviceStop Dec 10 04:05:19 opera volumio[4066]: info: [1765339519933] ControllerQobuz::stop Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 10 04:05:19 opera volumio[4066]: info: ControllerMpd::stop Dec 10 04:05:19 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 04:05:19 opera volumio[4066]: info: sendMpdCommand stop took 5 milliseconds Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::play index undefined Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 04:05:19 opera volumio[4066]: info: CorePlayQueue::getTrack 3 Dec 10 04:05:19 opera volumio[4066]: info: CoreStateMachine::startPlaybackTimer Dec 10 04:05:19 opera volumio[4066]: info: CorePlayQueue::getTrack 3 Dec 10 04:05:19 opera volumio[4066]: info: [1765339519941] ControllerQobuz::clearAddPlayTrack Dec 10 04:05:19 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:05:20 opera volumio[4066]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 10 04:05:20 opera volumio[4066]: info: CoreStateMachine::ClearQueue Dec 10 04:05:20 opera volumio[4066]: info: CoreStateMachine::stop Dec 10 04:05:20 opera volumio[4066]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 04:05:20 opera volumio[4066]: verbose: UNSET VOLATILE Dec 10 04:05:20 opera volumio[4066]: info: CorePlayQueue::clearPlayQueue Dec 10 04:05:20 opera volumio[4066]: info: CorePlayQueue::saveQueue Dec 10 04:05:20 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:05:20 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:05:20 opera volumio[4066]: info: CoreCommandRouter::volumioPushQueue Dec 10 04:05:20 opera volumio[4066]: info: CoreStateMachine::addQueueItems Dec 10 04:05:20 opera volumio[4066]: info: CorePlayQueue::addQueueItems Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/354082105 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/354082105 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/352399361 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/352399361 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/347627740 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/347627740 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/351836232 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/351836232 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/334339934 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/334339934 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/335477308 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/335477308 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/343028126 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/343028126 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/306567681 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/306567681 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/353014492 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/353014492 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355836931 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/355836931 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/350249796 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/350249796 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/361396574 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/361396574 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355281076 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/355281076 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/337591082 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/337591082 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/341795531 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/341795531 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/335016915 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/335016915 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/324746043 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/324746043 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/358787235 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/358787235 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355852821 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/355852821 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/352692873 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/352692873 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/360753003 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/360753003 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/347472325 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/347472325 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/343665756 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/343665756 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/329507367 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/329507367 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/316581655 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/316581655 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355854429 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/355854429 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/368760701 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/368760701 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/349884089 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/349884089 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/345650448 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/345650448 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/335572747 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/335572747 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/319186373 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/319186373 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/337100433 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/337100433 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/354660916 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/354660916 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/345388330 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/345388330 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355738893 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/355738893 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/356868535 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/356868535 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/345612397 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/345612397 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355646615 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/355646615 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/11091740 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/11091740 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/302433444 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/302433444 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/339884045 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/339884045 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/312575213 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/312575213 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/316759196 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/316759196 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/365451252 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/365451252 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/330139809 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/330139809 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/292720942 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/292720942 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/323129425 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/323129425 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/351520959 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/351520959 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355694761 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/355694761 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/358152893 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/358152893 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/317986726 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/317986726 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/349113453 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/349113453 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/328951803 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/328951803 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/329099983 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/329099983 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/327749532 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/327749532 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/335709284 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/335709284 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/356687932 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/356687932 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/332369121 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/332369121 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/325765792 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/325765792 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/338023591 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/338023591 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/355337391 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/355337391 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/279171734 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/279171734 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/362966352 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/362966352 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/324601034 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/324601034 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/329123660 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/329123660 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/316363486 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/316363486 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/314061681 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/314061681 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/356354941 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/356354941 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/302548615 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/302548615 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/328069826 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/328069826 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/344451091 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/344451091 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/354396531 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/354396531 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/230877061 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/230877061 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/341402456 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/341402456 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/358121311 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/358121311 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/360162340 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/360162340 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/361403970 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/361403970 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/368761248 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/368761248 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/363785254 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/363785254 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/363503187 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/363503187 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/343052552 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/343052552 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/316912588 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/316912588 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/332887867 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/332887867 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/320713507 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/320713507 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/353286479 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/353286479 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/318342367 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/318342367 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/356294432 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/356294432 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/75606452 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/75606452 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/346768285 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/346768285 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/336220296 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/336220296 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/354931229 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/354931229 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/358860377 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/358860377 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/371168385 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/371168385 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/370305755 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/370305755 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/319185491 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/319185491 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/308277365 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/308277365 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/368760689 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/368760689 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/363414142 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/363414142 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/364077406 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/364077406 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/308274628 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/308274628 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/308977768 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/308977768 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/354388286 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/354388286 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/357995608 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/357995608 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/356962308 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/356962308 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Adding Item to queue: qobuz://song/344456385 Dec 10 04:05:20 opera volumio[4066]: info: Exploding uri qobuz://song/344456385 in service qobuz Dec 10 04:05:20 opera volumio[4066]: info: Restarting Shairport-Sync after stop Dec 10 04:05:20 opera sudo[4756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 10 04:05:20 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:05:20 opera sudo[4756]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 04:05:20 opera volumio[4066]: info: getStreamUrl took 742 milliseconds Dec 10 04:05:20 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 04:05:20 opera volumio[4066]: info: sendMpdCommand stop took 2 milliseconds Dec 10 04:05:20 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand clear Dec 10 04:05:20 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 10 04:05:20 opera volumio[4066]: info: Dec 10 04:05:20 opera volumio[4066]: ---------------------------- MPD announces system playlist update Dec 10 04:05:20 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 10 04:05:20 opera volumio[4066]: info: Ignoring MPD Status Update Dec 10 04:05:20 opera volumio[4066]: info: sendMpdCommand clear took 6 milliseconds Dec 10 04:05:20 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand load "https://streaming-qobuz-std.akamaized.net/file?uid=9143235&eid=351836232&fmt=7&profile=raw&range=20-30&app_id=539451548&etsp=1765425920&hmac=fShZyD-ltUQ4RKbWdYMPU4FNV1w" Dec 10 04:05:20 opera volumio[4066]: error: updateQueue error: null Dec 10 04:05:20 opera volumio[4066]: info: ------------------------------ 5ms Dec 10 04:05:20 opera sudo[4756]: pam_unix(sudo:session): session closed for user root Dec 10 04:05:20 opera volumio[4066]: info: Shairport-Sync retarted Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1123 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1128 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1104 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1149 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1136 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1115 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1259 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1233 milliseconds Dec 10 04:05:21 opera volumio[4066]: error: Cannot explode uri qobuz://song/323129425 from service qobuz: failed to get track: got 404: {"status":"error","code":404,"message":"No result matching given argument"} Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1238 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1207 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1238 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1220 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1202 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1248 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1216 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1313 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1352 milliseconds Dec 10 04:05:21 opera volumio[4066]: info: explodeUri took 1341 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1659 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1825 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1753 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1717 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1715 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1817 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1813 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1760 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1837 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1826 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1839 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1816 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1821 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1804 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1727 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1810 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1786 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1773 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1740 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1813 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1781 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1762 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1750 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1796 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1791 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1840 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1857 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1846 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1810 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1806 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1835 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1912 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1856 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1796 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1879 milliseconds Dec 10 04:05:22 opera volumio[4066]: error: Cannot explode uri qobuz://song/356868535 from service qobuz: failed to get track: got 404: {"status":"error","code":404,"message":"No result matching given argument"} Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1911 milliseconds Dec 10 04:05:22 opera volumio[4066]: error: Cannot explode uri qobuz://song/355836931 from service qobuz: failed to get track: got 404: {"status":"error","code":404,"message":"No result matching given argument"} Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1798 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1788 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1906 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1801 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1868 milliseconds Dec 10 04:05:22 opera volumio[4066]: error: Cannot explode uri qobuz://song/329099983 from service qobuz: failed to get track: got 404: {"status":"error","code":404,"message":"No result matching given argument"} Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1902 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1919 milliseconds Dec 10 04:05:22 opera volumio[4066]: error: Cannot explode uri qobuz://song/324746043 from service qobuz: failed to get track: got 404: {"status":"error","code":404,"message":"No result matching given argument"} Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1818 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1852 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1879 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1919 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1930 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1865 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1818 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1825 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 1817 milliseconds Dec 10 04:05:22 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=9143235&eid=351836232&fmt=7&profile=raw&range=20-30&app_id=539451548&etsp=1765425920&hmac=fShZyD-ltUQ4RKbWdYMPU4FNV1w" Dec 10 04:05:22 opera volumio[4066]: info: Dec 10 04:05:22 opera volumio[4066]: ---------------------------- MPD announces system playlist update Dec 10 04:05:22 opera volumio[4066]: info: Ignoring MPD Status Update Dec 10 04:05:22 opera volumio[4066]: info: sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=9143235&eid=351836232&fmt=7&profile=raw&range=20-30&app_id=539451548&etsp=1765425920&hmac=fShZyD-ltUQ4RKbWdYMPU4FNV1w" took 2 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 10 04:05:22 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand play Dec 10 04:05:22 opera volumio[4066]: info: ------------------------------ 4ms Dec 10 04:05:22 opera volumio[4066]: info: sendMpdCommand play took 3 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2216 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2148 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2103 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2208 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2218 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2126 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2156 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2210 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2213 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2169 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2188 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2110 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2128 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2159 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2195 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2345 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2372 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2372 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2349 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2301 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2311 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2306 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2370 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2258 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2277 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2421 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2451 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2471 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2540 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2604 milliseconds Dec 10 04:05:22 opera volumio[4066]: info: explodeUri took 2615 milliseconds Dec 10 04:05:23 opera volumio[4066]: info: explodeUri took 2833 milliseconds Dec 10 04:05:23 opera volumio[4066]: info: explodeUri took 2943 milliseconds Dec 10 04:05:23 opera volumio[4066]: info: explodeUri took 3122 milliseconds Dec 10 04:05:24 opera volumio[4066]: info: Dec 10 04:05:24 opera volumio[4066]: ---------------------------- MPD announces state update: player Dec 10 04:05:24 opera volumio[4066]: info: ControllerMpd::getState Dec 10 04:05:24 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand status Dec 10 04:05:24 opera volumio[4066]: info: explodeUri took 3935 milliseconds Dec 10 04:05:24 opera volumio[4066]: info: CorePlayQueue::saveQueue Dec 10 04:05:24 opera volumio[4066]: info: CoreCommandRouter::volumioPushQueue Dec 10 04:05:24 opera volumio[4066]: info: CoreStateMachine::updateTrackBlock Dec 10 04:05:24 opera volumio[4066]: info: CorePlayQueue::getTrackBlock Dec 10 04:05:24 opera volumio[4066]: info: CoreCommandRouter::volumioPlay Dec 10 04:05:24 opera volumio[4066]: verbose: UNSET VOLATILE Dec 10 04:05:24 opera volumio[4066]: info: CoreStateMachine::play index 3 Dec 10 04:05:24 opera volumio[4066]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 04:05:24 opera volumio[4066]: info: CoreStateMachine::stop Dec 10 04:05:24 opera volumio[4066]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 04:05:24 opera volumio[4066]: verbose: UNSET VOLATILE Dec 10 04:05:24 opera volumio[4066]: info: CoreStateMachine::play index undefined Dec 10 04:05:24 opera volumio[4066]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 04:05:24 opera volumio[4066]: info: CorePlayQueue::getTrack 3 Dec 10 04:05:24 opera volumio[4066]: info: CoreStateMachine::startPlaybackTimer Dec 10 04:05:24 opera volumio[4066]: info: CorePlayQueue::getTrack 3 Dec 10 04:05:24 opera volumio[4066]: info: [1765339524294] ControllerQobuz::clearAddPlayTrack Dec 10 04:05:24 opera volumio[4066]: info: Dec 10 04:05:24 opera volumio[4066]: ---------------------------- MPD announces state update: player Dec 10 04:05:24 opera volumio[4066]: info: sendMpdCommand status took 276 milliseconds Dec 10 04:05:24 opera volumio[4066]: info: ControllerMpd::getState Dec 10 04:05:24 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand status Dec 10 04:05:24 opera volumio[4066]: verbose: ControllerMpd::parseState Dec 10 04:05:24 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 04:05:24 opera volumio[4066]: info: sendMpdCommand status took 17 milliseconds Dec 10 04:05:24 opera volumio[4066]: info: sendMpdCommand playlistinfo took 16 milliseconds Dec 10 04:05:24 opera volumio[4066]: verbose: ControllerMpd::parseState Dec 10 04:05:24 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 04:05:24 opera volumio[4066]: verbose: ControllerMpd::parseTrackInfo Dec 10 04:05:24 opera volumio[4066]: info: ControllerMpd::pushState Dec 10 04:05:24 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:05:24 opera volumio[4066]: info: CorePlayQueue::getTrack 3 Dec 10 04:05:24 opera volumio[4066]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Dec 10 04:05:24 opera volumio[4066]: info: ------------------------------ 309ms Dec 10 04:05:24 opera volumio[4066]: info: sendMpdCommand playlistinfo took 16 milliseconds Dec 10 04:05:24 opera volumio[4066]: verbose: ControllerMpd::parseTrackInfo Dec 10 04:05:24 opera volumio[4066]: info: ControllerMpd::pushState Dec 10 04:05:24 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:05:24 opera volumio[4066]: info: CorePlayQueue::getTrack 3 Dec 10 04:05:24 opera volumio[4066]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Dec 10 04:05:24 opera volumio[4066]: info: ------------------------------ 47ms Dec 10 04:05:24 opera volumio[4066]: info: getStreamUrl took 693 milliseconds Dec 10 04:05:24 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 04:05:25 opera volumio[4066]: info: Dec 10 04:05:25 opera volumio[4066]: ---------------------------- MPD announces state update: player Dec 10 04:05:25 opera volumio[4066]: info: sendMpdCommand stop took 197 milliseconds Dec 10 04:05:25 opera volumio[4066]: info: ControllerMpd::getState Dec 10 04:05:25 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand status Dec 10 04:05:25 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand clear Dec 10 04:05:25 opera volumio[4066]: info: Dec 10 04:05:25 opera volumio[4066]: ---------------------------- MPD announces system playlist update Dec 10 04:05:25 opera volumio[4066]: info: Ignoring MPD Status Update Dec 10 04:05:25 opera volumio[4066]: info: sendMpdCommand status took 2 milliseconds Dec 10 04:05:25 opera volumio[4066]: info: sendMpdCommand clear took 2 milliseconds Dec 10 04:05:25 opera volumio[4066]: verbose: ControllerMpd::parseState Dec 10 04:05:25 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 04:05:25 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand load "https://streaming-qobuz-std.akamaized.net/file?uid=9143235&eid=351836232&fmt=7&profile=raw&range=20-30&app_id=539451548&etsp=1765425924&hmac=lYDD5JCxKUnCuIY595WSh7q774U" Dec 10 04:05:25 opera volumio[4066]: error: updateQueue error: null Dec 10 04:05:25 opera volumio[4066]: info: ------------------------------ 4ms Dec 10 04:05:25 opera volumio[4066]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 10 04:05:25 opera volumio[4066]: verbose: ControllerMpd::parseTrackInfo Dec 10 04:05:25 opera volumio[4066]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 10 04:05:25 opera volumio[4066]: info: ------------------------------ 8ms Dec 10 04:05:25 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=9143235&eid=351836232&fmt=7&profile=raw&range=20-30&app_id=539451548&etsp=1765425924&hmac=lYDD5JCxKUnCuIY595WSh7q774U" Dec 10 04:05:25 opera volumio[4066]: info: Dec 10 04:05:25 opera volumio[4066]: ---------------------------- MPD announces system playlist update Dec 10 04:05:25 opera volumio[4066]: info: Ignoring MPD Status Update Dec 10 04:05:25 opera volumio[4066]: info: sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=9143235&eid=351836232&fmt=7&profile=raw&range=20-30&app_id=539451548&etsp=1765425924&hmac=lYDD5JCxKUnCuIY595WSh7q774U" took 1 milliseconds Dec 10 04:05:25 opera volumio[4066]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 10 04:05:25 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand play Dec 10 04:05:25 opera volumio[4066]: info: ------------------------------ 3ms Dec 10 04:05:25 opera volumio[4066]: info: sendMpdCommand play took 2 milliseconds Dec 10 04:05:26 opera volumio[4066]: info: Dec 10 04:05:26 opera volumio[4066]: ---------------------------- MPD announces state update: player Dec 10 04:05:26 opera volumio[4066]: info: ControllerMpd::getState Dec 10 04:05:26 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand status Dec 10 04:05:26 opera volumio[4066]: info: Dec 10 04:05:26 opera volumio[4066]: ---------------------------- MPD announces state update: player Dec 10 04:05:26 opera volumio[4066]: info: sendMpdCommand status took 3 milliseconds Dec 10 04:05:26 opera volumio[4066]: info: ControllerMpd::getState Dec 10 04:05:26 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand status Dec 10 04:05:26 opera volumio[4066]: verbose: ControllerMpd::parseState Dec 10 04:05:26 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 04:05:26 opera volumio[4066]: info: sendMpdCommand status took 2 milliseconds Dec 10 04:05:26 opera volumio[4066]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 10 04:05:26 opera volumio[4066]: verbose: ControllerMpd::parseState Dec 10 04:05:26 opera volumio[4066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 04:05:26 opera volumio[4066]: verbose: ControllerMpd::parseTrackInfo Dec 10 04:05:26 opera volumio[4066]: info: ControllerMpd::pushState Dec 10 04:05:26 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:05:26 opera volumio[4066]: info: CorePlayQueue::getTrack 3 Dec 10 04:05:26 opera volumio[4066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=9143235&eid=351836232&fmt=7&profile=raw&range=20-30&app_id=539451548&etsp=1765425924&hmac=lYDD5JCxKUnCuIY595WSh7q774U","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=9143235&eid=351836232&fmt=7&profile=raw&range=20-30&app_id=539451548&etsp=1765425924&hmac=lYDD5JCxKUnCuIY595WSh7q774U","trackType":"qobuz"} Dec 10 04:05:26 opera volumio[4066]: verbose: CURRENT POSITION 3 Dec 10 04:05:26 opera volumio[4066]: info: CoreStateMachine::syncState stateService play Dec 10 04:05:26 opera volumio[4066]: info: CoreStateMachine::syncState currentStatus stop Dec 10 04:05:26 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:05:26 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:05:26 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:05:26 opera volumio[4066]: info: ------------------------------ 15ms Dec 10 04:05:26 opera volumio[4066]: info: sendMpdCommand playlistinfo took 9 milliseconds Dec 10 04:05:26 opera volumio[4066]: verbose: ControllerMpd::parseTrackInfo Dec 10 04:05:26 opera volumio[4066]: info: ControllerMpd::pushState Dec 10 04:05:26 opera volumio[4066]: info: CoreCommandRouter::servicePushState Dec 10 04:05:26 opera volumio[4066]: info: CorePlayQueue::getTrack 3 Dec 10 04:05:26 opera volumio[4066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":490,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2742 Kbps","isStreaming":false,"title":"file?uid=9143235&eid=351836232&fmt=7&profile=raw&range=20-30&app_id=539451548&etsp=1765425924&hmac=lYDD5JCxKUnCuIY595WSh7q774U","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=9143235&eid=351836232&fmt=7&profile=raw&range=20-30&app_id=539451548&etsp=1765425924&hmac=lYDD5JCxKUnCuIY595WSh7q774U","trackType":"qobuz"} Dec 10 04:05:26 opera volumio[4066]: verbose: CURRENT POSITION 3 Dec 10 04:05:26 opera volumio[4066]: info: CoreStateMachine::syncState stateService play Dec 10 04:05:26 opera volumio[4066]: info: CoreStateMachine::syncState currentStatus play Dec 10 04:05:26 opera volumio[4066]: info: Received an update from plugin. extracting info from payload Dec 10 04:05:26 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:05:26 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:05:26 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:05:26 opera volumio[4066]: info: CoreStateMachine::pushState Dec 10 04:05:26 opera volumio[4066]: info: CoreCommandRouter::volumioPushState Dec 10 04:05:26 opera volumio[4066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 04:05:26 opera volumio[4066]: info: ------------------------------ 27ms Dec 10 04:05:26 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:05:26 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:05:26 opera volumio[4066]: info: Updating RAAT Signal Path Dec 10 04:05:34 opera volumio[4066]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 04:05:34 opera volumio[4066]: { Error: connect ETIMEDOUT 128.242.240.157:443 Dec 10 04:05:34 opera volumio[4066]: at Object._errnoException (util.js:1022:11) Dec 10 04:05:34 opera volumio[4066]: at _exceptionWithHostPort (util.js:1044:20) Dec 10 04:05:34 opera volumio[4066]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Dec 10 04:05:34 opera volumio[4066]: code: 'ETIMEDOUT', Dec 10 04:05:34 opera volumio[4066]: errno: 'ETIMEDOUT', Dec 10 04:05:34 opera volumio[4066]: syscall: 'connect', Dec 10 04:05:34 opera volumio[4066]: address: '128.242.240.157', Dec 10 04:05:34 opera volumio[4066]: port: 443 } Dec 10 04:05:34 opera volumio[4066]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 04:05:35 opera sudo[4811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-10 04:04 Dec 10 04:05:35 opera sudo[4811]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"