-- Logs begin at Wed 2025-06-11 23:56:30 CEST, end at Wed 2025-06-11 23:58:32 CEST. -- Jun 11 23:57:00 wohnzimmer volumio[927]: info: [now-playing] ConfigUpdater: config is up to date. Jun 11 23:57:00 wohnzimmer volumio[927]: info: Loading i18n strings for locale de Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: FusionDsp - mixtype--------------------- Software Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 11 23:57:00 wohnzimmer volumio[927]: info: [1749679020034] CoreMusicLibrary::Adding element LastFM Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 11 23:57:00 wohnzimmer volumio[927]: Cannot find translation for source LastFM Jun 11 23:57:00 wohnzimmer volumio[927]: info: [LastFM] scrobbler initiated! Jun 11 23:57:00 wohnzimmer volumio[927]: info: [LastFM] extended logging: false Jun 11 23:57:00 wohnzimmer volumio[927]: info: [LastFM] try scrobble stream/radio plays: true Jun 11 23:57:00 wohnzimmer volumio[927]: info: [LastFM] Configuration parameters missing: "API_KEY" "API_SECRET" "username" "authToken" Jun 11 23:57:00 wohnzimmer volumio[927]: info: [LastFM] Left init routine Jun 11 23:57:00 wohnzimmer volumio[927]: info: [LastFM] Socket already connected: true Jun 11 23:57:00 wohnzimmer volumio[927]: info: Volumio Calling Home Jun 11 23:57:00 wohnzimmer volumio[927]: info: Preparing to generate the ALSA configuration file Jun 11 23:57:00 wohnzimmer volumio[927]: info: [LastFM] finished init with error: Configuration parameters missing: "API_KEY" "API_SECRET" "username" "authToken" Jun 11 23:57:00 wohnzimmer volumio[927]: info: [now-playing] App is listening on port 4004. Jun 11 23:57:00 wohnzimmer volumio[927]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 11 23:57:00 wohnzimmer volumio[927]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jun 11 23:57:00 wohnzimmer volumio[927]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 11 23:57:00 wohnzimmer volumio[927]: info: Reading ALSA contributions from plugins. Jun 11 23:57:00 wohnzimmer volumio[927]: info: MPD Permissions set Jun 11 23:57:00 wohnzimmer volumio[927]: info: MPD Permissions set Jun 11 23:57:00 wohnzimmer volumio[927]: error: Upnp client error: Error: This socket has been ended by the other party Jun 11 23:57:00 wohnzimmer volumio[927]: info: Spotify config file written Jun 11 23:57:00 wohnzimmer volumio[927]: info: FusionDsp - IP adress is ---------------------------192.168.1.203 Jun 11 23:57:00 wohnzimmer volumio[927]: info: FusionDsp - Jun 11 23:57:00 wohnzimmer sudo[1747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 11 23:57:00 wohnzimmer sudo[1747]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:00 wohnzimmer systemd[1]: Started go-librespot Daemon. Jun 11 23:57:00 wohnzimmer go-librespot[1749]: go-librespot daemon starting... Jun 11 23:57:00 wohnzimmer sudo[1747]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:00 wohnzimmer volumio[927]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 11 23:57:00 wohnzimmer volumio[927]: info: Volumio called home Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:00 wohnzimmer volumio[927]: info: No need to fix Spotify hosts Jun 11 23:57:00 wohnzimmer volumio[927]: info: FusionDsp - IP adress is ---------------------------192.168.1.203 Jun 11 23:57:00 wohnzimmer volumio[927]: info: FusionDsp - Jun 11 23:57:00 wohnzimmer mpd[1731]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 11 23:57:00 wohnzimmer mpd[1731]: output: No 'audio_output' defined in config file Jun 11 23:57:00 wohnzimmer mpd[1731]: couldn't open play stream: No such file or directory Jun 11 23:57:00 wohnzimmer mpd[1731]: sndio_output: Error opening default sndio device Jun 11 23:57:00 wohnzimmer volumio[927]: info: FusionDsp - undefined Jun 11 23:57:00 wohnzimmer mpd[1731]: ALSA lib /home/volumio-fifo-plugin/src/pcm_volumiofifo.c:753:(_snd_pcm_volumiofifo_open) Failed to open output fifo /tmp/fusiondspfifo Jun 11 23:57:00 wohnzimmer mpd[1731]: alsa_output: Error opening default ALSA device: No such file or directory Jun 11 23:57:00 wohnzimmer mpd[1731]: output: Successfully detected a jack audio device Jun 11 23:57:00 wohnzimmer mpd[1731]: zeroconf: No global port, disabling zeroconf Jun 11 23:57:00 wohnzimmer systemd[1]: Started Music Player Daemon. Jun 11 23:57:00 wohnzimmer sudo[1711]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:00 wohnzimmer sudo[1721]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:00 wohnzimmer volumio[927]: info: FusionDsp - undefined Jun 11 23:57:00 wohnzimmer go-librespot[1749]: time="2025-06-11T23:57:00+02:00" level=info msg="running go-librespot 0.2.0" Jun 11 23:57:00 wohnzimmer go-librespot[1749]: time="2025-06-11T23:57:00+02:00" level=debug msg="app state loaded" Jun 11 23:57:00 wohnzimmer go-librespot[1749]: time="2025-06-11T23:57:00+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 11 23:57:00 wohnzimmer volumio[927]: info: VolumeController::SetAlsaVolume0 Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:57:00 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:57:00 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:57:00 wohnzimmer volumio[927]: info: Completed starting Core Plugins Jun 11 23:57:00 wohnzimmer volumio[927]: info: ------------------------------------------- Jun 11 23:57:00 wohnzimmer volumio[927]: info: ----- MyVolumio plugins startup ---- Jun 11 23:57:00 wohnzimmer volumio[927]: info: ------------------------------------------- Jun 11 23:57:00 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 11 23:57:00 wohnzimmer volumio[927]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jun 11 23:57:01 wohnzimmer volumio[927]: info: Starting Shairport Sync Jun 11 23:57:01 wohnzimmer volumio[927]: info: Starting Shairport Sync Jun 11 23:57:01 wohnzimmer sudo[1775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 11 23:57:01 wohnzimmer sudo[1775]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:01 wohnzimmer volumio[927]: info: Starting Shairport Sync Jun 11 23:57:01 wohnzimmer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 11 23:57:01 wohnzimmer sudo[1777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 11 23:57:01 wohnzimmer systemd[1]: shairport-sync.service: Succeeded. Jun 11 23:57:01 wohnzimmer sudo[1777]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:01 wohnzimmer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 11 23:57:01 wohnzimmer go-librespot[1749]: time="2025-06-11T23:57:01+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Jun 11 23:57:01 wohnzimmer go-librespot[1749]: time="2025-06-11T23:57:01+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jun 11 23:57:01 wohnzimmer go-librespot[1749]: time="2025-06-11T23:57:01+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jun 11 23:57:01 wohnzimmer go-librespot[1749]: time="2025-06-11T23:57:01+02:00" level=info msg="zeroconf server listening on port 40913" Jun 11 23:57:01 wohnzimmer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 11 23:57:01 wohnzimmer sudo[1775]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:01 wohnzimmer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 11 23:57:01 wohnzimmer systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 11 23:57:01 wohnzimmer systemd[1]: shairport-sync.service: Succeeded. Jun 11 23:57:01 wohnzimmer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 11 23:57:01 wohnzimmer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 11 23:57:01 wohnzimmer sudo[1777]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:01 wohnzimmer sudo[1782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 11 23:57:01 wohnzimmer sudo[1782]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:01 wohnzimmer go-librespot[1749]: time="2025-06-11T23:57:01+02:00" level=debug msg="obtained new client token: AAAnKFdeOpN/aGoCkczFvkd0eeu+pN6Knabj2PqAjNAo0CptHeHz2OLFD5usBbWjNWVR5VWT/bzEyTxgU5wpZM8G1B4TqqkFZneKUHc2fdbkFdQZVkVRYwGxLFICfrp4AhtEep5KhnGSltORAZiqE+MJ8d6n6N3KUE0Rjh2a/zmID3f+hLO0om1Xrd02F29jsAoHk59XTg+oTHNoSRN0rZZym7QVvHn2RQi+C6bM+Fu7BwmLqOwVnbvz" Jun 11 23:57:01 wohnzimmer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 11 23:57:01 wohnzimmer systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 11 23:57:01 wohnzimmer systemd[1]: shairport-sync.service: Succeeded. Jun 11 23:57:01 wohnzimmer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 11 23:57:01 wohnzimmer go-librespot[1749]: time="2025-06-11T23:57:01+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Jun 11 23:57:01 wohnzimmer volumio[927]: error: MPD error: The expression evaluated to a falsy value: Jun 11 23:57:01 wohnzimmer volumio[927]: assert.ok(self.idling) Jun 11 23:57:01 wohnzimmer volumio[927]: error: The expression evaluated to a falsy value: Jun 11 23:57:01 wohnzimmer volumio[927]: assert.ok(self.idling) Jun 11 23:57:01 wohnzimmer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 11 23:57:01 wohnzimmer sudo[1782]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:01 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:01 wohnzimmer volumio[927]: info: MPD running with PID1731 Jun 11 23:57:01 wohnzimmer volumio[927]: ,establishing connection Jun 11 23:57:01 wohnzimmer volumio[927]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jun 11 23:57:01 wohnzimmer volumio[927]: SPOTIFY: BQAjzduI1g_cHdcLsqFxCrxYaVFky9Ph2yYCAVu2qqAGTEbKbYSORZfBworiXA6RudNV-ISXPO-ZM_QJ2L44PnYRTpYnlkBDO09xhxMrnx7IFPar_eadZmgZRY9W91Wpkp-3bPD-xDtYbWB1UkD3ndyW-rIm-ijIXMR2N3MSuYpfS8fAWhTQmXCMzCh1zmhkaNAz4FwP71ju_QRlVXdnliOgGGTV7YzIJJ--MOPIctGxIxqJvyzsfP3gk62fnDr57spbR0ZRIHf9v_f9fzNqBMR5g16w Jun 11 23:57:01 wohnzimmer volumio[927]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jun 11 23:57:01 wohnzimmer volumio[927]: info: New Spotify access token = BQAjzduI1g_cHdcLsqFxCrxYaVFky9Ph2yYCAVu2qqAGTEbKbYSORZfBworiXA6RudNV-ISXPO-ZM_QJ2L44PnYRTpYnlkBDO09xhxMrnx7IFPar_eadZmgZRY9W91Wpkp-3bPD-xDtYbWB1UkD3ndyW-rIm-ijIXMR2N3MSuYpfS8fAWhTQmXCMzCh1zmhkaNAz4FwP71ju_QRlVXdnliOgGGTV7YzIJJ--MOPIctGxIxqJvyzsfP3gk62fnDr57spbR0ZRIHf9v_f9fzNqBMR5g16w Jun 11 23:57:01 wohnzimmer volumio[927]: info: Spotify credentials grant success - running version from March 24, 2019 Jun 11 23:57:01 wohnzimmer volumio[927]: error: updateQueue error: null Jun 11 23:57:01 wohnzimmer volumio[927]: info: Shairport-Sync Started Jun 11 23:57:01 wohnzimmer volumio[927]: Error adding Membership: Error: addMembership EINVAL Jun 11 23:57:01 wohnzimmer volumio[927]: info: Shairport-Sync Started Jun 11 23:57:01 wohnzimmer volumio[927]: info: Shairport-Sync Started Jun 11 23:57:01 wohnzimmer volumio[927]: info: Asound.conf file unchanged, so no further update is needed Jun 11 23:57:01 wohnzimmer volumio[927]: info: Output device has changed, restarting MPD Jun 11 23:57:01 wohnzimmer sudo[1790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 11 23:57:01 wohnzimmer sudo[1790]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:01 wohnzimmer volumio[927]: info: Output device has changed, restarting Shairport Sync Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:01 wohnzimmer sudo[1790]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:01 wohnzimmer sudo[1793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 11 23:57:01 wohnzimmer sudo[1793]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:01 wohnzimmer systemd[1]: Stopping Music Player Daemon... Jun 11 23:57:01 wohnzimmer volumio[927]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 11 23:57:01 wohnzimmer systemd[1]: mpd.service: Succeeded. Jun 11 23:57:01 wohnzimmer systemd[1]: Stopped Music Player Daemon. Jun 11 23:57:01 wohnzimmer systemd[1]: Starting Music Player Daemon... Jun 11 23:57:01 wohnzimmer sudo[1798]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 11 23:57:01 wohnzimmer sudo[1798]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:01 wohnzimmer sudo[1798]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:01 wohnzimmer volumio[927]: error: MPD error: Error: write EPIPE Jun 11 23:57:01 wohnzimmer volumio[927]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Jun 11 23:57:01 wohnzimmer volumio[927]: info: MPD Permissions set Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:01 wohnzimmer volumio[927]: info: Starting Shairport Sync Jun 11 23:57:01 wohnzimmer sudo[1808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 11 23:57:01 wohnzimmer sudo[1808]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:01 wohnzimmer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 11 23:57:01 wohnzimmer systemd[1]: shairport-sync.service: Succeeded. Jun 11 23:57:01 wohnzimmer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 11 23:57:01 wohnzimmer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 11 23:57:01 wohnzimmer sudo[1808]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:01 wohnzimmer volumio[927]: info: Shairport-Sync Started Jun 11 23:57:01 wohnzimmer volumio[927]: SPOTIFY: User informations: {"country":"DE","display_name":"Stefan","email":"stefan.guhle@googlemail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/11130484598"},"followers":{"href":null,"total":3},"href":"https://api.spotify.com/v1/users/11130484598","id":"11130484598","images":[{"height":300,"url":"https://scontent-lhr8-1.xx.fbcdn.net/v/t1.6435-1/101548700_3868886273185804_7424884108339183616_n.jpg?stp=dst-jpg_s320x320_tt6&_nc_cat=108&ccb=1-7&_nc_sid=79bf43&_nc_ohc=NDWZmMv_f-oQ7kNvwFaNEwO&_nc_oc=AdnkAaJFbEgVD7B_NPL3OcvEuCog7BddtsAdMh5AFl76L8eeuQdhGn8_osNYpyOztNd5GWZCxBvKIA18bop5Knzw&_nc_zt=24&_nc_ht=scontent-lhr8-1.xx&edm=AP4hL3IEAAAA&_nc_gid=pVTTaE3KoMOJd_38N-pSjQ&oh=00_AfPr97TJaIZrPIk-m1P54CJQ-1KOo3ryU17GAJ3GfWKSFQ&oe=68714F5F","width":300},{"height":64,"url":"https://scontent-lhr8-1.xx.fbcdn.net/v/t1.6435-1/101548700_3868886273185804_7424884108339183616_n.jpg?stp=cp0_dst-jpg_s50x50_tt6&_nc_cat=108&ccb=1-7&_nc_sid=28885b&_nc_ohc=NDWZmMv_f-oQ7kNvwFaNEwO&_nc_oc=AdnkAaJFbEgVD7B_NPL3OcvEuCog7BddtsAdMh5AFl76L8eeuQdhGn8_osNYpyOztNd5GWZCxBvKIA18bop5Knzw&_nc_zt=24&_nc_ht=scontent-lhr8-1.xx&edm=AP4hL3IEAAAA&_nc_gid=pVTTaE3KoMOJd_38N-pSjQ&oh=00_AfOCn24lVYWh8NVskHcAo_pIlFPf3paM6I9-jQDSXTQ3sw&oe=68714F5F","width":64}],"product":"premium","type":"user","uri":"spotify:user:11130484598"} Jun 11 23:57:01 wohnzimmer volumio[927]: info: Spotify Successfully logged in Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 11 23:57:01 wohnzimmer volumio[927]: info: [1749679021682] CoreMusicLibrary::Adding element Spotify Jun 11 23:57:01 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 11 23:57:01 wohnzimmer volumio[927]: Cannot find translation for source LastFM Jun 11 23:57:01 wohnzimmer volumio[927]: Cannot find translation for source Spotify Jun 11 23:57:02 wohnzimmer volumio[927]: info: camilladsp service started and running in background, instance 1 Jun 11 23:57:02 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:02 wohnzimmer volumio[927]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Jun 11 23:57:02 wohnzimmer volumio[927]: cannot open device 'volumioHw': No such device Jun 11 23:57:02 wohnzimmer volumio[927]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 11 23:57:02 wohnzimmer volumio[927]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Jun 11 23:57:02 wohnzimmer volumio[927]: cannot open device 'volumioHw': No such device Jun 11 23:57:02 wohnzimmer mpd[1800]: Jun 11 23:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 11 23:57:02 wohnzimmer systemd[1]: Started Music Player Daemon. Jun 11 23:57:02 wohnzimmer sudo[1793]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:02 wohnzimmer volumio[927]: info: FusionDsp loaded Jun 11 23:57:02 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 11 23:57:02 wohnzimmer sudo[1835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 11 23:57:02 wohnzimmer volumio[927]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 11 23:57:02 wohnzimmer volumio[927]: info: Adding Signal Path Element [object Object] Jun 11 23:57:02 wohnzimmer volumio[927]: info: Adding fusiondspeq DSP Signal Path Element Jun 11 23:57:02 wohnzimmer sudo[1835]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:02 wohnzimmer volumio[927]: info: FusionDsp - ---- installed callbackRead Jun 11 23:57:02 wohnzimmer volumio[927]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 11 23:57:02 wohnzimmer volumio[927]: error: FusionDsp - WebSocket error: [object Object] Jun 11 23:57:02 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 11 23:57:02 wohnzimmer volumio[927]: info: Discovery: Getting this device information Jun 11 23:57:02 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:02 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:02 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 11 23:57:02 wohnzimmer systemd[1]: Started FusionDsp Daemon. Jun 11 23:57:02 wohnzimmer sudo[1835]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:02 wohnzimmer volumio[927]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 11 23:57:02 wohnzimmer volumio[927]: error: updateQueue error: null Jun 11 23:57:02 wohnzimmer volumio[927]: error: Upnp client error: Error: This socket has been ended by the other party Jun 11 23:57:02 wohnzimmer volumio[1701]: Generating RSA private key, 4096 bit long modulus (2 primes) Jun 11 23:57:02 wohnzimmer volumio[1701]: .++++ Jun 11 23:57:02 wohnzimmer volumio-remote-updater[660]: [2025-06-11 23:57:02] [connect] Successful connection Jun 11 23:57:02 wohnzimmer volumio-remote-updater[660]: [2025-06-11 23:57:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749679022 101 Jun 11 23:57:02 wohnzimmer volumio[927]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 8 Jun 11 23:57:03 wohnzimmer systemd[1]: systemd-fsckd.service: Succeeded. Jun 11 23:57:03 wohnzimmer volumio[927]: info: go-librespot daemon successfully initialized Jun 11 23:57:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:03 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:04 wohnzimmer volumio[927]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not access weather service: missing geographic coordinates. Jun 11 23:57:04 wohnzimmer volumio[927]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:95:19) Jun 11 23:57:04 wohnzimmer volumio[927]: at Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:115:37) Jun 11 23:57:04 wohnzimmer volumio[927]: at /data/plugins/user_interface/now_playing/dist/app/Router.js:47:13 Jun 11 23:57:04 wohnzimmer volumio[927]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Jun 11 23:57:04 wohnzimmer volumio[927]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:149:13) Jun 11 23:57:04 wohnzimmer volumio[927]: at Route.dispatch (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:119:3) Jun 11 23:57:04 wohnzimmer volumio[927]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Jun 11 23:57:04 wohnzimmer volumio[927]: at /data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:284:15 Jun 11 23:57:04 wohnzimmer volumio[927]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:365:14) Jun 11 23:57:04 wohnzimmer volumio[927]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14) Jun 11 23:57:04 wohnzimmer volumio[927]: at Function.process_params (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:421:3) Jun 11 23:57:04 wohnzimmer volumio[927]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:280:10) Jun 11 23:57:04 wohnzimmer volumio[927]: at Function.handle (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:175:3) Jun 11 23:57:04 wohnzimmer volumio[927]: at router (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:47:12) Jun 11 23:57:04 wohnzimmer volumio[927]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Jun 11 23:57:04 wohnzimmer volumio[927]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jun 11 23:57:05 wohnzimmer volumio[927]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Jun 11 23:57:05 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Jun 11 23:57:05 wohnzimmer volumio[927]: info: Listing playlists Jun 11 23:57:05 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetQueue Jun 11 23:57:05 wohnzimmer volumio[927]: info: CoreStateMachine::getQueue Jun 11 23:57:05 wohnzimmer volumio[927]: info: CorePlayQueue::getQueue Jun 11 23:57:05 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetVisibleSources Jun 11 23:57:05 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 11 23:57:05 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:05 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:06 wohnzimmer volumio[927]: info: Initializing connection to go-librespot Websocket Jun 11 23:57:06 wohnzimmer go-librespot[1749]: time="2025-06-11T23:57:06+02:00" level=debug msg="new websocket client" Jun 11 23:57:06 wohnzimmer volumio[927]: info: Connection to go-librespot Websocket established Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 11 23:57:09 wohnzimmer volumio[927]: info: Adding plugin bluetooth to MyMusic Plugins Jun 11 23:57:09 wohnzimmer volumio[927]: info: Adding plugin multiroom to MyMusic Plugins Jun 11 23:57:09 wohnzimmer volumio[927]: info: Adding plugin metavolumio to MyMusic Plugins Jun 11 23:57:09 wohnzimmer volumio[927]: info: Adding plugin cd_controller to MyMusic Plugins Jun 11 23:57:09 wohnzimmer volumio[927]: info: Adding plugin qobuzconnect to MyMusic Plugins Jun 11 23:57:09 wohnzimmer volumio[927]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 11 23:57:09 wohnzimmer volumio[927]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 11 23:57:09 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 11 23:57:10 wohnzimmer volumio[1701]: ............................................................................................................................................................................................................................................................................................................................................................................................++++ Jun 11 23:57:10 wohnzimmer volumio[1701]: e is 65537 (0x010001) Jun 11 23:57:10 wohnzimmer volumio[1701]: writing RSA key Jun 11 23:57:11 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 11 23:57:11 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 11 23:57:11 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:11 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:11 wohnzimmer volumio[927]: info: Starting MyVolumio Remote Streaming Endpoints Jun 11 23:57:11 wohnzimmer volumio[927]: info: MyVolumio login type: Token Jun 11 23:57:11 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 11 23:57:11 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 11 23:57:12 wohnzimmer volumio[927]: info: Starting Streaming Service Transparent Proxy Jun 11 23:57:12 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 11 23:57:12 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 11 23:57:12 wohnzimmer volumio[927]: info: Streaming services startup Jun 11 23:57:12 wohnzimmer volumio[927]: info: Starting Streaming Daemon Jun 11 23:57:12 wohnzimmer sudo[2278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 11 23:57:12 wohnzimmer sudo[2278]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:12 wohnzimmer sudo[2278]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:12 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 11 23:57:12 wohnzimmer volumio[927]: info: Getting Spotify volume Jun 11 23:57:12 wohnzimmer volumio[927]: error: Cannot start Volumio Streaming Daemon Jun 11 23:57:12 wohnzimmer volumio[927]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 11 23:57:12 wohnzimmer volumio[927]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 11 23:57:12 wohnzimmer volumio[927]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jun 11 23:57:12 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:12 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:12 wohnzimmer volumio[927]: error: MyVolumio Custom Token format not valid, refreshing it Jun 11 23:57:13 wohnzimmer volumio[927]: STREAMING PROXY: Starting server on port 3245 Jun 11 23:57:13 wohnzimmer volumio[927]: Node JS runtime: 14 Jun 11 23:57:13 wohnzimmer volumio[927]: info: MyVolumio login type: Token Jun 11 23:57:13 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:13 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:14 wohnzimmer volumio[927]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 11 23:57:14 wohnzimmer systemd[1]: systemd-timedated.service: Succeeded. Jun 11 23:57:15 wohnzimmer volumio[927]: info: MyVolumio token set successfully Jun 11 23:57:15 wohnzimmer volumio[927]: info: MYVOLUMIO: Adding device Jun 11 23:57:15 wohnzimmer volumio[927]: info: MYVOLUMIO: Evaluating Server Jun 11 23:57:16 wohnzimmer volumio[927]: info: MyVolumio Plan changed: premium Jun 11 23:57:16 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jun 11 23:57:16 wohnzimmer volumio[927]: info: Removing browser output: myVolumio user plan is not superstar Jun 11 23:57:16 wohnzimmer volumio[927]: info: Removing audio output: Jun 11 23:57:16 wohnzimmer volumio[927]: info: MYVOLUMIO: Adding device Jun 11 23:57:16 wohnzimmer volumio[927]: info: MYVOLUMIO: Evaluating Server Jun 11 23:57:16 wohnzimmer volumio[927]: info: Remote config written successfully Jun 11 23:57:16 wohnzimmer volumio[927]: info: Starting Tunnel 1 Jun 11 23:57:16 wohnzimmer volumio[927]: info: Starting Tunnel Connection Checker Jun 11 23:57:16 wohnzimmer volumio[927]: info: Completed starting MyVolumio Plugin Jun 11 23:57:16 wohnzimmer volumio[927]: info: MYVolumio Device enabled Jun 11 23:57:16 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jun 11 23:57:16 wohnzimmer volumio[927]: info: MyVolumio status changed Jun 11 23:57:16 wohnzimmer volumio[927]: info: Streaming services startup Jun 11 23:57:16 wohnzimmer volumio[927]: info: Starting Streaming Daemon Jun 11 23:57:16 wohnzimmer volumio[927]: info: Setting Geolocation for MyVolumio to eu7 Jun 11 23:57:16 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:16 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:16 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:16 wohnzimmer sudo[2690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 11 23:57:16 wohnzimmer sudo[2690]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:16 wohnzimmer sudo[2690]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:16 wohnzimmer volumio[927]: error: Cannot start Volumio Streaming Daemon Jun 11 23:57:16 wohnzimmer volumio[927]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 11 23:57:16 wohnzimmer volumio[927]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 11 23:57:16 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jun 11 23:57:16 wohnzimmer volumio[927]: error: [MyVolumio PluginManager] Cache data is invalid! Jun 11 23:57:16 wohnzimmer volumio[927]: info: Setting Geolocation for MyVolumio to eu4 Jun 11 23:57:16 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:16 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:16 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:17 wohnzimmer volumio[927]: info: Successfully Added MyVolumio device Jun 11 23:57:17 wohnzimmer volumio[927]: info: Successfully Added MyVolumio device Jun 11 23:57:17 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jun 11 23:57:17 wohnzimmer volumio[927]: info: [1749679037488] Starting BluetoothController Jun 11 23:57:17 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jun 11 23:57:18 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Jun 11 23:57:18 wohnzimmer sudo[2816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jun 11 23:57:18 wohnzimmer sudo[2816]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:18 wohnzimmer sudo[2816]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:18 wohnzimmer volumio[927]: info: MRS: MultiRoom plugin initialized Jun 11 23:57:18 wohnzimmer volumio[927]: info: MRS: STOPPING SNAPCLIENT Jun 11 23:57:18 wohnzimmer volumio[927]: info: MRS: Snap server stop Jun 11 23:57:18 wohnzimmer sudo[2832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jun 11 23:57:18 wohnzimmer sudo[2832]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:18 wohnzimmer volumio[927]: info: MRS: STOPPING volumioStreaming Jun 11 23:57:18 wohnzimmer sudo[2835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jun 11 23:57:18 wohnzimmer sudo[2832]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:18 wohnzimmer sudo[2835]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:18 wohnzimmer sudo[2838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jun 11 23:57:18 wohnzimmer sudo[2838]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:18 wohnzimmer sudo[2835]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:18 wohnzimmer sudo[2838]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:18 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jun 11 23:57:18 wohnzimmer sudo[2841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jun 11 23:57:18 wohnzimmer sudo[2841]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:18 wohnzimmer sudo[2841]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:18 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jun 11 23:57:18 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Jun 11 23:57:19 wohnzimmer volumio[927]: info: Preparing to generate the ALSA configuration file Jun 11 23:57:19 wohnzimmer volumio[927]: info: Updating MyVolumio device info Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:19 wohnzimmer volumio[927]: info: Updating MyVolumio device info Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jun 11 23:57:19 wohnzimmer volumio[927]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jun 11 23:57:19 wohnzimmer volumio[927]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 11 23:57:19 wohnzimmer volumio[927]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 11 23:57:19 wohnzimmer volumio[927]: info: Reading ALSA contributions from plugins. Jun 11 23:57:19 wohnzimmer volumio[927]: info: MRS: Removed streaming files Jun 11 23:57:19 wohnzimmer volumio[927]: info: MRS: volumioStreaming STOPPED Jun 11 23:57:19 wohnzimmer volumio[927]: info: MRS: SNAPSERVER STOPPED Jun 11 23:57:19 wohnzimmer volumio[927]: info: MRS: SNAPCLIENT STOPPED Jun 11 23:57:19 wohnzimmer volumio[927]: info: Asound.conf file written Jun 11 23:57:19 wohnzimmer sudo[2851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 11 23:57:19 wohnzimmer sudo[2851]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:19 wohnzimmer sudo[2851]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:19 wohnzimmer volumio[927]: info: Output device has changed, restarting MPD Jun 11 23:57:19 wohnzimmer sudo[2856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 11 23:57:19 wohnzimmer sudo[2856]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:19 wohnzimmer volumio[927]: info: Output device has changed, restarting Shairport Sync Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:19 wohnzimmer sudo[2856]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:19 wohnzimmer sudo[2859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 11 23:57:19 wohnzimmer sudo[2859]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:19 wohnzimmer systemd[1]: Stopping Music Player Daemon... Jun 11 23:57:19 wohnzimmer systemd[1]: mpd.service: Succeeded. Jun 11 23:57:19 wohnzimmer systemd[1]: Stopped Music Player Daemon. Jun 11 23:57:19 wohnzimmer volumio[927]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 11 23:57:19 wohnzimmer volumio[927]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:19 wohnzimmer systemd[1]: Starting Music Player Daemon... Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jun 11 23:57:19 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output for this device Jun 11 23:57:19 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:57:19 wohnzimmer sudo[2868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Wohnzimmer Jun 11 23:57:19 wohnzimmer volumio[927]: info: Adding audio output: Jun 11 23:57:19 wohnzimmer sudo[2868]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:19 wohnzimmer sudo[2868]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:19 wohnzimmer sudo[2864]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 11 23:57:19 wohnzimmer sudo[2864]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:19 wohnzimmer volumio[927]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 11 23:57:19 wohnzimmer sudo[2864]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Jun 11 23:57:19 wohnzimmer volumio[927]: info: Adding METAVOLUMIO REST API Endpoints Jun 11 23:57:19 wohnzimmer volumio[927]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jun 11 23:57:19 wohnzimmer volumio[927]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jun 11 23:57:19 wohnzimmer volumio[927]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jun 11 23:57:19 wohnzimmer volumio[927]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Jun 11 23:57:19 wohnzimmer volumio[927]: info: Adding inputs REST Endpoints Jun 11 23:57:19 wohnzimmer volumio[927]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jun 11 23:57:19 wohnzimmer volumio[927]: info: Scanning Audio Inputs Jun 11 23:57:19 wohnzimmer volumio[927]: info: Checking against Known Cards name Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 11 23:57:19 wohnzimmer volumio[927]: info: [1749679039740] CoreMusicLibrary::Adding element HD-Audio Generic Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 11 23:57:19 wohnzimmer volumio[927]: Cannot find translation for source LastFM Jun 11 23:57:19 wohnzimmer volumio[927]: Cannot find translation for source Spotify Jun 11 23:57:19 wohnzimmer volumio[927]: Cannot find translation for source HD-Audio Generic Jun 11 23:57:19 wohnzimmer volumio[927]: info: Checking against Known Cards name Jun 11 23:57:19 wohnzimmer volumio[927]: info: Checking against Known Cards name Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 11 23:57:19 wohnzimmer volumio[927]: info: [1749679039754] CoreMusicLibrary::Adding element USB Audio CODEC Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 11 23:57:19 wohnzimmer volumio[927]: Cannot find translation for source LastFM Jun 11 23:57:19 wohnzimmer volumio[927]: Cannot find translation for source Spotify Jun 11 23:57:19 wohnzimmer volumio[927]: Cannot find translation for source HD-Audio Generic Jun 11 23:57:19 wohnzimmer volumio[927]: Cannot find translation for source USB Audio CODEC Jun 11 23:57:19 wohnzimmer volumio[927]: info: Checking against Known Cards name Jun 11 23:57:19 wohnzimmer volumio[927]: info: Adding Server instance for streaming Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Jun 11 23:57:19 wohnzimmer volumio[927]: error: Hi Res Audio Failed Login: Missing Login Data Jun 11 23:57:19 wohnzimmer volumio[927]: info: Adding HIGHRESAUDIO REST API Endpoints Jun 11 23:57:19 wohnzimmer volumio[927]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Jun 11 23:57:19 wohnzimmer volumio[927]: info: Refreshing TIDAL token Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Jun 11 23:57:19 wohnzimmer volumio[927]: info: Refreshing QOBUZ token Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Jun 11 23:57:19 wohnzimmer volumio[927]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Jun 11 23:57:19 wohnzimmer volumio[927]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Jun 11 23:57:19 wohnzimmer sudo[2878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 11 23:57:19 wohnzimmer sudo[2878]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:19 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:19 wohnzimmer volumio[927]: info: QobuzConnect: Starting Qobuz Connect socket and service Jun 11 23:57:19 wohnzimmer sudo[2878]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:19 wohnzimmer volumio[927]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Jun 11 23:57:19 wohnzimmer sudo[2885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 11 23:57:19 wohnzimmer sudo[2885]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:19 wohnzimmer sudo[2885]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:20 wohnzimmer volumio[927]: info: MRS: Adding multiroomSync output Jun 11 23:57:20 wohnzimmer volumio[927]: info: Adding audio output: Jun 11 23:57:20 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:57:20 wohnzimmer sudo[2887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 11 23:57:20 wohnzimmer sudo[2887]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:20 wohnzimmer volumio[927]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jun 11 23:57:20 wohnzimmer volumio[927]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'Wohnzimmer' Jun 11 23:57:20 wohnzimmer volumio[927]: Can't get device info: No such device Jun 11 23:57:20 wohnzimmer volumio[927]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jun 11 23:57:20 wohnzimmer volumio[927]: info: MPD Permissions set Jun 11 23:57:20 wohnzimmer systemd[1]: Started Volumio Qobuz Connect Service. Jun 11 23:57:20 wohnzimmer sudo[2887]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:20 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:20 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:20 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 11 23:57:20 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:20 wohnzimmer volumio[927]: info: MRS: Found cast device: LenovoCD-24502F-1797cd035674a6bd04799d93772b0005 Jun 11 23:57:20 wohnzimmer volumio[927]: info: Adding audio output: Jun 11 23:57:20 wohnzimmer volumio[927]: info: Access Token successfully retrieved Jun 11 23:57:20 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 11 23:57:20 wohnzimmer volumio[927]: info: [1749679040442] CoreMusicLibrary::Adding element QOBUZ Jun 11 23:57:20 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 11 23:57:20 wohnzimmer volumio[927]: Cannot find translation for source LastFM Jun 11 23:57:20 wohnzimmer volumio[927]: Cannot find translation for source Spotify Jun 11 23:57:20 wohnzimmer volumio[927]: Cannot find translation for source HD-Audio Generic Jun 11 23:57:20 wohnzimmer volumio[927]: Cannot find translation for source USB Audio CODEC Jun 11 23:57:20 wohnzimmer volumio[927]: Cannot find translation for source QOBUZ Jun 11 23:57:20 wohnzimmer volumio[927]: info: Stopping AccessToken refresher cron for QOBUZ Jun 11 23:57:20 wohnzimmer volumio[927]: info: AccessToken refresher cron started for QOBUZ Jun 11 23:57:20 wohnzimmer volumio[927]: info: Adding QOBUZ REST API Endpoints Jun 11 23:57:20 wohnzimmer volumio[927]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Jun 11 23:57:20 wohnzimmer volumio[927]: info: Adding audio output: Jun 11 23:57:20 wohnzimmer volumio[927]: info: Adding audio output: Jun 11 23:57:20 wohnzimmer volumio[927]: info: Adding audio output: Jun 11 23:57:20 wohnzimmer volumio[927]: info: Adding audio output: Jun 11 23:57:20 wohnzimmer volumio[927]: info: Executing endpoint qc_getconfig Jun 11 23:57:20 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 11 23:57:20 wohnzimmer qobuz-connect[2889]: 20250611 23:57:20.679 [2889.2889] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 11 23:57:20 wohnzimmer volumio[927]: info: Starting Shairport Sync Jun 11 23:57:20 wohnzimmer volumio[927]: info: Access Token successfully retrieved Jun 11 23:57:20 wohnzimmer sudo[2914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 11 23:57:20 wohnzimmer sudo[2914]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:20 wohnzimmer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 11 23:57:20 wohnzimmer systemd[1]: shairport-sync.service: Succeeded. Jun 11 23:57:20 wohnzimmer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 11 23:57:20 wohnzimmer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 11 23:57:20 wohnzimmer kernel: usb 3-1.4: new high-speed USB device number 5 using ehci-pci Jun 11 23:57:20 wohnzimmer sudo[2914]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:20 wohnzimmer volumio[927]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 11 23:57:20 wohnzimmer volumio[927]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 11 23:57:20 wohnzimmer qobuz-connect[2889]: 20250611 23:57:20.881 [2889.2889] INFO VolumeManager: [0x56443c9d64f0]: Setting new playback volume: 75 Jun 11 23:57:20 wohnzimmer qobuz-connect[2889]: 20250611 23:57:20.881 [2889.2889] INFO VolumeManager: [0x56443c9d64f0]: Setting new mute state: 0 Jun 11 23:57:20 wohnzimmer qobuz-connect[2889]: 20250611 23:57:20.881 [2889.2889] INFO QobuzConnect: [0x56443c9d7710]: Client initialized! Jun 11 23:57:20 wohnzimmer qobuz-connect[2889]: 20250611 23:57:20.881 [2889.2889] INFO SampleApp: Starting Avahi advertising, name: Wohnzimmer, service name: _qobuz-connect._tcp Jun 11 23:57:20 wohnzimmer qobuz-connect[2889]: 20250611 23:57:20.905 [2889.2889] INFO LocalConfigManager: [0x56443c9d57e0]: Starting Local Configuration server Jun 11 23:57:20 wohnzimmer qobuz-connect[2889]: 20250611 23:57:20.905 [2889.2889] INFO SampleApp: Starting Local configuration server Jun 11 23:57:20 wohnzimmer qobuz-connect[2889]: 20250611 23:57:20.905 [2889.2889] INFO SampleApp: Playback volume changed: 75 Jun 11 23:57:20 wohnzimmer qobuz-connect[2889]: 20250611 23:57:20.906 [2889.2889] INFO SampleApp: Connected to UNIX socket client 0x56443c9bd280 Jun 11 23:57:20 wohnzimmer volumio[927]: info: MRS: Found cast device: Pioneer-SX-S30DAB-92929d1214fa9756f0b255389524de8b Jun 11 23:57:20 wohnzimmer volumio[927]: info: Adding audio output: Jun 11 23:57:20 wohnzimmer kernel: usb 3-1.4: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 6.f2 Jun 11 23:57:20 wohnzimmer kernel: usb 3-1.4: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Jun 11 23:57:20 wohnzimmer kernel: usb 3-1.4: Product: SMSL M300 Jun 11 23:57:20 wohnzimmer kernel: usb 3-1.4: Manufacturer: SMSL Jun 11 23:57:20 wohnzimmer mpd[2872]: Jun 11 23:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 11 23:57:20 wohnzimmer systemd[1]: Started Music Player Daemon. Jun 11 23:57:20 wohnzimmer sudo[2859]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:20 wohnzimmer volumio[927]: info: Successfully Updated MyVolumio device Jun 11 23:57:20 wohnzimmer volumio[927]: [98B blob data] Jun 11 23:57:20 wohnzimmer volumio[927]: info: Shairport-Sync Started Jun 11 23:57:21 wohnzimmer volumio[927]: info: Adding audio output: Jun 11 23:57:21 wohnzimmer volumio[927]: info: Adding audio output: Jun 11 23:57:21 wohnzimmer volumio[927]: error: updateQueue error: null Jun 11 23:57:21 wohnzimmer volumio[927]: info: Successfully Updated MyVolumio device Jun 11 23:57:21 wohnzimmer volumio[927]: info: Successfully retrieved User Session From TIDAL Jun 11 23:57:21 wohnzimmer volumio[927]: info: Successfully retrieved User Subscription From TIDAL Jun 11 23:57:21 wohnzimmer volumio[927]: info: Adding TIDAL to Browse Sources Jun 11 23:57:21 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 11 23:57:21 wohnzimmer volumio[927]: info: [1749679041523] CoreMusicLibrary::Adding element TIDAL Jun 11 23:57:21 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 11 23:57:21 wohnzimmer volumio[927]: Cannot find translation for source LastFM Jun 11 23:57:21 wohnzimmer volumio[927]: Cannot find translation for source Spotify Jun 11 23:57:21 wohnzimmer volumio[927]: Cannot find translation for source HD-Audio Generic Jun 11 23:57:21 wohnzimmer volumio[927]: Cannot find translation for source USB Audio CODEC Jun 11 23:57:21 wohnzimmer volumio[927]: Cannot find translation for source QOBUZ Jun 11 23:57:21 wohnzimmer volumio[927]: Cannot find translation for source TIDAL Jun 11 23:57:21 wohnzimmer sudo[2963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jun 11 23:57:21 wohnzimmer sudo[2963]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:21 wohnzimmer volumio[927]: info: Stopping AccessToken refresher cron Jun 11 23:57:21 wohnzimmer volumio[927]: info: AccessToken refresher cron started Jun 11 23:57:21 wohnzimmer volumio[927]: info: Adding TIDAL REST API Endpoints Jun 11 23:57:21 wohnzimmer volumio[927]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Jun 11 23:57:21 wohnzimmer systemd[1]: Started MyVolumio SSH Tunnel. Jun 11 23:57:21 wohnzimmer sudo[2963]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:21 wohnzimmer autossh[2973]: port set to 0, monitoring disabled Jun 11 23:57:21 wohnzimmer autossh[2973]: starting ssh (count 1) Jun 11 23:57:21 wohnzimmer autossh[2973]: ssh child pid is 2976 Jun 11 23:57:21 wohnzimmer volumio[927]: info: Remote SSH Started Jun 11 23:57:21 wohnzimmer volumiossh-tunnel[2966]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts. Jun 11 23:57:21 wohnzimmer volumio[927]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jun 11 23:57:21 wohnzimmer kernel: usb 3-1.4: 1:3 : unsupported format bits 0x100000000 Jun 11 23:57:21 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:21 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:22 wohnzimmer sudo[3051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jun 11 23:57:22 wohnzimmer sudo[3051]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:22 wohnzimmer systemd[1]: Started Volumio Bluetooth Module. Jun 11 23:57:22 wohnzimmer sudo[3051]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:22 wohnzimmer volumio[927]: info: Volumio BT Module successfully started Jun 11 23:57:22 wohnzimmer sudo[3057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Jun 11 23:57:22 wohnzimmer sudo[3057]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:22 wohnzimmer volumiobt[3053]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Jun 11 23:57:22 wohnzimmer sudo[3057]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:22 wohnzimmer volumio[927]: info: TidalConnect service stoped! Jun 11 23:57:22 wohnzimmer volumio[927]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 11 23:57:22 wohnzimmer volumio[927]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 11 23:57:22 wohnzimmer sudo[3069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 11 23:57:22 wohnzimmer sudo[3069]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:23 wohnzimmer systemd[1]: Started Volumio Tidal Connect Service. Jun 11 23:57:23 wohnzimmer sudo[3069]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:23 wohnzimmer volumio[927]: info: Executing endpoint tc_getconfig Jun 11 23:57:23 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jun 11 23:57:23 wohnzimmer vtcs[3071]: STARTING TidalConnect services, version: 1.5.1-beta1 Jun 11 23:57:23 wohnzimmer vtcs[3071]: STARTED TidalConnect services. Jun 11 23:57:23 wohnzimmer volumio[927]: info: Executing endpoint tc_connect Jun 11 23:57:23 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jun 11 23:57:23 wohnzimmer volumio[927]: info: Connecting to TidalConnect Jun 11 23:57:23 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:57:23 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:57:23 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:23 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:57:23 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:57:23 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:57:23 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:23 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:23 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:23 wohnzimmer volumio[927]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Jun 11 23:57:23 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:57:23 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:57:23 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:23 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:57:23 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:57:23 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:57:23 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:23 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:23 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:23 wohnzimmer volumio[927]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Jun 11 23:57:23 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:23 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:23 wohnzimmer volumio[927]: info: Listing playlists Jun 11 23:57:23 wohnzimmer volumio[927]: info: Listing playlists Jun 11 23:57:23 wohnzimmer sudo[3090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Jun 11 23:57:23 wohnzimmer sudo[3090]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:23 wohnzimmer volumiobt[3053]: pulseaudio: no process found Jun 11 23:57:23 wohnzimmer sudo[3090]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:23 wohnzimmer dbus-daemon[650]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.38' (uid=1000 pid=3094 comm="/usr/bin/pulseaudio --high-priority=true ") Jun 11 23:57:23 wohnzimmer systemd[1]: Starting RealtimeKit Scheduling Policy Service... Jun 11 23:57:24 wohnzimmer volumio[927]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 11 23:57:24 wohnzimmer dbus-daemon[650]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Jun 11 23:57:24 wohnzimmer rtkit-daemon[3095]: Successfully called chroot. Jun 11 23:57:24 wohnzimmer rtkit-daemon[3095]: Successfully dropped privileges. Jun 11 23:57:24 wohnzimmer rtkit-daemon[3095]: Successfully limited resources. Jun 11 23:57:24 wohnzimmer rtkit-daemon[3095]: Running. Jun 11 23:57:24 wohnzimmer systemd[1]: Started RealtimeKit Scheduling Policy Service. Jun 11 23:57:24 wohnzimmer rtkit-daemon[3095]: Canary thread running. Jun 11 23:57:24 wohnzimmer rtkit-daemon[3095]: Watchdog thread running. Jun 11 23:57:24 wohnzimmer dbus-daemon[650]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.39' (uid=0 pid=3095 comm="/usr/lib/rtkit/rtkit-daemon ") Jun 11 23:57:24 wohnzimmer systemd[1]: Starting Authorization Manager... Jun 11 23:57:24 wohnzimmer volumio[927]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 11 23:57:24 wohnzimmer polkitd[3098]: started daemon version 0.105 using authority implementation `local' version `0.105' Jun 11 23:57:24 wohnzimmer dbus-daemon[650]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jun 11 23:57:24 wohnzimmer systemd[1]: Started Authorization Manager. Jun 11 23:57:24 wohnzimmer pulseaudio[3094]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jun 11 23:57:24 wohnzimmer pulseaudio[3094]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jun 11 23:57:24 wohnzimmer pulseaudio[3094]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Jun 11 23:57:24 wohnzimmer volumiobt[3053]: Applying permissions Jun 11 23:57:24 wohnzimmer volumiobt[3053]: Setting BT discoverable and pairable Jun 11 23:57:24 wohnzimmer volumiobt[3053]: Agent registered Jun 11 23:57:24 wohnzimmer volumiobt[3053]: [bluetooth]# -e power on Jun 11 23:57:24 wohnzimmer volumiobt[3053]: Invalid command in menu main: -e Jun 11 23:57:24 wohnzimmer volumiobt[3053]: Jun 11 23:57:24 wohnzimmer volumiobt[3053]: Use "help" for a list of available commands in a menu. Jun 11 23:57:24 wohnzimmer volumiobt[3053]: Use "menu " if you want to enter any submenu. Jun 11 23:57:24 wohnzimmer volumiobt[3053]: Use "back" if you want to return to menu main. Jun 11 23:57:24 wohnzimmer volumiobt[3053]: [bluetooth]# agent on Jun 11 23:57:24 wohnzimmer volumiobt[3053]: Agent is already registered Jun 11 23:57:24 wohnzimmer volumiobt[3053]: [bluetooth]# discoverable on Jun 11 23:57:24 wohnzimmer volumiobt[3053]: No default controller available Jun 11 23:57:24 wohnzimmer volumiobt[3053]: [bluetooth]# pairable on Jun 11 23:57:24 wohnzimmer volumiobt[3053]: No default controller available Jun 11 23:57:24 wohnzimmer volumiobt[3053]: [bluetooth]# agent NoInputNoOutput Jun 11 23:57:24 wohnzimmer volumiobt[3053]: Agent is already registered Jun 11 23:57:24 wohnzimmer volumiobt[3053]: [bluetooth]# default-agent Jun 11 23:57:24 wohnzimmer volumiobt[3053]: [bluetooth]# quit Jun 11 23:57:24 wohnzimmer volumiobt[3053]: [59B blob data] Jun 11 23:57:24 wohnzimmer volumio[927]: info: MRS: Getting audio outputs on start Jun 11 23:57:24 wohnzimmer volumio[927]: info: MRS: Requesting all other devices output Jun 11 23:57:24 wohnzimmer systemd[1]: systemd-hostnamed.service: Succeeded. Jun 11 23:57:26 wohnzimmer volumio[927]: info: TidalConnect service started! Jun 11 23:57:26 wohnzimmer volumio[927]: [Metrics] CommandRouter: 42s 826.33ms Jun 11 23:57:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumiosetStartupVolume Jun 11 23:57:26 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:26 wohnzimmer volumio[927]: info: VolumeController:: Setting startup Volume 100 Jun 11 23:57:26 wohnzimmer volumio[927]: info: VolumeController::SetAlsaVolume100 Jun 11 23:57:26 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:26 wohnzimmer volumio[927]: info: CoreCommandRouter::Close All Modals sent Jun 11 23:57:26 wohnzimmer volumio[927]: info: CoreCommandRouter::Close All Modals sent Jun 11 23:57:26 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:57:26 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:26 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:57:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:57:26 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:57:26 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:57:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:26 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:26 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 11 23:57:26 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:57:26 wohnzimmer volumio[927]: SPOTIFY: SPOTIFY VOLUME undefined Jun 11 23:57:26 wohnzimmer volumio[927]: SPOTIFY: VOLUMIO VOLUME 100 Jun 11 23:57:26 wohnzimmer volumio[927]: info: Aligning Spotify Volume to Volumio Volume Jun 11 23:57:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:26 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:26 wohnzimmer volumio[927]: info: Setting Spotify Volume from Volumio: 100 Jun 11 23:57:26 wohnzimmer volumio[927]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jun 11 23:57:26 wohnzimmer volumio[927]: info: FusionDsp - ---- read samplerate from file: 44100 Jun 11 23:57:26 wohnzimmer volumio[927]: info: camilladsp stopping service pid 3040... Jun 11 23:57:26 wohnzimmer volumio[927]: info: camilladsp service terminated, instance 1 Jun 11 23:57:26 wohnzimmer volumio[927]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 11 23:57:26 wohnzimmer volumio[927]: info: camilladsp service started and running in background, instance 1 Jun 11 23:57:26 wohnzimmer volumio[927]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Jun 11 23:57:26 wohnzimmer volumio[927]: xcb_connection_has_error() returned true Jun 11 23:57:26 wohnzimmer volumio[927]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jun 11 23:57:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:26 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:27 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 11 23:57:27 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 11 23:57:27 wohnzimmer volumio[927]: No protocol specified Jun 11 23:57:27 wohnzimmer volumio[927]: xcb_connection_has_error() returned true Jun 11 23:57:27 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 11 23:57:27 wohnzimmer volumio[927]: info: Version has changed, forcing UI Reload Jun 11 23:57:27 wohnzimmer volumio[927]: info: CoreCommandRouter::Reload Ui Jun 11 23:57:27 wohnzimmer volumio[927]: SPOTIFY: SETTING SPOTIFY VOLUME 100 Jun 11 23:57:27 wohnzimmer volumio[927]: info: Sending Spotify command with payload to local API: /player/volume Jun 11 23:57:28 wohnzimmer sudo[3135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 11 23:57:28 wohnzimmer sudo[3135]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:28 wohnzimmer sudo[3135]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:28 wohnzimmer sudo[3146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 11 23:57:28 wohnzimmer sudo[3146]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 11 23:57:28 wohnzimmer sudo[3146]: pam_unix(sudo:session): session closed for user root Jun 11 23:57:29 wohnzimmer volumio[927]: verbose: New Socket.io Connection to 192.168.1.203 from 192.168.1.159 UA: Mozilla/5.0 (Linux; Android 15; SM-S921B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetVisibleSources Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:29 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 11 23:57:29 wohnzimmer volumio[927]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 11 23:57:29 wohnzimmer volumio[927]: info: Received Get System Info Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 11 23:57:29 wohnzimmer volumio[927]: info: Discovery: Getting this device information Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:29 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:29 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:29 wohnzimmer volumio[927]: info: Listing playlists Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 11 23:57:29 wohnzimmer volumio[927]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 11 23:57:29 wohnzimmer volumio[927]: info: FusionDsp - IP adress is ---------------------------192.168.1.203 Jun 11 23:57:29 wohnzimmer volumio[927]: info: FusionDsp - Jun 11 23:57:29 wohnzimmer volumio[927]: info: FusionDsp - undefined Jun 11 23:57:30 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 11 23:57:30 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 11 23:57:30 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 11 23:57:30 wohnzimmer volumio-remote-updater[660]: No test mode Jun 11 23:57:30 wohnzimmer volumio-remote-updater[660]: No alpha test mode Jun 11 23:57:30 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 11 23:57:30 wohnzimmer volumio[927]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 11 23:57:30 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 11 23:57:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 11 23:57:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 11 23:57:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 11 23:57:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 11 23:57:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetBrowseSources Jun 11 23:57:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 11 23:57:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 11 23:57:31 wohnzimmer volumio[927]: info: Received Get System Info Jun 11 23:57:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 11 23:57:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 11 23:57:31 wohnzimmer volumio[927]: info: Discovery: Getting this device information Jun 11 23:57:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:31 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 11 23:57:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 11 23:57:32 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 11 23:57:32 wohnzimmer volumio[927]: info: Received Get System Info Jun 11 23:57:32 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 11 23:57:32 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 11 23:57:32 wohnzimmer volumio[927]: info: Discovery: Getting this device information Jun 11 23:57:32 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:32 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:32 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 11 23:57:33 wohnzimmer volumio[927]: info: BOOT COMPLETED Jun 11 23:57:33 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:33 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:39 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 11 23:57:43 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:43 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:43 wohnzimmer volumio[927]: info: Listing playlists Jun 11 23:57:43 wohnzimmer volumio[927]: info: Listing playlists Jun 11 23:57:48 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 11 23:57:48 wohnzimmer volumio[927]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 11 23:57:48 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 11 23:57:48 wohnzimmer volumio[927]: info: Received Get System Version Jun 11 23:57:48 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 11 23:57:48 wohnzimmer volumio[927]: info: Received Get System Info Jun 11 23:57:48 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 11 23:57:48 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 11 23:57:48 wohnzimmer volumio[927]: info: Discovery: Getting this device information Jun 11 23:57:48 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:48 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:57:48 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 11 23:57:53 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:57:53 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:58:01 wohnzimmer qobuz-connect[2889]: 20250611 23:58:01.601 [2889.3294] INFO SampleApp: API endpoint invoked: get-display-info Jun 11 23:58:01 wohnzimmer qobuz-connect[2889]: 20250611 23:58:01.617 [2889.3294] INFO SampleApp: API endpoint invoked: get-connect-info Jun 11 23:58:02 wohnzimmer qobuz-connect[2889]: 20250611 23:58:02.421 [2889.3294] INFO SampleApp: API endpoint invoked: connect-to-qconnect Jun 11 23:58:02 wohnzimmer qobuz-connect[2889]: 20250611 23:58:02.421 [2889.2889] INFO EndpointManager: [0x56443c9d50e0]: Updating API endpoint Jun 11 23:58:02 wohnzimmer qobuz-connect[2889]: 20250611 23:58:02.421 [2889.2889] INFO EndpointManager: [0x56443c9d50e0]: Updating QConnect endpoint Jun 11 23:58:02 wohnzimmer qobuz-connect[2889]: 20250611 23:58:02.421 [2889.2889] INFO ActiveStateManager: [0x56443c9d34c0]: Setting new active state: active Jun 11 23:58:02 wohnzimmer qobuz-connect[2889]: 20250611 23:58:02.421 [2889.2889] INFO PlaybackSessionManager: [0x56443c9d5820]: Starting playback session maintenance Jun 11 23:58:02 wohnzimmer qobuz-connect[2889]: 20250611 23:58:02.421 [2889.2889] INFO HttpDownloader: [0x56443c9d5ba0]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start Jun 11 23:58:02 wohnzimmer qobuz-connect[2889]: 20250611 23:58:02.421 [2889.2889] INFO CloudClient: [0x56443c9d6790]: Connecting to the cloud Jun 11 23:58:02 wohnzimmer qobuz-connect[2889]: 20250611 23:58:02.421 [2889.2889] INFO SampleApp: Renderer is now active Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.366 [2889.2889] INFO PlaybackSessionManager: [0x56443c9d5820]: Playback session has been refreshed Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.391 [2889.2889] INFO CloudClient: [0x56443c9d6790]: Connection established Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.391 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Authenticate message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.391 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Subscribe message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.391 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending JoinSession message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.391 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending VolumeChanged message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.391 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending VolumeMuted message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.391 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending MaxAudioQualityChanged message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.392 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Payload message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.428 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Received SetActive message: active Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.428 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Received SetState message: Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.428 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Playing state: Playing Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.428 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Playback position: 1028 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.428 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Queue version: 3.1 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.428 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Current track: TID: 730742, QID: 8, Context UUID: 9f7cf59a-091e-4b0d-addb-cc5c6176deed Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.428 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Next track: TID: 195467217, QID: 9, Context UUID: 9f7cf59a-091e-4b0d-addb-cc5c6176deed Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.428 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Stopping playback, clearing tracks Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.428 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Initiating playback Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO RendererActionAvailabilityManager: [0x56443c9d6900]: Renderer action 'Next' is available Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Received SetLoopMode message: Off Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO PlaybackControlsManager: [0x56443c9d6400]: Setting new loop mode: Off Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Setting current track: 730742, initial offset: 1028ms Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Clearing all streams Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: New stream: 1 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO HttpDownloader: [0x56443cb55f70]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=48aecad8441ec86c77b701f814004c77&request_ts=1749679083&track_id=730742 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO HttpDownloader: [0x56443cb55520]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=730742 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO HttpDownloader: [0x56443cb51da0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=e23aca1d8817974facdd61d596b3f46a&request_ts=1749679083&track_id=730742 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 1]: Running audio stream Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Received SetShuffleMode message: disabled Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO PlaybackControlsManager: [0x56443c9d6400]: Setting new shuffle mode: disabled Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Setting next track: 195467217 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: New stream: 2 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO HttpDownloader: [0x56443cb63b70]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=1224ca90961f7c95b880bc203bd5fa92&request_ts=1749679083&track_id=195467217 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO HttpDownloader: [0x56443cb41e30]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=195467217 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.429 [2889.2889] INFO HttpDownloader: [0x56443cb36e30]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=34075e2ba9c0d7beda20d267917160c8&request_ts=1749679083&track_id=195467217 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.430 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Waiting for current stream to start before starting audio renderer Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.522 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4609519&eid=730742&fmt=6&profile=raw&app_id=174516466&cid=2770419&etsp=1749682683&hmac=TwFLc4SXyMd_i0kTpUc1dBvNAE8 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.527 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 2]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4609519&eid=195467217&fmt=7&profile=raw&app_id=174516466&cid=2770419&etsp=1749682683&hmac=QlGTEoqwmGNi6Y9b7DlCDD5ovP8 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.553 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 2]: stream information have been fetched Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.605 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 2]: Metadata became available: Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.605 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Title: City Song Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.605 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Artist: Gia Margaret Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.605 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Album: Romantic Piano Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.606 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Album art URL: https://static.qobuz.com/images/covers/bb/ha/bxswmazhzhabb_600.jpg Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.652 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 1]: Metadata became available: Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.652 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Title: The Limit To Your Love Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.652 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Artist: Feist Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.652 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Album: The Reminder Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.652 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Album art URL: https://static.qobuz.com/images/covers/70/84/0060249848470_600.jpg Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.660 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 1]: stream information have been fetched Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.660 [2889.2889] INFO UrlAudioSource: [0x56443cb258a0]: Starting URL audio source, initial position: 1028ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=4609519&eid=730742&fmt=6&profile=raw&app_id=174516466&cid=2770419&etsp=1749682683&hmac=TwFLc4SXyMd_i0kTpUc1dBvNAE8 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.660 [2889.2889] INFO ContentFetcher: [0x56443cb22af0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=4609519&eid=730742&fmt=6&profile=raw&app_id=174516466&cid=2770419&etsp=1749682683&hmac=TwFLc4SXyMd_i0kTpUc1dBvNAE8, offset: 0 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.660 [2889.2889] INFO AudioRenderer: [0x56443c9d60f0]: Starting audio renderer, initial playback state: Playing Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.661 [2889.2889] INFO SampleApp: [Stream 1]: New audio stream (starting from 1027ms) Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.661 [2889.2889] INFO SampleApp: [Stream 1]: Stream metadata became available: Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.661 [2889.2889] INFO SampleApp: Title: The Limit To Your Love Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.661 [2889.2889] INFO SampleApp: Artist: Feist Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.661 [2889.2889] INFO SampleApp: Album: The Reminder Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.661 [2889.2889] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/70/84/0060249848470_600.jpg Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:58:03 wohnzimmer volumio[927]: info: QobuzConnect: setActiveState() Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.668 [2889.2889] INFO VolumeManager: [0x56443c9d64f0]: Setting new playback volume: 100 Jun 11 23:58:03 wohnzimmer volumio[927]: info: QobuzConnect: Set Qobuz connect default volume to 100 Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:58:03 wohnzimmer volumio[927]: info: QobuzConnect: Stopping currently active service Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioStop Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreStateMachine::stop Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:03 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:03 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CorePlayQueue::getTrack 0 Jun 11 23:58:03 wohnzimmer volumio[927]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect Jun 11 23:58:03 wohnzimmer volumio[927]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect Jun 11 23:58:03 wohnzimmer volumio[927]: info: QobuzConnect: setActiveState() completed, send playback confirmation Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.728 [2889.2889] INFO SampleApp: Initiating playback, initial state: Playing Jun 11 23:58:03 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:257:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioDsp has buffer size 65536 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:268:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioDsp has buffer size 65536 Jun 11 23:58:03 wohnzimmer volumio[927]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jun 11 23:58:03 wohnzimmer volumio[927]: info: FusionDsp - ---- read samplerate from file: 44100 Jun 11 23:58:03 wohnzimmer volumio[927]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.763 [2889.2889] INFO SampleApp: Playback state changed: Playing Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.766 [2889.2889] INFO StreamingEventReporter: [0x56443c9d71e0]: Reporting streaming started event Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.766 [2889.2889] INFO HttpDownloader: [0x56443c9d7270]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.766 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Need to send state update Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.766 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending StateUpdated message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.767 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Payload message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.767 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending FileAudioQualityChanged message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.767 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Payload message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.767 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending DeviceAudioQualityChanged message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.767 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Payload message Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:03 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:03 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.790 [2889.2889] INFO VolumeManager: [0x56443c9d64f0]: Setting new playback volume: 100 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.791 [2889.2889] INFO VolumeManager: [0x56443c9d64f0]: Setting new mute state: 0 Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.792 [2889.2889] INFO UrlAudioSource: [0x56443cb258a0]: Content info extracted Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.793 [2889.2889] INFO UrlAudioSource: [0x56443cb258a0]: Size: 26815112 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.795 [2889.3303] INFO AudioDecoder: [0x56443cd2d110]: Stream info: Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.796 [2889.3303] INFO AudioDecoder: [0x56443cd2d110]: Total samples: 11509512 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.796 [2889.3303] INFO AudioDecoder: [0x56443cd2d110]: Sample rate: 44100 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.796 [2889.3303] INFO AudioDecoder: [0x56443cd2d110]: Channel count: 2 Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.797 [2889.3303] INFO AudioDecoder: [0x56443cd2d110]: Bits per sample: 16 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.798 [2889.3303] INFO AudioDecoder: [0x56443cd2d110]: Duration: 260986 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.802 [2889.2889] INFO UrlAudioSource: [0x56443cb258a0]: Audio properties have changed Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.802 [2889.2889] INFO UrlAudioSource: [0x56443cb258a0]: Seeking input stream to byte offset: 84295 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.802 [2889.2889] INFO ContentFetcher: [0x56443cb22af0]: Adjusting download offset to: 84295 Jun 11 23:58:03 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:03 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:03 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:03 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.874 [2889.2889] INFO SampleApp: Playback volume changed: 100 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.876 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Volume changed: 100 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.877 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending VolumeChanged message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.892 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Payload message Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.910 [2889.2889] INFO UrlAudioSource: [0x56443cb258a0]: Seeking input stream to byte offset: 72203 Jun 11 23:58:03 wohnzimmer qobuz-connect[2889]: 20250611 23:58:03.911 [2889.2889] INFO ContentFetcher: [0x56443cb22af0]: Adjusting download offset to: 72203 Jun 11 23:58:03 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:03 wohnzimmer volumio[927]: info: QobuzConnect: Volume received from daemon: 100 Jun 11 23:58:03 wohnzimmer volumio[927]: info: VolumeController::SetAlsaVolume100 Jun 11 23:58:04 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:04 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:04 wohnzimmer qobuz-connect[2889]: 20250611 23:58:04.012 [2889.2889] INFO UrlAudioSource: [0x56443cb258a0]: Seeking input stream to byte offset: 69683 Jun 11 23:58:04 wohnzimmer qobuz-connect[2889]: 20250611 23:58:04.012 [2889.2889] INFO ContentFetcher: [0x56443cb22af0]: Adjusting download offset to: 69683 Jun 11 23:58:04 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:04 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:04 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:04 wohnzimmer volumio[927]: info: [LastFM] Current track has sufficient metadata: title (The Limit To Your Love) and artist (Feist) passed on explicitly Jun 11 23:58:04 wohnzimmer volumio[927]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Jun 11 23:58:04 wohnzimmer qobuz-connect[2889]: 20250611 23:58:04.087 [2889.2889] INFO UrlAudioSource: [0x56443cb258a0]: Seeking input stream to byte offset: 54835 Jun 11 23:58:04 wohnzimmer qobuz-connect[2889]: 20250611 23:58:04.087 [2889.2889] INFO ContentFetcher: [0x56443cb22af0]: Adjusting download offset to: 54835 Jun 11 23:58:04 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:04 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:04 wohnzimmer volumio[927]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jun 11 23:58:04 wohnzimmer volumio[927]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Jun 11 23:58:04 wohnzimmer volumio[927]: xcb_connection_has_error() returned true Jun 11 23:58:04 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:04 wohnzimmer volumio[927]: info: Listing playlists Jun 11 23:58:04 wohnzimmer volumio[927]: info: Listing playlists Jun 11 23:58:04 wohnzimmer qobuz-connect[2889]: 20250611 23:58:04.184 [2889.2889] INFO UrlAudioSource: [0x56443cb258a0]: Seeking input stream to byte offset: 70193 Jun 11 23:58:04 wohnzimmer qobuz-connect[2889]: 20250611 23:58:04.184 [2889.2889] INFO ContentFetcher: [0x56443cb22af0]: Adjusting download offset to: 70193 Jun 11 23:58:04 wohnzimmer qobuz-connect[2889]: 20250611 23:58:04.246 [2889.2889] INFO UrlAudioSource: [0x56443cb258a0]: Seeking input stream to byte offset: 69159 Jun 11 23:58:04 wohnzimmer qobuz-connect[2889]: 20250611 23:58:04.246 [2889.2889] INFO ContentFetcher: [0x56443cb22af0]: Adjusting download offset to: 69159 Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.531 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Received SetState message: Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.532 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Playing state: Paused Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.532 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Playback position: Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.532 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Queue version: Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.532 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Current track: Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.532 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Next track: Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.533 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Pausing playback Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.533 [2889.2889] INFO AudioRenderer: [0x56443c9d60f0]: Pausing audio renderer Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.533 [2889.2889] INFO SampleApp: Pausing playback Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.533 [2889.2889] INFO SampleApp: Playback state changed: Paused Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.533 [2889.2889] INFO StreamingEventReporter: [0x56443c9d71e0]: Reporting streaming ended event Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.533 [2889.2889] INFO HttpDownloader: [0x56443c9d7270]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.534 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Need to send state update Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.534 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending StateUpdated message Jun 11 23:58:12 wohnzimmer qobuz-connect[2889]: 20250611 23:58:12.534 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Payload message Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:12 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:12 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:12 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:12 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:12 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:12 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:12 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:12 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:12 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:13 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.641 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Received SetState message: Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.641 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Playing state: Playing Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.641 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Playback position: Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.641 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Queue version: Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.641 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Current track: Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.641 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Next track: Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.641 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Resuming playback Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.641 [2889.2889] INFO AudioRenderer: [0x56443c9d60f0]: Resuming audio renderer Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.641 [2889.2889] INFO SampleApp: Resuming playback Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.642 [2889.2889] INFO SampleApp: Playback state changed: Playing Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.642 [2889.2889] INFO StreamingEventReporter: [0x56443c9d71e0]: Reporting streaming started event Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.642 [2889.2889] INFO HttpDownloader: [0x56443c9d7270]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.642 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Need to send state update Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.642 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending StateUpdated message Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:18 wohnzimmer qobuz-connect[2889]: 20250611 23:58:18.644 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Payload message Jun 11 23:58:18 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:18 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:18 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:18 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:18 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:18 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:18 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:18 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:18 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:18 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:18 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:18 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:18 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:23 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:23 wohnzimmer volumio[927]: info: Listing playlists Jun 11 23:58:23 wohnzimmer volumio[927]: info: Listing playlists Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.291 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Received SetState message: Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.291 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Playing state: Paused Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.291 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Playback position: Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.291 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Queue version: Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.291 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Current track: Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.291 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Next track: Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.291 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Pausing playback Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.291 [2889.2889] INFO AudioRenderer: [0x56443c9d60f0]: Pausing audio renderer Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.291 [2889.2889] INFO SampleApp: Pausing playback Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.291 [2889.2889] INFO SampleApp: Playback state changed: Paused Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.291 [2889.2889] INFO StreamingEventReporter: [0x56443c9d71e0]: Reporting streaming ended event Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.291 [2889.2889] INFO HttpDownloader: [0x56443c9d7270]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.292 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Need to send state update Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.292 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending StateUpdated message Jun 11 23:58:25 wohnzimmer qobuz-connect[2889]: 20250611 23:58:25.292 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Payload message Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:25 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:25 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:25 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:25 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:25 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:25 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:25 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:25 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.539 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Received SetState message: Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.540 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Playing state: Playing Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.540 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Playback position: Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.540 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Queue version: Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.540 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Current track: Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.540 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Next track: Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.540 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Resuming playback Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.540 [2889.2889] INFO AudioRenderer: [0x56443c9d60f0]: Resuming audio renderer Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.540 [2889.2889] INFO SampleApp: Resuming playback Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.541 [2889.2889] INFO SampleApp: Playback state changed: Playing Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.541 [2889.2889] INFO StreamingEventReporter: [0x56443c9d71e0]: Reporting streaming started event Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.541 [2889.2889] INFO HttpDownloader: [0x56443c9d7270]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.541 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Need to send state update Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.542 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending StateUpdated message Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:26 wohnzimmer qobuz-connect[2889]: 20250611 23:58:26.543 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Payload message Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:26 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:26 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:26 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:26 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:26 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:26 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:26 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:26 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:26 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:26 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:26 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:26 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:26 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.303 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Received SetState message: Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.303 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Playing state: Playing Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.303 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Playback position: 0 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.303 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Queue version: 4.1 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.303 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Current track: TID: 8019030, QID: 7, Context UUID: ac23eb8b-b77b-49e5-a654-8c9e698d38da Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.303 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Next track: TID: 730742, QID: 8, Context UUID: ac23eb8b-b77b-49e5-a654-8c9e698d38da Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.303 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Stopping playback, clearing tracks Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.303 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Initiating playback Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.303 [2889.2889] INFO AudioRenderer: [0x56443c9d60f0]: Stopping audio renderer Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.303 [2889.2889] INFO SampleApp: Stopping playback Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.304 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Clearing all streams Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.304 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 1]: Disposing of audio stream Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.304 [2889.2889] INFO ContentFetcher: [0x56443cb22af0]: Canceling download Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.308 [2889.2889] INFO SampleApp: Playback state changed: Stopped Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.308 [2889.2889] INFO StreamingEventReporter: [0x56443c9d71e0]: Reporting streaming ended event Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.308 [2889.2889] INFO HttpDownloader: [0x56443c9d7270]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.308 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Need to send state update Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.308 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending StateUpdated message Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.308 [2889.2889] INFO SampleApp: [Stream 1]: Audio stream has been disposed of Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.308 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Setting current track: 8019030, initial offset: 0ms Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.308 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Clearing all streams Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.308 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: New stream: 3 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.308 [2889.2889] INFO HttpDownloader: [0x56443cb3a8b0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=3fa02542403d4daadcb41c23c84934fb&request_ts=1749679111&track_id=8019030 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.308 [2889.2889] INFO HttpDownloader: [0x56443cb32f40]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=8019030 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.308 [2889.2889] INFO HttpDownloader: [0x56443cb66380]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=75e4901a5bdc361d3d89ead2757a9ccd&request_ts=1749679111&track_id=8019030 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.309 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 3]: Running audio stream Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.309 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Payload message Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.310 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Setting next track: 730742 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.310 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: New stream: 4 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.310 [2889.2889] INFO HttpDownloader: [0x56443cb55f70]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=f4c57d1c907d968464e88044836bd33d&request_ts=1749679111&track_id=730742 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.310 [2889.2889] INFO HttpDownloader: [0x56443cb55520]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=730742 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.310 [2889.2889] INFO HttpDownloader: [0x56443cbe5440]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=2dcd78e4e2a2ebbc2323438dcbe64b2c&request_ts=1749679111&track_id=730742 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.311 [2889.2889] INFO MediaEngine: [0x56443c9d5cf0]: Waiting for current stream to start before starting audio renderer Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.358 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 4]: Metadata became available: Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.358 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Title: The Limit To Your Love Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.358 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Artist: Feist Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.358 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Album: The Reminder Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.358 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Album art URL: https://static.qobuz.com/images/covers/70/84/0060249848470_600.jpg Jun 11 23:58:31 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:31 wohnzimmer volumio[927]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.399 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 4]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4609519&eid=730742&fmt=6&profile=raw&app_id=174516466&cid=2770419&etsp=1749682711&hmac=9MwzzA6LOBpnOpG5J9AZUm7Z_Bs Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.405 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 3]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4609519&eid=8019030&fmt=6&profile=raw&app_id=174516466&cid=2770419&etsp=1749682711&hmac=z8WiNxmeZwlQYKsF4cdnJk-JAJk Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.434 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 3]: stream information have been fetched Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.434 [2889.2889] INFO UrlAudioSource: [0x56443ccc42f0]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=4609519&eid=8019030&fmt=6&profile=raw&app_id=174516466&cid=2770419&etsp=1749682711&hmac=z8WiNxmeZwlQYKsF4cdnJk-JAJk Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.434 [2889.2889] INFO ContentFetcher: [0x56443cc8cd30]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=4609519&eid=8019030&fmt=6&profile=raw&app_id=174516466&cid=2770419&etsp=1749682711&hmac=z8WiNxmeZwlQYKsF4cdnJk-JAJk, offset: 0 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.434 [2889.2889] INFO AudioRenderer: [0x56443c9d60f0]: Starting audio renderer, initial playback state: Playing Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.434 [2889.2889] INFO SampleApp: [Stream 3]: New audio stream (starting from 0ms) Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer volumio[927]: info: QobuzConnect: alread currrent service, send playback confirmation Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.484 [2889.2889] INFO SampleApp: Initiating playback, initial state: Playing Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:257:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioDsp has buffer size 65536 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:268:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioDsp has buffer size 65536 Jun 11 23:58:31 wohnzimmer volumio[927]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jun 11 23:58:31 wohnzimmer volumio[927]: info: FusionDsp - ---- read samplerate from file: 44100 Jun 11 23:58:31 wohnzimmer volumio[927]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.505 [2889.2889] INFO SampleApp: Playback state changed: Playing Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.506 [2889.2889] INFO StreamingEventReporter: [0x56443c9d71e0]: Reporting streaming started event Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.506 [2889.2889] INFO ProtocolHandler: [0x56443c9d6a40]: Need to send state update Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.507 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending StateUpdated message Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.507 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Payload message Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.507 [2889.2889] INFO QConnectMessageSender: [0x56443cbe92f0]: Sending FileAudioQualityChanged message Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.507 [2889.2889] INFO QwspMessageSender: [0x56443cb82330]: Sending Payload message Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.508 [2889.2889] INFO HttpDownloader: [0x56443c9d7270]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.509 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 3]: Metadata became available: Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.509 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Title: Youth Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.509 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Artist: Daughter Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.509 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Album: If You Leave Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.509 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: Album art URL: https://static.qobuz.com/images/covers/68/01/0652637330168_600.jpg Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.509 [2889.2889] INFO AudioStreamManager: [0x56443c9d5e90]: [Stream 4]: stream information have been fetched Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.509 [2889.2889] INFO SampleApp: [Stream 3]: Stream metadata became available: Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.510 [2889.2889] INFO SampleApp: Title: Youth Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.511 [2889.2889] INFO SampleApp: Artist: Daughter Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.511 [2889.2889] INFO SampleApp: Album: If You Leave Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.511 [2889.2889] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/68/01/0652637330168_600.jpg Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.612 [2889.2889] INFO UrlAudioSource: [0x56443ccc42f0]: Content info extracted Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.612 [2889.2889] INFO UrlAudioSource: [0x56443ccc42f0]: Size: 22480944 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.612 [2889.3392] INFO AudioDecoder: [0x56443ccf7a10]: Stream info: Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.612 [2889.3392] INFO AudioDecoder: [0x56443ccf7a10]: Total samples: 11157888 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.612 [2889.3392] INFO AudioDecoder: [0x56443ccf7a10]: Sample rate: 44100 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.613 [2889.3392] INFO AudioDecoder: [0x56443ccf7a10]: Channel count: 2 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.613 [2889.3392] INFO AudioDecoder: [0x56443ccf7a10]: Bits per sample: 16 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.613 [2889.3392] INFO AudioDecoder: [0x56443ccf7a10]: Duration: 253013 Jun 11 23:58:31 wohnzimmer qobuz-connect[2889]: 20250611 23:58:31.613 [2889.2889] INFO UrlAudioSource: [0x56443ccc42f0]: Audio properties have changed Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::servicePushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreStateMachine::pushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioPushState Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output update for this device Jun 11 23:58:31 wohnzimmer volumio[927]: info: MRS: Pushing multiroomSync output Jun 11 23:58:31 wohnzimmer volumio[927]: info: CoreCommandRouter::volumioGetState Jun 11 23:58:31 wohnzimmer volumio[927]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Jun 11 23:58:31 wohnzimmer volumio[927]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 11 23:58:31 wohnzimmer volumio[927]: TypeError: Cannot read property 'indexOf' of undefined Jun 11 23:58:31 wohnzimmer volumio[927]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) Jun 11 23:58:31 wohnzimmer volumio[927]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) Jun 11 23:58:31 wohnzimmer volumio[927]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) Jun 11 23:58:31 wohnzimmer volumio[927]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 11 23:58:31 wohnzimmer volumio[927]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) Jun 11 23:58:31 wohnzimmer volumio[927]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) Jun 11 23:58:31 wohnzimmer volumio[927]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 11 23:58:31 wohnzimmer volumio[927]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 11 23:58:31 wohnzimmer volumio[927]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) Jun 11 23:58:31 wohnzimmer volumio[927]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 11 23:58:31 wohnzimmer volumio[927]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Jun 11 23:58:31 wohnzimmer volumio[927]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) Jun 11 23:58:31 wohnzimmer volumio[927]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) Jun 11 23:58:31 wohnzimmer volumio[927]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 11 23:58:31 wohnzimmer volumio[927]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 11 23:58:31 wohnzimmer volumio[927]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) Jun 11 23:58:31 wohnzimmer volumio[927]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 11 23:58:32 wohnzimmer sudo[3403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-11 23:57 Jun 11 23:58:32 wohnzimmer sudo[3403]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"