-- Logs begin at Wed 2024-04-10 22:20:31 CEST, end at Wed 2024-04-10 22:22:12 CEST. -- Apr 10 22:21:07 volumio ntpd[4796]: receive: Unexpected origin timestamp 0xe9c17323.b648718f does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xe9c17333.c46c276c Apr 10 22:21:07 volumio ntpd[4796]: receive: Unexpected origin timestamp 0xe9c17323.b65079d0 does not match aorg 0000000000.00000000 from server@185.51.192.63 xmt 0xe9c17333.c4b24a70 Apr 10 22:21:07 volumio ntpd[4796]: receive: Unexpected origin timestamp 0xe9c17323.b651e927 does not match aorg 0000000000.00000000 from server@23.94.217.117 xmt 0xe9c17333.c4ac91bc Apr 10 22:21:07 volumio ntpd[4796]: receive: Unexpected origin timestamp 0xe9c17323.b64ece34 does not match aorg 0000000000.00000000 from server@193.123.56.220 xmt 0xe9c17333.c5290c7c Apr 10 22:21:07 volumio ntpd[4796]: receive: Unexpected origin timestamp 0xe9c17323.b6575c1e does not match aorg 0000000000.00000000 from server@158.101.213.248 xmt 0xe9c17333.c5048f88 Apr 10 22:21:07 volumio ntpd[4796]: receive: Unexpected origin timestamp 0xe9c17323.b655eb6d does not match aorg 0000000000.00000000 from server@158.101.216.150 xmt 0xe9c17333.c58a06ba Apr 10 22:21:07 volumio ntpd[4796]: receive: Unexpected origin timestamp 0xe9c17323.b6548864 does not match aorg 0000000000.00000000 from server@213.109.127.82 xmt 0xe9c17333.c59338aa Apr 10 22:21:08 volumio volumio[4324]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=odroidc4&variante=volumio&version=3.629&uuid=b7286f18c981347c62b6c25db31ec89d" http://updates.volumio.org/downloader-v1/track-device Apr 10 22:21:08 volumio volumio[4324]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 10 22:21:08 volumio volumio[4324]: Dload Upload Total Spent Left Speed Apr 10 22:21:08 volumio volumio[4324]: [132B blob data] Apr 10 22:21:08 volumio volumio[4324]: retrying in 5 seconds, trial 0 Apr 10 22:21:08 volumio volumio[4324]: info: Volumio Calling Home Apr 10 22:21:08 volumio volumio[4324]: info: Volumio called home Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 10 22:21:08 volumio volumio[4324]: info: Adding plugin bluetooth to MyMusic Plugins Apr 10 22:21:08 volumio volumio[4324]: info: Adding plugin multiroom to MyMusic Plugins Apr 10 22:21:08 volumio volumio[4324]: info: Adding plugin metavolumio to MyMusic Plugins Apr 10 22:21:08 volumio volumio[4324]: info: Adding plugin cd_controller to MyMusic Plugins Apr 10 22:21:08 volumio volumio[4324]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 10 22:21:08 volumio volumio[4324]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 10 22:21:08 volumio volumio[4324]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 10 22:21:09 volumio volumio[4324]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 10 22:21:09 volumio volumio[4324]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 10 22:21:09 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:09 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:09 volumio volumio[4324]: info: Starting MyVolumio Remote Streaming Endpoints Apr 10 22:21:09 volumio volumio[4324]: info: MyVolumio login type: Token Apr 10 22:21:09 volumio volumio[4324]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 10 22:21:09 volumio volumio[4324]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 10 22:21:10 volumio volumio[4324]: info: Starting Streaming Service Transparent Proxy Apr 10 22:21:10 volumio volumio[4324]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 10 22:21:10 volumio volumio[4324]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 10 22:21:10 volumio volumio[4324]: info: Streaming services startup Apr 10 22:21:10 volumio volumio[4324]: info: Starting Streaming Daemon Apr 10 22:21:10 volumio sudo[4986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 10 22:21:10 volumio sudo[4986]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:10 volumio sudo[4986]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:10 volumio volumio[4324]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 10 22:21:10 volumio volumio[4324]: error: Cannot start Volumio Streaming Daemon Apr 10 22:21:10 volumio volumio[4324]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 10 22:21:10 volumio volumio[4324]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 10 22:21:11 volumio volumio[4324]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 10 22:21:11 volumio volumio[4324]: STREAMING PROXY: Starting server on port 3245 Apr 10 22:21:11 volumio volumio[4324]: Node JS runtime: 14 Apr 10 22:21:11 volumio volumio[4324]: info: MyVolumio token set successfully Apr 10 22:21:11 volumio volumio[4324]: info: MYVOLUMIO: Adding device Apr 10 22:21:11 volumio volumio[4324]: info: MYVOLUMIO: Evaluating Server Apr 10 22:21:12 volumio volumio[4324]: info: MyVolumio Plan changed: premium Apr 10 22:21:12 volumio volumio[4324]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Apr 10 22:21:12 volumio volumio[4324]: info: Removing browser output: myVolumio user plan is not superstar Apr 10 22:21:12 volumio volumio[4324]: info: Removing audio output: Apr 10 22:21:12 volumio volumio[4324]: info: MYVOLUMIO: Adding device Apr 10 22:21:12 volumio volumio[4324]: info: MYVOLUMIO: Evaluating Server Apr 10 22:21:12 volumio volumio[4324]: info: Remote config written successfully Apr 10 22:21:12 volumio volumio[4324]: info: Starting Tunnel 1 Apr 10 22:21:12 volumio volumio[4324]: info: Starting Tunnel Connection Checker Apr 10 22:21:12 volumio volumio[4324]: info: Completed starting MyVolumio Plugin Apr 10 22:21:12 volumio volumio[4324]: info: MYVolumio Device enabled Apr 10 22:21:12 volumio volumio[4324]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Apr 10 22:21:12 volumio volumio[4324]: info: MyVolumio status changed Apr 10 22:21:12 volumio volumio[4324]: info: Streaming services startup Apr 10 22:21:12 volumio volumio[4324]: info: Starting Streaming Daemon Apr 10 22:21:12 volumio sudo[5043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 10 22:21:12 volumio sudo[5043]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:12 volumio volumio[4324]: info: Setting Geolocation for MyVolumio to eu2 Apr 10 22:21:12 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:12 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:12 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:12 volumio sudo[5043]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:12 volumio volumio[4324]: error: Cannot start Volumio Streaming Daemon Apr 10 22:21:12 volumio volumio[4324]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 10 22:21:12 volumio volumio[4324]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 10 22:21:12 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Apr 10 22:21:12 volumio volumio[4324]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Apr 10 22:21:12 volumio volumio[4324]: info: [1712780472669] Starting BluetoothController Apr 10 22:21:12 volumio volumio[4324]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Apr 10 22:21:13 volumio volumio[4928]: ..................................................................................................................................................++++ Apr 10 22:21:13 volumio volumio[4928]: e is 65537 (0x010001) Apr 10 22:21:13 volumio volumio[4928]: writing RSA key Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Apr 10 22:21:14 volumio sudo[5062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Apr 10 22:21:14 volumio sudo[5062]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:14 volumio sudo[5062]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:14 volumio volumio[4324]: info: MRS: MultiRoom plugin initialized Apr 10 22:21:14 volumio volumio[4324]: info: MRS: STOPPING SNAPCLIENT Apr 10 22:21:14 volumio volumio[4324]: info: MRS: Snap server stop Apr 10 22:21:14 volumio sudo[5078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Apr 10 22:21:14 volumio sudo[5078]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:14 volumio volumio[4324]: info: MRS: STOPPING volumioStreaming Apr 10 22:21:14 volumio sudo[5080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Apr 10 22:21:14 volumio sudo[5080]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:14 volumio sudo[5078]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Apr 10 22:21:14 volumio sudo[5084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Apr 10 22:21:14 volumio sudo[5084]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:14 volumio sudo[5080]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:14 volumio sudo[5086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Apr 10 22:21:14 volumio sudo[5086]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:14 volumio sudo[5086]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:14 volumio sudo[5084]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Apr 10 22:21:14 volumio volumio[4324]: info: Preparing to generate the ALSA configuration file Apr 10 22:21:14 volumio volumio[4324]: info: Updating MyVolumio device info Apr 10 22:21:14 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:14 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:14 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:14 volumio volumio[4324]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 10 22:21:14 volumio volumio[4324]: info: Reading ALSA contributions from plugins. Apr 10 22:21:14 volumio volumio[4324]: info: Setting Geolocation for MyVolumio to eu2 Apr 10 22:21:14 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:14 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:14 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:14 volumio volumio[4324]: info: MRS: Removed streaming files Apr 10 22:21:14 volumio volumio[4324]: info: MRS: volumioStreaming STOPPED Apr 10 22:21:14 volumio volumio[4324]: info: MRS: SNAPSERVER STOPPED Apr 10 22:21:14 volumio volumio[4324]: info: MRS: SNAPCLIENT STOPPED Apr 10 22:21:14 volumio volumio[4324]: info: Asound.conf file written Apr 10 22:21:14 volumio sudo[5090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 10 22:21:14 volumio sudo[5090]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:14 volumio sudo[5090]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:14 volumio kernel: out of value, fixed it Apr 10 22:21:14 volumio kernel: id=0 set inskew=0 Apr 10 22:21:14 volumio volumio[4324]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Apr 10 22:21:14 volumio volumio[4324]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Apr 10 22:21:14 volumio volumio[4324]: info: Output device has changed, restarting MPD Apr 10 22:21:14 volumio sudo[5095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 10 22:21:14 volumio sudo[5095]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:14 volumio volumio[4324]: info: Output device has changed, restarting Shairport Sync Apr 10 22:21:14 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:14 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:14 volumio sudo[5095]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:14 volumio sudo[5097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 10 22:21:14 volumio sudo[5097]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:14 volumio systemd[1]: Stopping Music Player Daemon... Apr 10 22:21:14 volumio volumio[4324]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 10 22:21:14 volumio volumio[4324]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 10 22:21:14 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Apr 10 22:21:14 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Apr 10 22:21:14 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Apr 10 22:21:14 volumio volumio[4324]: info: MRS: Pushing multiroomSync output for this device Apr 10 22:21:14 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:14 volumio volumio[4324]: info: Adding audio output: Apr 10 22:21:14 volumio volumio[4324]: info: Adding audio output: Apr 10 22:21:14 volumio kernel: aml_spdif_open Apr 10 22:21:14 volumio kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Apr 10 22:21:14 volumio kernel: spdif_a keep clk continuous Apr 10 22:21:14 volumio kernel: aml_spdif_close Apr 10 22:21:14 volumio kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Apr 10 22:21:14 volumio sudo[5109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio Apr 10 22:21:14 volumio sudo[5109]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:14 volumio volumio[4324]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 10 22:21:14 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Apr 10 22:21:14 volumio volumio[4324]: info: Adding METAVOLUMIO REST API Endpoints Apr 10 22:21:14 volumio volumio[4324]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Apr 10 22:21:14 volumio volumio[4324]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Apr 10 22:21:14 volumio volumio[4324]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Apr 10 22:21:14 volumio volumio[4324]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Apr 10 22:21:14 volumio volumio[4324]: info: Adding Manifest REST API Endpoints Apr 10 22:21:14 volumio volumio[4324]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Apr 10 22:21:14 volumio volumio[4324]: info: Preparing CD Folders Apr 10 22:21:14 volumio volumio[4324]: info: Adding CD REST API Endpoints Apr 10 22:21:14 volumio volumio[4324]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Apr 10 22:21:14 volumio volumio[4324]: info: Starting UDEV Watcher for CD Apr 10 22:21:14 volumio volumio[4324]: info: Detecting CD presence with UDEV Apr 10 22:21:14 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Apr 10 22:21:14 volumio kernel: Bluetooth: Core ver 2.22 Apr 10 22:21:14 volumio kernel: Bluetooth: Starting self testing Apr 10 22:21:14 volumio systemd[1]: mpd.service: Succeeded. Apr 10 22:21:14 volumio systemd[1]: Stopped Music Player Daemon. Apr 10 22:21:14 volumio kernel: aml_spdif_open Apr 10 22:21:14 volumio kernel: Bluetooth: ECDH test passed in 12366 usecs Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Apr 10 22:21:14 volumio volumio[4324]: info: Adding inputs REST Endpoints Apr 10 22:21:14 volumio volumio[4324]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Apr 10 22:21:14 volumio systemd[1]: Starting Music Player Daemon... Apr 10 22:21:14 volumio volumio[4324]: info: Scanning Audio Inputs Apr 10 22:21:14 volumio kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Apr 10 22:21:14 volumio kernel: spdif_a keep clk continuous Apr 10 22:21:14 volumio kernel: aml_spdif_close Apr 10 22:21:14 volumio kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Apr 10 22:21:14 volumio kernel: Bluetooth: SMP test passed in 29 usecs Apr 10 22:21:14 volumio kernel: Bluetooth: Finished self testing Apr 10 22:21:14 volumio kernel: NET: Registered protocol family 31 Apr 10 22:21:14 volumio kernel: Bluetooth: HCI device and connection manager initialized Apr 10 22:21:14 volumio kernel: Bluetooth: HCI socket layer initialized Apr 10 22:21:14 volumio kernel: Bluetooth: L2CAP socket layer initialized Apr 10 22:21:14 volumio kernel: Bluetooth: SCO socket layer initialized Apr 10 22:21:14 volumio sudo[5109]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:14 volumio volumio[4324]: info: Checking against Known Cards name Apr 10 22:21:14 volumio volumio[4324]: info: Adding Server instance for streaming Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Apr 10 22:21:14 volumio volumio[4324]: error: Hi Res Audio Failed Login: Missing Login Data Apr 10 22:21:14 volumio volumio[4324]: info: Adding HIGHRESAUDIO REST API Endpoints Apr 10 22:21:14 volumio volumio[4324]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Apr 10 22:21:14 volumio volumio[4324]: info: Refreshing QOBUZ token Apr 10 22:21:14 volumio volumio[4324]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Apr 10 22:21:14 volumio sudo[5144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 10 22:21:14 volumio sudo[5144]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:14 volumio volumio[4324]: info: Stopping AccessToken refresher cron Apr 10 22:21:15 volumio sudo[5144]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:15 volumio volumio[4324]: info: AccessToken refresher cron started Apr 10 22:21:15 volumio volumio[4324]: info: Adding TIDAL REST API Endpoints Apr 10 22:21:15 volumio volumio[4324]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Apr 10 22:21:15 volumio volumio[4324]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'Volumio' Apr 10 22:21:15 volumio volumio[4324]: Can't get device info: No such device Apr 10 22:21:15 volumio volumio[4324]: info: MPD Permissions set Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: Starting Shairport Sync Apr 10 22:21:15 volumio sudo[5158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 10 22:21:15 volumio sudo[5158]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:15 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 10 22:21:15 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 10 22:21:15 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 10 22:21:15 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 10 22:21:15 volumio sudo[5158]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:15 volumio volumio[4324]: info: Shairport-Sync Started Apr 10 22:21:15 volumio volumio[4324]: info: MRS: Found cast device: KPN-DIW7022-d304f4263a67055e44cabeac9b22f928 Apr 10 22:21:15 volumio volumio[4324]: info: Adding audio output: Apr 10 22:21:15 volumio volumio[4324]: info: MRS: Found cast device: Google-Nest-Mini-6602258fc181f609c35a060e129a8f51 Apr 10 22:21:15 volumio volumio[4324]: info: Adding audio output: Apr 10 22:21:15 volumio volumio[4324]: info: MRS: Found cast device: Nest-Audio-7f53efb3235d7a4e80f95a7ee2fe537c Apr 10 22:21:15 volumio volumio[4324]: info: Adding audio output: Apr 10 22:21:15 volumio volumio[4324]: info: Successfully Added MyVolumio device Apr 10 22:21:15 volumio volumio[4324]: info: Successfully Added MyVolumio device Apr 10 22:21:15 volumio volumio[4324]: info: Access Token successfully retrieved Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 10 22:21:15 volumio volumio[4324]: info: [1712780475369] CoreMusicLibrary::Adding element QOBUZ Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 10 22:21:15 volumio volumio[4324]: Cannot find translation for source QOBUZ Apr 10 22:21:15 volumio volumio[4324]: info: Stopping AccessToken refresher cron for QOBUZ Apr 10 22:21:15 volumio volumio[4324]: info: AccessToken refresher cron started for QOBUZ Apr 10 22:21:15 volumio volumio[4324]: info: Adding QOBUZ REST API Endpoints Apr 10 22:21:15 volumio volumio[4324]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Apr 10 22:21:15 volumio volumio[4324]: info: Successfully Updated MyVolumio device Apr 10 22:21:15 volumio volumio[4324]: info: Updating MyVolumio device info Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 10 22:21:15 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 10 22:21:15 volumio volumio[4324]: info: Successfully Updated MyVolumio device Apr 10 22:21:16 volumio mpd[5118]: Apr 10 22:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 10 22:21:16 volumio systemd[1]: Started Music Player Daemon. Apr 10 22:21:16 volumio sudo[5097]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:16 volumio volumio[4324]: error: updateQueue error: null Apr 10 22:21:17 volumio sudo[5210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 10 22:21:17 volumio sudo[5210]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:17 volumio systemd[1]: Started MyVolumio SSH Tunnel. Apr 10 22:21:17 volumio sudo[5210]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:17 volumio volumio[4324]: info: Remote SSH Started Apr 10 22:21:17 volumio autossh[5225]: port set to 0, monitoring disabled Apr 10 22:21:17 volumio autossh[5225]: starting ssh (count 1) Apr 10 22:21:17 volumio autossh[5225]: ssh child pid is 5237 Apr 10 22:21:17 volumio volumio[4324]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 10 Apr 10 22:21:17 volumio volumiossh-tunnel[5212]: Warning: Permanently added '[eu2.myvolumio.org]:2222,[185.14.187.123]:2222' (RSA) to the list of known hosts. Apr 10 22:21:17 volumio volumio[4324]: info: CoreCommandRouter::volumioGetState Apr 10 22:21:17 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:17 volumio sudo[5241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Apr 10 22:21:17 volumio sudo[5241]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:17 volumio systemd[1]: Started Volumio Bluetooth Module. Apr 10 22:21:17 volumio sudo[5241]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:17 volumio sudo[5258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Apr 10 22:21:17 volumio sudo[5258]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:17 volumio volumiobt[5243]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Apr 10 22:21:17 volumio volumio[4324]: info: Volumio BT Module successfully started Apr 10 22:21:17 volumio sudo[5258]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:18 volumio volumio[4324]: info: TidalConnect service stoped! Apr 10 22:21:18 volumio volumio[4324]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 10 22:21:18 volumio volumio[4324]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 10 22:21:18 volumio sudo[5278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 10 22:21:18 volumio sudo[5278]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:18 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 10 22:21:18 volumio sudo[5278]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:18 volumio volumio[4324]: info: Executing endpoint tc_getconfig Apr 10 22:21:18 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 10 22:21:18 volumio vtcs[5280]: STARTING TidalConnect services, version: 1.3.0.19 Apr 10 22:21:18 volumio vtcs[5280]: STARTED TidalConnect services. Apr 10 22:21:18 volumio volumio[4324]: info: Executing endpoint tc_connect Apr 10 22:21:18 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 10 22:21:18 volumio volumio[4324]: info: Connecting to TidalConnect Apr 10 22:21:18 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:18 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:18 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:18 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:18 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:18 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:18 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:18 volumio volumio[4324]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 10 22:21:18 volumio volumio[4324]: verbose: CURRENT POSITION 0 Apr 10 22:21:18 volumio volumio[4324]: info: CoreStateMachine::syncState stateService stop Apr 10 22:21:18 volumio volumio[4324]: info: CoreStateMachine::syncState currentStatus stop Apr 10 22:21:18 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:18 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:18 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:18 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:18 volumio systemd[1]: systemd-fsckd.service: Succeeded. Apr 10 22:21:18 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:18 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:18 volumio volumio[4324]: info: No code Apr 10 22:21:18 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:18 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:18 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:18 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:18 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:18 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:18 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:18 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:18 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:18 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:18 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:18 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:18 volumio volumio[4324]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 10 22:21:18 volumio volumio[4324]: verbose: CURRENT POSITION 0 Apr 10 22:21:18 volumio volumio[4324]: info: CoreStateMachine::syncState stateService stop Apr 10 22:21:18 volumio volumio[4324]: info: CoreStateMachine::syncState currentStatus stop Apr 10 22:21:18 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:18 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:18 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:18 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:18 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:18 volumio volumio[4324]: info: No code Apr 10 22:21:18 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:18 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:18 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:18 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:18 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:18 volumio sudo[5320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Apr 10 22:21:18 volumio sudo[5320]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:18 volumio volumiobt[5243]: pulseaudio: no process found Apr 10 22:21:18 volumio sudo[5320]: pam_unix(sudo:session): session closed for user root Apr 10 22:21:18 volumio dbus-daemon[3604]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.19' (uid=1000 pid=5325 comm="/usr/bin/pulseaudio --high-priority=true " label="kernel") Apr 10 22:21:18 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service... Apr 10 22:21:18 volumio volumio[4324]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 10 22:21:18 volumio dbus-daemon[3604]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Apr 10 22:21:18 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service. Apr 10 22:21:18 volumio rtkit-daemon[5326]: Successfully called chroot. Apr 10 22:21:18 volumio rtkit-daemon[5326]: Successfully dropped privileges. Apr 10 22:21:18 volumio rtkit-daemon[5326]: Successfully limited resources. Apr 10 22:21:18 volumio rtkit-daemon[5326]: Running. Apr 10 22:21:18 volumio rtkit-daemon[5326]: Canary thread running. Apr 10 22:21:18 volumio rtkit-daemon[5326]: Watchdog thread running. Apr 10 22:21:18 volumio dbus-daemon[3604]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.20' (uid=0 pid=5326 comm="/usr/lib/rtkit/rtkit-daemon " label="kernel") Apr 10 22:21:19 volumio systemd[1]: Starting Authorization Manager... Apr 10 22:21:19 volumio volumio[4324]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 10 22:21:19 volumio polkitd[5348]: started daemon version 0.105 using authority implementation `local' version `0.105' Apr 10 22:21:19 volumio dbus-daemon[3604]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 10 22:21:19 volumio systemd[1]: Started Authorization Manager. Apr 10 22:21:19 volumio dbus-daemon[3604]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.40' (uid=1000 pid=5325 comm="/usr/bin/pulseaudio --high-priority=true " label="kernel") Apr 10 22:21:19 volumio systemd[1]: Starting Bluetooth service... Apr 10 22:21:19 volumio volumio[4324]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 10 22:21:19 volumio pulseaudio[5325]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 10 22:21:19 volumio pulseaudio[5325]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 10 22:21:19 volumio volumiobt[5243]: Applying permissions Apr 10 22:21:19 volumio volumiobt[5243]: Setting BT discoverable and pairable Apr 10 22:21:19 volumio bluetoothd[5372]: Bluetooth daemon 5.50 Apr 10 22:21:19 volumio bluetoothd[5372]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Apr 10 22:21:19 volumio dbus-daemon[3604]: [system] Successfully activated service 'org.bluez' Apr 10 22:21:19 volumio systemd[1]: Started Bluetooth service. Apr 10 22:21:19 volumio bluetoothd[5372]: Starting SDP server Apr 10 22:21:19 volumio bluetoothd[5372]: Excluding (cli) sap Apr 10 22:21:19 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Apr 10 22:21:19 volumio kernel: Bluetooth: BNEP filters: protocol multicast Apr 10 22:21:19 volumio kernel: Bluetooth: BNEP socket layer initialized Apr 10 22:21:19 volumio dbus-daemon[3604]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.41' (uid=0 pid=5372 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap " label="kernel") Apr 10 22:21:19 volumio bluetoothd[5372]: Bluetooth management interface 1.14 initialized Apr 10 22:21:19 volumio volumiobt[5243]: [bluetooth]# -e power on Apr 10 22:21:19 volumio volumiobt[5243]: Invalid command in menu main: -e Apr 10 22:21:19 volumio volumiobt[5243]: Apr 10 22:21:19 volumio volumiobt[5243]: Use "help" for a list of available commands in a menu. Apr 10 22:21:19 volumio volumiobt[5243]: Use "menu " if you want to enter any submenu. Apr 10 22:21:19 volumio volumiobt[5243]: Use "back" if you want to return to menu main. Apr 10 22:21:19 volumio volumiobt[5243]: [bluetooth]# agent on Apr 10 22:21:19 volumio volumiobt[5243]: Failed to register agent object Apr 10 22:21:19 volumio volumiobt[5243]: [bluetooth]# discoverable on Apr 10 22:21:19 volumio volumiobt[5243]: No default controller available Apr 10 22:21:19 volumio volumiobt[5243]: [bluetooth]# pairable on Apr 10 22:21:19 volumio volumiobt[5243]: No default controller available Apr 10 22:21:19 volumio volumiobt[5243]: [bluetooth]# agent NoInputNoOutput Apr 10 22:21:19 volumio volumiobt[5243]: Failed to register agent object Apr 10 22:21:19 volumio volumiobt[5243]: [bluetooth]# default-agent Apr 10 22:21:19 volumio volumiobt[5243]: No agent is registered Apr 10 22:21:19 volumio volumiobt[5243]: [bluetooth]# quit Apr 10 22:21:19 volumio pulseaudio[5325]: 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 Apr 10 22:21:19 volumio volumiobt[5243]: [59B blob data] Apr 10 22:21:19 volumio systemd[1]: Starting Hostname Service... Apr 10 22:21:19 volumio volumio[4324]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 10 22:21:19 volumio dbus-daemon[3604]: [system] Successfully activated service 'org.freedesktop.hostname1' Apr 10 22:21:19 volumio systemd[1]: Started Hostname Service. Apr 10 22:21:19 volumio volumio[4324]: info: MRS: Getting audio outputs on start Apr 10 22:21:19 volumio volumio[4324]: info: MRS: Requesting all other devices output Apr 10 22:21:21 volumio volumio[4324]: info: TidalConnect service started! Apr 10 22:21:21 volumio volumio[4324]: info: BOOT COMPLETED Apr 10 22:21:21 volumio volumio[4324]: [Metrics] CommandRouter: 28s 452.89ms Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::volumiosetStartupVolume Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::Close All Modals sent Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::Close All Modals sent Apr 10 22:21:21 volumio kernel: aml_spdif_open Apr 10 22:21:21 volumio kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Apr 10 22:21:21 volumio kernel: set normal 512 fs /4 fs Apr 10 22:21:21 volumio kernel: set spdifout clk:5644800, mpll:22579200 Apr 10 22:21:21 volumio kernel: get spdifout clk:5644797, mpll:22579186 Apr 10 22:21:21 volumio kernel: aml_dai_set_spdif_fmt , fmt 0x4010 Apr 10 22:21:21 volumio kernel: set normal 512 fs /4 fs Apr 10 22:21:21 volumio kernel: set spdifout clk:5644800, mpll:22579200 Apr 10 22:21:21 volumio kernel: get spdifout clk:5644797, mpll:22579186 Apr 10 22:21:21 volumio kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Apr 10 22:21:21 volumio kernel: hdmitx: hw: set audio Apr 10 22:21:21 volumio kernel: hdmitx: hw: hdmitx tx_aud_src = 0 Apr 10 22:21:21 volumio kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 593407 Apr 10 22:21:21 volumio kernel: hdmitx: hw: aud_n_para = 8918 Apr 10 22:21:21 volumio kernel: hdmitx: hw: set channel status Apr 10 22:21:21 volumio kernel: hdmitx: audio: Audio Type: PCM Apr 10 22:21:21 volumio kernel: hdmitx: audio: set audio param Apr 10 22:21:21 volumio kernel: aml_spdif_fifo_ctrl, bit depth:16, frddr type:1, toddr:type:1 Apr 10 22:21:21 volumio kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Apr 10 22:21:21 volumio kernel: aml_spdif_fifo_ctrl, bit depth:16, frddr type:1, toddr:type:1 Apr 10 22:21:21 volumio kernel: asoc-aml-card odroid_hdmi: S/PDIF Playback enable Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::volumioGetState Apr 10 22:21:21 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::volumioGetState Apr 10 22:21:21 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:21 volumio volumio[4324]: info: Currently active: mpd Apr 10 22:21:21 volumio volumio[4324]: info: Stopping currently active service Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::volumioStop Apr 10 22:21:21 volumio volumio[4324]: info: CoreStateMachine::stop Apr 10 22:21:21 volumio volumio[4324]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:21:21 volumio volumio[4324]: info: TidalConnect Active Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::volumioGetState Apr 10 22:21:21 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:21 volumio volumio[4324]: info: Currently active: mpd Apr 10 22:21:21 volumio volumio[4324]: info: Setting Volatile state to tidalconnect Apr 10 22:21:21 volumio volumio[4324]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:21 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:21 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:21 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:21 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:21 volumio volumio[4324]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 10 22:21:21 volumio volumio[4324]: verbose: CURRENT POSITION 0 Apr 10 22:21:21 volumio volumio[4324]: info: CoreStateMachine::syncState stateService stop Apr 10 22:21:21 volumio volumio[4324]: info: CoreStateMachine::syncState currentStatus stop Apr 10 22:21:21 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:21 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:21 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:21 volumio volumio[4324]: info: No code Apr 10 22:21:21 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:21 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:21 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:21 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:21 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:21 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:21 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:21 volumio volumio[4324]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 10 22:21:21 volumio volumio[4324]: verbose: CURRENT POSITION 0 Apr 10 22:21:21 volumio volumio[4324]: info: CoreStateMachine::syncState stateService stop Apr 10 22:21:21 volumio volumio[4324]: info: CoreStateMachine::syncState currentStatus stop Apr 10 22:21:21 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:21 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:21 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:21 volumio volumio[4324]: info: No code Apr 10 22:21:21 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:21 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:21 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:21 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:21 volumio volumio[4324]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.gvMCDpi4bYWrnqJAAn4ONcbsKYC2.b7286f18c981347c62b6c25db31ec89d.state.status' Apr 10 22:21:21 volumio volumio[4324]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.gvMCDpi4bYWrnqJAAn4ONcbsKYC2.b7286f18c981347c62b6c25db31ec89d.state.status' Apr 10 22:21:21 volumio volumio[4324]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.gvMCDpi4bYWrnqJAAn4ONcbsKYC2.b7286f18c981347c62b6c25db31ec89d.state.status' Apr 10 22:21:21 volumio volumio[4324]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.gvMCDpi4bYWrnqJAAn4ONcbsKYC2.b7286f18c981347c62b6c25db31ec89d.state.status' Apr 10 22:21:21 volumio volumio[4324]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.gvMCDpi4bYWrnqJAAn4ONcbsKYC2.b7286f18c981347c62b6c25db31ec89d.state.status' Apr 10 22:21:22 volumio vtcs[5280]: [2024-04-10 22:21:22.095] [tisoc] [warning] [PlaybackControllerImpl.cpp:501] Illegal state:1 Apr 10 22:21:22 volumio volumio[4324]: info: Pushing metadata Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:22 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:22 volumio volumio[4324]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"Khashoggi's Ship","artist":"Queen","album":"The Miracle (2011 Remaster)","albumart":"https://resources.tidal.com/images/814254cc/d517/4fa3/8c37/2122bbc63ec2/1280x1280.jpg","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":168,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 10 22:21:22 volumio volumio[4324]: verbose: CURRENT POSITION 0 Apr 10 22:21:22 volumio volumio[4324]: info: CoreStateMachine::syncState stateService stop Apr 10 22:21:22 volumio volumio[4324]: info: CoreStateMachine::syncState currentStatus stop Apr 10 22:21:22 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:22 volumio volumio[4324]: info: No code Apr 10 22:21:22 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:22 volumio volumio[4324]: info: CorePlayQueue::getTrack 0 Apr 10 22:21:22 volumio volumio[4324]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"Khashoggi's Ship","artist":"Queen","album":"The Miracle (2011 Remaster)","albumart":"https://resources.tidal.com/images/814254cc/d517/4fa3/8c37/2122bbc63ec2/1280x1280.jpg","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":61100,"duration":168,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 10 22:21:22 volumio volumio[4324]: verbose: CURRENT POSITION 0 Apr 10 22:21:22 volumio volumio[4324]: info: CoreStateMachine::syncState stateService stop Apr 10 22:21:22 volumio volumio[4324]: info: CoreStateMachine::syncState currentStatus stop Apr 10 22:21:22 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:22 volumio volumio[4324]: info: No code Apr 10 22:21:22 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 10 22:21:22 volumio volumio[4324]: xcb_connection_has_error() returned true Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 10 22:21:22 volumio volumio[4324]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.gvMCDpi4bYWrnqJAAn4ONcbsKYC2.b7286f18c981347c62b6c25db31ec89d.state.status' Apr 10 22:21:22 volumio volumio[4324]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.gvMCDpi4bYWrnqJAAn4ONcbsKYC2.b7286f18c981347c62b6c25db31ec89d.state.status' Apr 10 22:21:22 volumio volumio[4324]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.gvMCDpi4bYWrnqJAAn4ONcbsKYC2.b7286f18c981347c62b6c25db31ec89d.state.status' Apr 10 22:21:22 volumio volumio[4324]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.gvMCDpi4bYWrnqJAAn4ONcbsKYC2.b7286f18c981347c62b6c25db31ec89d.state.status' Apr 10 22:21:22 volumio volumio[4324]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.gvMCDpi4bYWrnqJAAn4ONcbsKYC2.b7286f18c981347c62b6c25db31ec89d.state.status' Apr 10 22:21:22 volumio volumio[4324]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.gvMCDpi4bYWrnqJAAn4ONcbsKYC2.b7286f18c981347c62b6c25db31ec89d.state.status' Apr 10 22:21:22 volumio volumio[4324]: info: Pushing metadata Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:22 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:22 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:24 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 10 22:21:24 volumio volumio[4324]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 11 Apr 10 22:21:24 volumio volumio[4324]: info: CoreCommandRouter::volumioGetState Apr 10 22:21:26 volumio kernel: asoc-aml-card odroid_hdmi: S/PDIF Playback disable Apr 10 22:21:26 volumio kernel: spdif_a keep clk continuous Apr 10 22:21:26 volumio kernel: aml_spdif_close Apr 10 22:21:26 volumio kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Apr 10 22:21:27 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 10 22:21:27 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:21:27 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 10 22:21:27 volumio volumio-remote-updater[3589]: No test mode Apr 10 22:21:27 volumio volumio-remote-updater[3589]: No alpha test mode Apr 10 22:21:27 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 10 22:21:27 volumio volumio[4324]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 10 22:21:27 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 10 22:21:29 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:29 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:21:29 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 10 22:21:29 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 10 22:21:29 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 10 22:21:29 volumio volumio[4324]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 22:21:29 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 10 22:21:31 volumio vtcs[5280]: [2024-04-10 22:21:31.540] [tisoc] [warning] [audio_worker.cpp:326] Attempting to initialize a decoder without initial data! Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:31 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:31 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:31 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:31 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:31 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:31 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:31 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:31 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:31 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:31 volumio kernel: aml_spdif_open Apr 10 22:21:31 volumio kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Apr 10 22:21:31 volumio kernel: set normal 512 fs /4 fs Apr 10 22:21:31 volumio kernel: set spdifout clk:5644800, mpll:22579200 Apr 10 22:21:31 volumio kernel: get spdifout clk:5644797, mpll:22579186 Apr 10 22:21:31 volumio kernel: aml_dai_set_spdif_fmt , fmt 0x4010 Apr 10 22:21:31 volumio kernel: set normal 512 fs /4 fs Apr 10 22:21:31 volumio kernel: set spdifout clk:5644800, mpll:22579200 Apr 10 22:21:31 volumio kernel: get spdifout clk:5644797, mpll:22579186 Apr 10 22:21:31 volumio kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Apr 10 22:21:31 volumio kernel: aml_spdif_fifo_ctrl, bit depth:16, frddr type:1, toddr:type:1 Apr 10 22:21:31 volumio kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Apr 10 22:21:31 volumio kernel: aml_spdif_fifo_ctrl, bit depth:16, frddr type:1, toddr:type:1 Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:31 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:31 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:31 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:31 volumio kernel: asoc-aml-card odroid_hdmi: S/PDIF Playback enable Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:31 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:31 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:31 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:31 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:31 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:31 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:31 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:32 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:32 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:32 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:32 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:32 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:32 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:32 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:32 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:32 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:32 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:32 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:32 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:32 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:32 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:32 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:32 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:36 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:36 volumio volumio[4324]: info: VolumeController::SetAlsaVolume1 Apr 10 22:21:36 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:36 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:36 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:36 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:36 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:37 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:37 volumio volumio[4324]: info: VolumeController::SetAlsaVolume2 Apr 10 22:21:37 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:37 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:37 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:37 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:37 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:38 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:38 volumio volumio[4324]: info: VolumeController::SetAlsaVolume1 Apr 10 22:21:38 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:38 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:38 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:38 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:38 volumio volumio[4324]: info: VolumeController::SetAlsaVolume2 Apr 10 22:21:38 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:38 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:38 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:38 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:38 volumio volumio[4324]: info: VolumeController::SetAlsaVolume3 Apr 10 22:21:38 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:38 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:38 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:38 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:38 volumio volumio[4324]: info: VolumeController::SetAlsaVolume4 Apr 10 22:21:38 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:38 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:38 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:38 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:38 volumio volumio[4324]: info: VolumeController::SetAlsaVolume5 Apr 10 22:21:38 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:38 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:38 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:38 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:38 volumio volumio[4324]: info: VolumeController::SetAlsaVolume6 Apr 10 22:21:38 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:38 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:38 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:38 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:38 volumio volumio[4324]: info: VolumeController::SetAlsaVolume7 Apr 10 22:21:38 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:38 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:38 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume8 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume9 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume10 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume11 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume12 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume13 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume14 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume15 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume16 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume17 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume18 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume19 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume20 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume21 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume22 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume23 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume24 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume25 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume26 Apr 10 22:21:39 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:39 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:39 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:39 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:39 volumio volumio[4324]: info: VolumeController::SetAlsaVolume27 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume28 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume29 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume30 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume31 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume32 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume33 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume34 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume35 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume36 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume37 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume38 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume39 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume40 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume41 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume42 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume43 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume44 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume45 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume46 Apr 10 22:21:40 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:40 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:40 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:40 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:40 volumio volumio[4324]: info: VolumeController::SetAlsaVolume47 Apr 10 22:21:41 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:41 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:41 volumio volumio[4324]: info: VolumeController::SetAlsaVolume48 Apr 10 22:21:41 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:41 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:41 volumio volumio[4324]: info: VolumeController::SetAlsaVolume49 Apr 10 22:21:41 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:41 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:41 volumio volumio[4324]: info: VolumeController::SetAlsaVolume50 Apr 10 22:21:41 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:41 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:41 volumio volumio[4324]: info: VolumeController::SetAlsaVolume51 Apr 10 22:21:41 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:41 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:41 volumio volumio[4324]: info: VolumeController::SetAlsaVolume52 Apr 10 22:21:41 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:41 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:41 volumio volumio[4324]: info: VolumeController::SetAlsaVolume53 Apr 10 22:21:41 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:41 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:41 volumio volumio[4324]: info: VolumeController::SetAlsaVolume54 Apr 10 22:21:41 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:41 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:41 volumio volumio[4324]: info: VolumeController::SetAlsaVolume55 Apr 10 22:21:41 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:41 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:41 volumio volumio[4324]: info: VolumeController::SetAlsaVolume56 Apr 10 22:21:41 volumio kernel: fb: mem_free_work, free memory: addr:800000 Apr 10 22:21:41 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:41 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:41 volumio volumio[4324]: info: VolumeController::SetAlsaVolume57 Apr 10 22:21:41 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:41 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:41 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:42 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:42 volumio volumio[4324]: info: VolumeController::SetAlsaVolume58 Apr 10 22:21:42 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:42 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:42 volumio volumio[4324]: info: VolumeController::SetAlsaVolume59 Apr 10 22:21:42 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:42 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:42 volumio volumio[4324]: info: VolumeController::SetAlsaVolume60 Apr 10 22:21:42 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:42 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:42 volumio volumio[4324]: info: VolumeController::SetAlsaVolume61 Apr 10 22:21:42 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:42 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:42 volumio volumio[4324]: info: VolumeController::SetAlsaVolume62 Apr 10 22:21:42 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:42 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:42 volumio volumio[4324]: info: VolumeController::SetAlsaVolume63 Apr 10 22:21:42 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:42 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:42 volumio volumio[4324]: info: VolumeController::SetAlsaVolume64 Apr 10 22:21:42 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:42 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:42 volumio volumio[4324]: info: VolumeController::SetAlsaVolume65 Apr 10 22:21:42 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:42 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:42 volumio volumio[4324]: info: VolumeController::SetAlsaVolume66 Apr 10 22:21:42 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:42 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:42 volumio volumio[4324]: info: VolumeController::SetAlsaVolume67 Apr 10 22:21:42 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:42 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:42 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:42 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:42 volumio volumio[4324]: info: VolumeController::SetAlsaVolume68 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume69 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume70 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume71 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume72 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume73 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume74 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume75 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume76 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume77 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume78 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume79 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume80 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume81 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume82 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume83 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume84 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume85 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume86 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume87 Apr 10 22:21:43 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:43 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:43 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:43 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:43 volumio volumio[4324]: info: VolumeController::SetAlsaVolume88 Apr 10 22:21:44 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:44 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:44 volumio volumio[4324]: info: VolumeController::SetAlsaVolume89 Apr 10 22:21:44 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:44 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:44 volumio volumio[4324]: info: VolumeController::SetAlsaVolume90 Apr 10 22:21:44 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:44 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:44 volumio volumio[4324]: info: VolumeController::SetAlsaVolume91 Apr 10 22:21:44 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:44 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:44 volumio volumio[4324]: info: VolumeController::SetAlsaVolume92 Apr 10 22:21:44 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:44 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:44 volumio volumio[4324]: info: VolumeController::SetAlsaVolume93 Apr 10 22:21:44 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:44 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:44 volumio volumio[4324]: info: VolumeController::SetAlsaVolume94 Apr 10 22:21:44 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:44 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:44 volumio volumio[4324]: info: VolumeController::SetAlsaVolume95 Apr 10 22:21:44 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:44 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:44 volumio volumio[4324]: info: VolumeController::SetAlsaVolume96 Apr 10 22:21:44 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:44 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:44 volumio volumio[4324]: info: VolumeController::SetAlsaVolume97 Apr 10 22:21:44 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:44 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:44 volumio volumio[4324]: info: VolumeController::SetAlsaVolume98 Apr 10 22:21:44 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:44 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:44 volumio volumio[4324]: info: VolumeController::SetAlsaVolume99 Apr 10 22:21:44 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:44 volumio volumio[4324]: info: Volume: {"mute":false} Apr 10 22:21:44 volumio volumio[4324]: info: VolumeController::SetAlsaVolume100 Apr 10 22:21:44 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:44 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:44 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio kernel: asoc-aml-card odroid_hdmi: S/PDIF Playback disable Apr 10 22:21:45 volumio kernel: spdif_a keep clk continuous Apr 10 22:21:45 volumio kernel: aml_spdif_close Apr 10 22:21:45 volumio kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Apr 10 22:21:45 volumio volumio[4324]: info: Pushing metadata Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio volumio[4324]: info: Pushing metadata Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio kernel: aml_spdif_open Apr 10 22:21:45 volumio kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Apr 10 22:21:45 volumio kernel: set normal 512 fs /4 fs Apr 10 22:21:45 volumio kernel: set spdifout clk:5644800, mpll:22579200 Apr 10 22:21:45 volumio kernel: get spdifout clk:5644797, mpll:22579186 Apr 10 22:21:45 volumio kernel: aml_dai_set_spdif_fmt , fmt 0x4010 Apr 10 22:21:45 volumio kernel: set normal 512 fs /4 fs Apr 10 22:21:45 volumio kernel: set spdifout clk:5644800, mpll:22579200 Apr 10 22:21:45 volumio kernel: get spdifout clk:5644797, mpll:22579186 Apr 10 22:21:45 volumio kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Apr 10 22:21:45 volumio kernel: aml_spdif_fifo_ctrl, bit depth:16, frddr type:1, toddr:type:1 Apr 10 22:21:45 volumio kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Apr 10 22:21:45 volumio kernel: aml_spdif_fifo_ctrl, bit depth:16, frddr type:1, toddr:type:1 Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio kernel: asoc-aml-card odroid_hdmi: S/PDIF Playback enable Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:45 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:45 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:46 volumio volumio[4324]: info: CoreCommandRouter::servicePushState Apr 10 22:21:46 volumio volumio[4324]: info: CoreStateMachine::pushState Apr 10 22:21:46 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:21:46 volumio volumio[4324]: info: CoreCommandRouter::volumioPushState Apr 10 22:21:46 volumio volumio[4324]: info: MRS: Pushing multiroomSync output update for this device Apr 10 22:21:46 volumio volumio[4324]: info: MRS: Pushing multiroomSync output Apr 10 22:21:49 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 22:21:51 volumio volumio[4324]: info: Retrieving Cloud Streaming UI Apr 10 22:21:51 volumio volumio[4324]: info: Getting Tidal Cloud Configuration Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 22:21:51 volumio volumio[4324]: info: Getting Qobuz Cloud Configuration Apr 10 22:21:51 volumio volumio[4324]: info: Asking plugin for UI Config Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 22:21:51 volumio volumio[4324]: info: Getting Spotify Cloud Configuration Apr 10 22:21:51 volumio volumio[4324]: info: Asking plugin for UI Config Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 22:21:51 volumio volumio[4324]: info: Saving Spotify Acccount Apr 10 22:21:51 volumio volumio[4324]: info: Got it Apr 10 22:21:51 volumio volumio[4324]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 10 22:21:51 volumio volumio[4324]: info: Got Tidal Cloud Configuration Apr 10 22:21:51 volumio volumio[4324]: info: Got it Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 22:21:51 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 10 22:21:53 volumio volumio[4324]: info: Disabling MyMusic plugin upnp Apr 10 22:21:53 volumio sudo[5623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Apr 10 22:21:53 volumio sudo[5623]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:21:53 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Apr 10 22:21:53 volumio volumio[4324]: error: Upnp client error: Error: This socket has been ended by the other party Apr 10 22:21:53 volumio volumio[4324]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 10 22:21:55 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 22:21:56 volumio volumio[4324]: info: Disabling MyMusic plugin smart_inputs Apr 10 22:21:56 volumio volumio[4324]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service smart_inputs Apr 10 22:21:56 volumio volumio[4324]: info: Removeing all smart Inputs Apr 10 22:21:56 volumio volumio[4324]: info: Disabling plugin smart_inputs Apr 10 22:21:59 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 22:22:00 volumio volumio[4324]: info: Enabling MyMusic plugin smart_inputs Apr 10 22:22:00 volumio volumio[4324]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service smart_inputs Apr 10 22:22:00 volumio volumio[4324]: info: Enabling plugin smart_inputs Apr 10 22:22:00 volumio volumio[4324]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Apr 10 22:22:00 volumio volumio[4324]: info: Adding inputs REST Endpoints Apr 10 22:22:00 volumio volumio[4324]: info: Updating scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Apr 10 22:22:00 volumio volumio[4324]: info: Scanning Audio Inputs Apr 10 22:22:00 volumio volumio[4324]: xcb_connection_has_error() returned true Apr 10 22:22:00 volumio volumio[4324]: info: Checking against Known Cards name Apr 10 22:22:00 volumio volumio[4324]: info: Adding Server instance for streaming Apr 10 22:22:00 volumio volumio[4324]: info: Done. Apr 10 22:22:03 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 22:22:04 volumio volumio[4324]: info: CALLMETHOD: music_service streaming_services qobuzLogout Apr 10 22:22:04 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: streaming_services , qobuzLogout Apr 10 22:22:04 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: qobuz , logout Apr 10 22:22:04 volumio volumio[4324]: info: Executing Logout From QOBUZ Apr 10 22:22:04 volumio volumio[4324]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Apr 10 22:22:04 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: my_music , getUIConfig Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 22:22:05 volumio volumio[4324]: info: Retrieving Cloud Streaming UI Apr 10 22:22:05 volumio volumio[4324]: info: Getting Tidal Cloud Configuration Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 22:22:05 volumio volumio[4324]: info: Getting Qobuz Cloud Configuration Apr 10 22:22:05 volumio volumio[4324]: info: Asking plugin for UI Config Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 22:22:05 volumio volumio[4324]: info: Getting Spotify Cloud Configuration Apr 10 22:22:05 volumio volumio[4324]: info: Asking plugin for UI Config Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 22:22:05 volumio volumio[4324]: info: Saving Spotify Acccount Apr 10 22:22:05 volumio volumio[4324]: info: Got it Apr 10 22:22:05 volumio volumio[4324]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 10 22:22:05 volumio volumio[4324]: info: Got Tidal Cloud Configuration Apr 10 22:22:05 volumio volumio[4324]: info: Got it Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 22:22:05 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 10 22:22:09 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 22:22:11 volumio volumio[4324]: info: Disabling MyMusic plugin upnp Apr 10 22:22:11 volumio sudo[5632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Apr 10 22:22:11 volumio sudo[5632]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:22:11 volumio volumio[4324]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 10 22:22:12 volumio volumio[4324]: info: Enabling MyMusic plugin upnp Apr 10 22:22:12 volumio volumio[4324]: info: Enabling plugin upnp Apr 10 22:22:12 volumio volumio[4324]: info: Loading plugin "upnp"... Apr 10 22:22:12 volumio volumio[4324]: info: [1712780532068] Starting Upmpd Daemon Apr 10 22:22:12 volumio volumio[4324]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 10 22:22:12 volumio volumio[4324]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 22:22:12 volumio volumio[4324]: Error: listen EADDRINUSE: address already in use :::6599 Apr 10 22:22:12 volumio volumio[4324]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Apr 10 22:22:12 volumio volumio[4324]: at listenInCluster (net.js:1379:12) Apr 10 22:22:12 volumio volumio[4324]: at Server.listen (net.js:1465:7) Apr 10 22:22:12 volumio volumio[4324]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Apr 10 22:22:12 volumio volumio[4324]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Apr 10 22:22:12 volumio volumio[4324]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Apr 10 22:22:12 volumio volumio[4324]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 10 22:22:12 volumio volumio[4324]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Apr 10 22:22:12 volumio volumio[4324]: code: 'EADDRINUSE', Apr 10 22:22:12 volumio volumio[4324]: errno: -98, Apr 10 22:22:12 volumio volumio[4324]: syscall: 'listen', Apr 10 22:22:12 volumio volumio[4324]: address: '::', Apr 10 22:22:12 volumio volumio[4324]: port: 6599 Apr 10 22:22:12 volumio volumio[4324]: } Apr 10 22:22:12 volumio volumio[4324]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 22:22:12 volumio sudo[5643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-10 22:21 Apr 10 22:22:12 volumio sudo[5643]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 24 Feb 2024 09:20:08 PM CET" VOLUMIO_VERSION="3.629" VOLUMIO_HARDWARE="odroidc4" VOLUMIO_DEVICENAME="Odroid-C4" VOLUMIO_HASH="f83d9bf37d1b991751b7e7a6d9294016"