-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Fri 2025-02-21 18:25:00 CET. -- Feb 21 18:24:07 bureau go-librespot[3442]: time="2025-02-21T18:24:07+01:00" level=trace msg="received accesspoint ping" Feb 21 18:24:07 bureau go-librespot[3442]: time="2025-02-21T18:24:07+01:00" level=trace msg="received accesspoint pong ack" Feb 21 18:24:07 bureau go-librespot[3442]: time="2025-02-21T18:24:07+01:00" level=trace msg="sent dealer ping" Feb 21 18:24:07 bureau go-librespot[3442]: time="2025-02-21T18:24:07+01:00" level=trace msg="received dealer pong" Feb 21 18:24:11 bureau kernel: hdmitx: system: irq 80000002 0 Feb 21 18:24:11 bureau kernel: hdmitx: system: plugin Feb 21 18:24:11 bureau kernel: hdmitx: edid: EDID Parser: Feb 21 18:24:11 bureau kernel: hdmitx: hdmitx: reach vesa idx MAX Feb 21 18:24:11 bureau kernel: hdmitx: hdmitx: reach vesa idx MAX Feb 21 18:24:11 bureau kernel: hdmitx: hdmitx: reach vesa idx MAX Feb 21 18:24:11 bureau kernel: hdmitx: hdmitx: reach vesa idx MAX Feb 21 18:24:11 bureau kernel: hdmitx: hdmitx: reach vesa idx MAX Feb 21 18:24:11 bureau kernel: hdmitx: hdmitx: reach vesa idx MAX Feb 21 18:24:11 bureau kernel: hdmitx: hdmitx: reach vesa idx MAX Feb 21 18:24:11 bureau kernel: [RX]-up_phy_addr = 2 Feb 21 18:24:11 bureau kernel: hdmitx: v2 VSVDB: len=11, sup_2160p60hz=1, Interface=2 Feb 21 18:24:11 bureau kernel: hdmitx: edid: change preferred_mode from 0 to 97 Feb 21 18:24:11 bureau kernel: hdmitx: hdmitx: get PMT vic: 97 Feb 21 18:24:11 bureau kernel: hdmitx: edid: find IEEEOUT Feb 21 18:24:11 bureau kernel: hdmitx: edid: check sum valid Feb 21 18:24:11 bureau kernel: hdmitx: edid: check sum valid Feb 21 18:24:11 bureau kernel: hdmitx: edid: update rx hdr info f at edid parsing Feb 21 18:24:11 bureau kernel: hdmitx: edid: check sum valid Feb 21 18:24:11 bureau kernel: hdmitx: edid: check sum valid Feb 21 18:24:11 bureau kernel: hdmitx: edid: blk0 raw data Feb 21 18:24:11 bureau kernel: hdmitx: edid: 00ffffffffffff00506c53960000010014210103807944780af4b5ac4f46a726 0f50542108008140a940818081c0a9c001010101010108e80030f2705a80b058 8a00b9a84200001e6fc200a0a0a055503020350056502100001e000000fc0042 65796f6e642054560a202020000000fd00324b1e503c000a202020202020012b Feb 21 18:24:11 bureau kernel: hdmitx: edid: blk1 raw data Feb 21 18:24:11 bureau kernel: hdmitx: edid: 02037cf05261606665765f5e5d3f10221f200514041303380f07071507505707 016704073d07c05f7e075f7e0135072883010000e200cb6e030c002000b84421 0080010203046ad85dc40178806f0230f0e305e301e20f1fe3060f01eb0146d0 004d1a968c4a6785e5018b8490016d1a0000020330f0000460405a4400000016 Feb 21 18:24:11 bureau kernel: hdmitx: system: update physcial size: 1210 680 Feb 21 18:24:11 bureau kernel: hdmitx: video: Sink is HDMI device Feb 21 18:24:11 bureau kernel: hdmitx: hw: set audio Feb 21 18:24:11 bureau kernel: hdmitx: hw: hdmitx tx_aud_src = 0 Feb 21 18:24:11 bureau kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 0 Feb 21 18:24:11 bureau kernel: hdmitx: hw: aud_n_para = 6272 Feb 21 18:24:11 bureau kernel: hdmitx: hw: set channel status Feb 21 18:24:11 bureau kernel: hdmitx: audio: Audio Type: PCM Feb 21 18:24:11 bureau kernel: hdmitx: system: get current mode: 1080p60hz Feb 21 18:24:11 bureau kernel: hdmitx: system: update rx hdr info f Feb 21 18:24:11 bureau kernel: hdmitx: system: update physcial size: 1210 680 Feb 21 18:24:11 bureau kernel: hdmitx: system: [set_disp_mode_auto] ALREADY init VIC = 16 Feb 21 18:24:11 bureau kernel: hdmitx: system: change to HDMI mode Feb 21 18:24:24 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:24:24 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:24:24 bureau volumio[2477]: info: Discovery: Getting this device information Feb 21 18:24:24 bureau volumio[2477]: info: CoreCommandRouter::volumioGetState Feb 21 18:24:24 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:24 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:24:24 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:24:24 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:24:24 bureau volumio[2477]: info: Discovery: Getting this device information Feb 21 18:24:24 bureau volumio[2477]: info: CoreCommandRouter::volumioGetState Feb 21 18:24:24 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:24 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:24:25 bureau volumio[2477]: verbose: New Socket.io Connection to 192.168.0.13 from 192.168.0.16 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5 Feb 21 18:24:25 bureau volumio[2477]: info: CoreCommandRouter::volumioGetVisibleSources Feb 21 18:24:25 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 18:24:25 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:25 bureau volumio[2477]: info: Retrieving Cloud Streaming UI Feb 21 18:24:25 bureau volumio[2477]: info: Getting Tidal Cloud Configuration Feb 21 18:24:25 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:25 bureau volumio[2477]: info: Getting Qobuz Cloud Configuration Feb 21 18:24:25 bureau volumio[2477]: info: Asking plugin for UI Config Feb 21 18:24:25 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:25 bureau volumio[2477]: info: Getting Spotify Cloud Configuration Feb 21 18:24:25 bureau volumio[2477]: info: Asking plugin for UI Config Feb 21 18:24:25 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:25 bureau volumio[2477]: info: Saving Spotify Acccount Feb 21 18:24:25 bureau volumio[2477]: info: Got Tidal Cloud Configuration Feb 21 18:24:25 bureau volumio[2477]: info: Got it Feb 21 18:24:25 bureau volumio[2477]: info: Got it Feb 21 18:24:25 bureau volumio[2477]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 21 18:24:25 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:25 bureau volumio[2477]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 21 18:24:25 bureau volumio[2477]: verbose: New Socket.io Connection to 192.168.0.13:3000 from 192.168.0.16 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 21 18:24:27 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 21 18:24:27 bureau volumio[2477]: info: Loading i18n strings for locale fr Feb 21 18:24:27 bureau volumio[2477]: Updating browse sources language Feb 21 18:24:27 bureau volumio[2477]: Cannot find translation for source Spotify Feb 21 18:24:27 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 18:24:27 bureau volumio[2477]: Cannot find translation for source Spotify Feb 21 18:24:27 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 21 18:24:27 bureau volumio[2477]: info: Setting timezone to Europe/Brussels Feb 21 18:24:27 bureau sudo[4222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 21 18:24:27 bureau sudo[4222]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:27 bureau sudo[4222]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:27 bureau sudo[4225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Brussels /etc/localtime Feb 21 18:24:27 bureau sudo[4225]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:27 bureau sudo[4225]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:27 bureau sudo[4228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 21 18:24:27 bureau sudo[4228]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:27 bureau sudo[4228]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:27 bureau sudo[4231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Brussels Feb 21 18:24:27 bureau sudo[4231]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:27 bureau dbus-daemon[2279]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.25' (uid=0 pid=4232 comm="/usr/bin/timedatectl set-timezone Europe/Brussels " label="kernel") Feb 21 18:24:27 bureau systemd[1]: Starting Time & Date Service... Feb 21 18:24:27 bureau dbus-daemon[2279]: [system] Successfully activated service 'org.freedesktop.timedate1' Feb 21 18:24:27 bureau systemd[1]: Started Time & Date Service. Feb 21 18:24:27 bureau sudo[4231]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:27 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Feb 21 18:24:27 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Feb 21 18:24:27 bureau sudo[4241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 21 18:24:27 bureau sudo[4241]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:27 bureau sudo[4241]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:27 bureau volumio[2477]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 21 18:24:27 bureau volumio[2477]: wlan0 Interface doesn't support scanning. Feb 21 18:24:27 bureau volumio[2477]: info: Cannot use regular scanning, forcing with ap-force Feb 21 18:24:27 bureau sudo[4246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 21 18:24:27 bureau sudo[4246]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:27 bureau sudo[4246]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:27 bureau volumio[2477]: command failed: No such device (-19) Feb 21 18:24:27 bureau volumio[2477]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Feb 21 18:24:27 bureau volumio[2477]: command failed: No such device (-19) Feb 21 18:24:27 bureau volumio[2477]: info: Fetching Streaming Services browse cache Feb 21 18:24:29 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Feb 21 18:24:29 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Feb 21 18:24:29 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 21 18:24:29 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:24:29 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Feb 21 18:24:30 bureau volumio[2477]: info: Preparing to save Alsa Options, stopping services first Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::volumioGetState Feb 21 18:24:30 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::volumioStop Feb 21 18:24:30 bureau volumio[2477]: info: CoreStateMachine::stop Feb 21 18:24:30 bureau volumio[2477]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 18:24:30 bureau volumio[2477]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"0","label":"HDMI/ TOSLINK (S/PDIF)"},"disallowPush":true} Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 21 18:24:30 bureau volumio[2477]: info: Found match in Cards Database: setting mixer for card HDMI/ TOSLINK (S/PDIF) Feb 21 18:24:30 bureau volumio[2477]: info: Setting mixer Audio hdmi-out mute for card HDMI/ TOSLINK (S/PDIF) Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 21 18:24:30 bureau volumio[2477]: info: Updating Volume Controller Parameters: Device: 0 Name: HDMI/ TOSLINK (S/PDIF) Mixer: Audio hdmi-out mute Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 21 18:24:30 bureau volumio[2477]: info: Disabling external Volume Control Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:30 bureau volumio[2477]: info: Preparing to generate the ALSA configuration file Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:30 bureau volumio[2477]: info: Retrieving Cloud Streaming UI Feb 21 18:24:30 bureau volumio[2477]: Unable to parse: Feb 21 18:24:30 bureau volumio[2477]: Simple mixer control 'Audio hdmi-out mute',0 Feb 21 18:24:30 bureau volumio[2477]: Capabilities: pswitch pswitch-joined Feb 21 18:24:30 bureau volumio[2477]: Playback channels: Mono Feb 21 18:24:30 bureau volumio[2477]: Mono: Playback [on] Feb 21 18:24:30 bureau volumio[2477]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 21 18:24:30 bureau volumio[2477]: info: Asound.conf file unchanged, so no further update is needed Feb 21 18:24:30 bureau volumio[2477]: info: Output device has changed, restarting MPD Feb 21 18:24:30 bureau sudo[4267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 18:24:30 bureau sudo[4267]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:30 bureau sudo[4267]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:30 bureau volumio[2477]: info: Output device has changed, restarting Shairport Sync Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:24:30 bureau sudo[4270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 18:24:30 bureau sudo[4270]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:30 bureau systemd[1]: Stopping Music Player Daemon... Feb 21 18:24:30 bureau volumio[2477]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 21 18:24:30 bureau volumio[2477]: info: Getting Tidal Cloud Configuration Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:30 bureau volumio[2477]: info: Getting Qobuz Cloud Configuration Feb 21 18:24:30 bureau volumio[2477]: info: Asking plugin for UI Config Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:30 bureau volumio[2477]: info: Getting Spotify Cloud Configuration Feb 21 18:24:30 bureau volumio[2477]: info: Asking plugin for UI Config Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:30 bureau volumio[2477]: info: Saving Spotify Acccount Feb 21 18:24:30 bureau volumio[2477]: info: Got Tidal Cloud Configuration Feb 21 18:24:30 bureau volumio[2477]: info: Got it Feb 21 18:24:30 bureau volumio[2477]: info: Got it Feb 21 18:24:30 bureau volumio[2477]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 21 18:24:30 bureau volumio[2477]: info: MPD Permissions set Feb 21 18:24:30 bureau volumio[2477]: Unable to parse: Feb 21 18:24:30 bureau volumio[2477]: Simple mixer control 'Audio hdmi-out mute',0 Feb 21 18:24:30 bureau volumio[2477]: Capabilities: pswitch pswitch-joined Feb 21 18:24:30 bureau volumio[2477]: Playback channels: Mono Feb 21 18:24:30 bureau volumio[2477]: Mono: Playback [on] Feb 21 18:24:30 bureau volumio[2477]: info: VolumeController:: Volume=undefined Mute =false Feb 21 18:24:30 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:30 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:30 bureau systemd[1]: mpd.service: Succeeded. Feb 21 18:24:30 bureau systemd[1]: Stopped Music Player Daemon. Feb 21 18:24:30 bureau systemd[1]: Starting Music Player Daemon... Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:24:30 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:30 bureau volumio[2477]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 21 18:24:30 bureau volumio[2477]: info: Starting Shairport Sync Feb 21 18:24:30 bureau sudo[4291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 21 18:24:30 bureau sudo[4291]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:30 bureau sudo[4275]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 18:24:30 bureau sudo[4275]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:30 bureau systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 21 18:24:30 bureau systemd[1]: shairport-sync.service: Succeeded. Feb 21 18:24:30 bureau sudo[4275]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:30 bureau systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 21 18:24:30 bureau systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 21 18:24:30 bureau sudo[4291]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:30 bureau volumio[2477]: info: Shairport-Sync Started Feb 21 18:24:31 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Feb 21 18:24:31 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Feb 21 18:24:31 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Feb 21 18:24:31 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Feb 21 18:24:31 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Feb 21 18:24:31 bureau mpd[4296]: Feb 21 18:24 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 21 18:24:31 bureau systemd[1]: Started Music Player Daemon. Feb 21 18:24:31 bureau sudo[4270]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:31 bureau volumio[2477]: error: updateQueue error: null Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::Reload Ui Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Feb 21 18:24:32 bureau volumio[2477]: info: Wizard terminated Successfully Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::volumiosetStartupVolume Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:24:32 bureau sudo[4309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 18:24:32 bureau sudo[4309]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:32 bureau sudo[4309]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:32 bureau sudo[4311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 18:24:32 bureau sudo[4311]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:32 bureau sudo[4311]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:32 bureau volumio[2477]: verbose: New Socket.io Connection to 192.168.0.13 from 192.168.0.16 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::volumioGetVisibleSources Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::volumioGetState Feb 21 18:24:32 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 21 18:24:32 bureau volumio[2477]: info: Received Get System Info Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:24:32 bureau volumio[2477]: info: Discovery: Getting this device information Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::volumioGetState Feb 21 18:24:32 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::volumioGetState Feb 21 18:24:32 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:32 bureau volumio[2477]: info: Listing playlists Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 21 18:24:32 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 21 18:24:32 bureau sudo[4317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 18:24:32 bureau sudo[4317]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:32 bureau sudo[4317]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:33 bureau sudo[4320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 18:24:33 bureau sudo[4320]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 21 18:24:33 bureau sudo[4320]: pam_unix(sudo:session): session closed for user root Feb 21 18:24:33 bureau volumio[2477]: verbose: New Socket.io Connection to 192.168.0.13 from 192.168.0.16 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::volumioGetVisibleSources Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::volumioGetState Feb 21 18:24:33 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 21 18:24:33 bureau volumio[2477]: info: Received Get System Info Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:24:33 bureau volumio[2477]: info: Discovery: Getting this device information Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::volumioGetState Feb 21 18:24:33 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::volumioGetState Feb 21 18:24:33 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:33 bureau volumio[2477]: info: Listing playlists Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 21 18:24:33 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 21 18:24:34 bureau volumio[2477]: info: CoreCommandRouter::volumioPlay Feb 21 18:24:34 bureau volumio[2477]: info: CoreStateMachine::play index undefined Feb 21 18:24:34 bureau volumio[2477]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 18:24:34 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:34 bureau volumio[2477]: info: CoreStateMachine::startPlaybackTimer Feb 21 18:24:34 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:34 bureau volumio[2477]: info: [1740158674175] ControllerWebradio::clearAddPlayTrack Feb 21 18:24:34 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 18:24:34 bureau volumio[2477]: info: sendMpdCommand stop took 1 milliseconds Feb 21 18:24:34 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 18:24:34 bureau volumio[2477]: info: Feb 21 18:24:34 bureau volumio[2477]: ---------------------------- MPD announces system playlist update Feb 21 18:24:34 bureau volumio[2477]: info: Ignoring MPD Status Update Feb 21 18:24:34 bureau volumio[2477]: info: sendMpdCommand clear took 3 milliseconds Feb 21 18:24:34 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand load "https://systemweb-server3.de:7002/stream/1/" Feb 21 18:24:34 bureau volumio[2477]: error: updateQueue error: null Feb 21 18:24:34 bureau volumio[2477]: info: ------------------------------ 4ms Feb 21 18:24:34 bureau volumio[2477]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Feb 21 18:24:34 bureau volumio[2477]: info: CoreStateMachine::getcurrentVolume Feb 21 18:24:34 bureau volumio[2477]: info: CoreCommandRouter::volumioRetrievevolume Feb 21 18:24:34 bureau volumio[2477]: Unable to parse: Feb 21 18:24:34 bureau volumio[2477]: Simple mixer control 'Audio hdmi-out mute',0 Feb 21 18:24:34 bureau volumio[2477]: Capabilities: pswitch pswitch-joined Feb 21 18:24:34 bureau volumio[2477]: Playback channels: Mono Feb 21 18:24:34 bureau volumio[2477]: Mono: Playback [on] Feb 21 18:24:34 bureau volumio[2477]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Feb 21 18:24:34 bureau volumio[2477]: Unable to parse: Feb 21 18:24:34 bureau volumio[2477]: Simple mixer control 'Audio hdmi-out mute',0 Feb 21 18:24:34 bureau volumio[2477]: Capabilities: pswitch pswitch-joined Feb 21 18:24:34 bureau volumio[2477]: Playback channels: Mono Feb 21 18:24:34 bureau volumio[2477]: Mono: Playback [on] Feb 21 18:24:34 bureau volumio[2477]: info: VolumeController:: Volume=undefined Mute =false Feb 21 18:24:34 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:34 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:34 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:34 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:34 bureau volumio[2477]: info: CoreStateMachine::updateTrackBlock Feb 21 18:24:34 bureau volumio[2477]: info: CorePlayQueue::getTrackBlock Feb 21 18:24:34 bureau volumio[2477]: info: CoreCommandRouter::volumioRetrievevolume Feb 21 18:24:34 bureau volumio[2477]: Unable to parse: Feb 21 18:24:34 bureau volumio[2477]: Simple mixer control 'Audio hdmi-out mute',0 Feb 21 18:24:34 bureau volumio[2477]: Capabilities: pswitch pswitch-joined Feb 21 18:24:34 bureau volumio[2477]: Playback channels: Mono Feb 21 18:24:34 bureau volumio[2477]: Mono: Playback [on] Feb 21 18:24:34 bureau volumio[2477]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Feb 21 18:24:34 bureau volumio[2477]: Unable to parse: Feb 21 18:24:34 bureau volumio[2477]: Simple mixer control 'Audio hdmi-out mute',0 Feb 21 18:24:34 bureau volumio[2477]: Capabilities: pswitch pswitch-joined Feb 21 18:24:34 bureau volumio[2477]: Playback channels: Mono Feb 21 18:24:34 bureau volumio[2477]: Mono: Playback [on] Feb 21 18:24:34 bureau volumio[2477]: info: VolumeController:: Volume=undefined Mute =false Feb 21 18:24:34 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:34 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:34 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:34 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 21 18:24:34 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:24:34 bureau volumio[2477]: info: Received Get System Info Feb 21 18:24:34 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:24:34 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:24:34 bureau volumio[2477]: info: Discovery: Getting this device information Feb 21 18:24:34 bureau volumio[2477]: info: CoreCommandRouter::volumioGetState Feb 21 18:24:34 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:34 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand add "https://systemweb-server3.de:7002/stream/1/" Feb 21 18:24:35 bureau volumio[2477]: info: Feb 21 18:24:35 bureau volumio[2477]: ---------------------------- MPD announces system playlist update Feb 21 18:24:35 bureau volumio[2477]: info: Ignoring MPD Status Update Feb 21 18:24:35 bureau volumio[2477]: info: sendMpdCommand add "https://systemweb-server3.de:7002/stream/1/" took 2 milliseconds Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand play Feb 21 18:24:35 bureau volumio[2477]: info: ------------------------------ 3ms Feb 21 18:24:35 bureau volumio[2477]: info: sendMpdCommand play took 2 milliseconds Feb 21 18:24:35 bureau volumio[2477]: info: Feb 21 18:24:35 bureau volumio[2477]: ---------------------------- MPD announces state update: player Feb 21 18:24:35 bureau volumio[2477]: info: ControllerMpd::getState Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand status Feb 21 18:24:35 bureau kernel: aml_spdif_open Feb 21 18:24:35 bureau kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Feb 21 18:24:35 bureau kernel: set normal 512 fs /4 fs Feb 21 18:24:35 bureau kernel: set spdifout clk:5644800, mpll:22579200 Feb 21 18:24:35 bureau kernel: get spdifout clk:5644797, mpll:22579186 Feb 21 18:24:35 bureau kernel: aml_dai_set_spdif_fmt , fmt 0x4010 Feb 21 18:24:35 bureau kernel: set normal 512 fs /4 fs Feb 21 18:24:35 bureau kernel: set spdifout clk:5644800, mpll:22579200 Feb 21 18:24:35 bureau kernel: get spdifout clk:5644797, mpll:22579186 Feb 21 18:24:35 bureau kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Feb 21 18:24:35 bureau kernel: aml_spdif_fifo_ctrl, bit depth:24, frddr type:4, toddr:type:4 Feb 21 18:24:35 bureau volumio[2477]: info: Feb 21 18:24:35 bureau volumio[2477]: ---------------------------- MPD announces state update: player Feb 21 18:24:35 bureau volumio[2477]: info: sendMpdCommand status took 12 milliseconds Feb 21 18:24:35 bureau volumio[2477]: info: ControllerMpd::getState Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand status Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::parseState Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 18:24:35 bureau volumio[2477]: info: sendMpdCommand status took 2 milliseconds Feb 21 18:24:35 bureau volumio[2477]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::parseState Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::parseTrackInfo Feb 21 18:24:35 bureau volumio[2477]: info: ControllerMpd::pushState Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::servicePushState Feb 21 18:24:35 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:35 bureau volumio[2477]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"https://systemweb-server3.de:7002/stream/1/","trackType":""} Feb 21 18:24:35 bureau volumio[2477]: verbose: CURRENT POSITION 0 Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::syncState stateService play Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::syncState currentStatus stop Feb 21 18:24:35 bureau volumio[2477]: info: ------------------------------ 21ms Feb 21 18:24:35 bureau volumio[2477]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::parseTrackInfo Feb 21 18:24:35 bureau volumio[2477]: info: ControllerMpd::pushState Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::servicePushState Feb 21 18:24:35 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:35 bureau volumio[2477]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"https://systemweb-server3.de:7002/stream/1/","trackType":""} Feb 21 18:24:35 bureau volumio[2477]: verbose: CURRENT POSITION 0 Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::syncState stateService play Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::syncState currentStatus play Feb 21 18:24:35 bureau volumio[2477]: info: Received an update from plugin. extracting info from payload Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:35 bureau volumio[2477]: info: ------------------------------ 32ms Feb 21 18:24:35 bureau volumio[2477]: info: Feb 21 18:24:35 bureau volumio[2477]: ---------------------------- MPD announces system playlist update Feb 21 18:24:35 bureau volumio[2477]: info: Ignoring MPD Status Update Feb 21 18:24:35 bureau volumio[2477]: info: Feb 21 18:24:35 bureau volumio[2477]: ---------------------------- MPD announces state update: player Feb 21 18:24:35 bureau volumio[2477]: info: ControllerMpd::getState Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand status Feb 21 18:24:35 bureau kernel: asoc-aml-card odroid_hdmi: S/PDIF Playback enable Feb 21 18:24:35 bureau volumio[2477]: info: Feb 21 18:24:35 bureau volumio[2477]: ---------------------------- MPD announces system playlist update Feb 21 18:24:35 bureau volumio[2477]: info: Ignoring MPD Status Update Feb 21 18:24:35 bureau volumio[2477]: info: Feb 21 18:24:35 bureau volumio[2477]: ---------------------------- MPD announces state update: player Feb 21 18:24:35 bureau volumio[2477]: info: ControllerMpd::getState Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand status Feb 21 18:24:35 bureau volumio[2477]: info: ------------------------------ 5ms Feb 21 18:24:35 bureau volumio[2477]: info: sendMpdCommand status took 3 milliseconds Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::parseState Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 18:24:35 bureau volumio[2477]: info: ------------------------------ 4ms Feb 21 18:24:35 bureau volumio[2477]: info: sendMpdCommand status took 3 milliseconds Feb 21 18:24:35 bureau volumio[2477]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::parseState Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::parseTrackInfo Feb 21 18:24:35 bureau volumio[2477]: info: ControllerMpd::pushState Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::servicePushState Feb 21 18:24:35 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:35 bureau volumio[2477]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Don't talk just kiss - Right Said Fred","artist":"Radio Contact - Ostbelgien NOW auf UKW 96,7 MHz - Livestream von Systemweb.de","album":null,"uri":"https://systemweb-server3.de:7002/stream/1/","trackType":""} Feb 21 18:24:35 bureau volumio[2477]: verbose: CURRENT POSITION 0 Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::syncState stateService play Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::syncState currentStatus play Feb 21 18:24:35 bureau volumio[2477]: info: Received an update from plugin. extracting info from payload Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:35 bureau volumio[2477]: info: ------------------------------ 30ms Feb 21 18:24:35 bureau volumio[2477]: info: sendMpdCommand playlistinfo took 23 milliseconds Feb 21 18:24:35 bureau volumio[2477]: verbose: ControllerMpd::parseTrackInfo Feb 21 18:24:35 bureau volumio[2477]: info: ControllerMpd::pushState Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::servicePushState Feb 21 18:24:35 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:35 bureau volumio[2477]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Don't talk just kiss - Right Said Fred","artist":"Radio Contact - Ostbelgien NOW auf UKW 96,7 MHz - Livestream von Systemweb.de","album":null,"uri":"https://systemweb-server3.de:7002/stream/1/","trackType":""} Feb 21 18:24:35 bureau volumio[2477]: verbose: CURRENT POSITION 0 Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::syncState stateService play Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::syncState currentStatus play Feb 21 18:24:35 bureau volumio[2477]: info: Received an update from plugin. extracting info from payload Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:35 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:35 bureau volumio[2477]: info: ------------------------------ 48ms Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:24:35 bureau volumio[2477]: info: Received Get System Info Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:24:35 bureau volumio[2477]: info: Discovery: Getting this device information Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::volumioGetState Feb 21 18:24:35 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:24:37 bureau go-librespot[3442]: time="2025-02-21T18:24:37+01:00" level=trace msg="sent dealer ping" Feb 21 18:24:37 bureau go-librespot[3442]: time="2025-02-21T18:24:37+01:00" level=trace msg="received dealer pong" Feb 21 18:24:39 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Feb 21 18:24:39 bureau volumio[2477]: info: Feb 21 18:24:39 bureau volumio[2477]: ---------------------------- MPD announces system playlist update Feb 21 18:24:39 bureau volumio[2477]: info: Ignoring MPD Status Update Feb 21 18:24:39 bureau volumio[2477]: info: Feb 21 18:24:39 bureau volumio[2477]: ---------------------------- MPD announces state update: player Feb 21 18:24:39 bureau volumio[2477]: info: ControllerMpd::getState Feb 21 18:24:39 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand status Feb 21 18:24:39 bureau volumio[2477]: info: ------------------------------ 3ms Feb 21 18:24:39 bureau volumio[2477]: info: sendMpdCommand status took 3 milliseconds Feb 21 18:24:39 bureau volumio[2477]: verbose: ControllerMpd::parseState Feb 21 18:24:39 bureau volumio[2477]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 18:24:39 bureau volumio[2477]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 21 18:24:39 bureau volumio[2477]: verbose: ControllerMpd::parseTrackInfo Feb 21 18:24:39 bureau volumio[2477]: info: ControllerMpd::pushState Feb 21 18:24:39 bureau volumio[2477]: info: CoreCommandRouter::servicePushState Feb 21 18:24:39 bureau volumio[2477]: info: CorePlayQueue::getTrack 0 Feb 21 18:24:39 bureau volumio[2477]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5235,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Forever Young - David Guetta, Alphaville & Ava Max","artist":"Radio Contact - Ostbelgien NOW auf UKW 96,7 MHz - Livestream von Systemweb.de","album":null,"uri":"https://systemweb-server3.de:7002/stream/1/","trackType":""} Feb 21 18:24:39 bureau volumio[2477]: verbose: CURRENT POSITION 0 Feb 21 18:24:39 bureau volumio[2477]: info: CoreStateMachine::syncState stateService play Feb 21 18:24:39 bureau volumio[2477]: info: CoreStateMachine::syncState currentStatus play Feb 21 18:24:39 bureau volumio[2477]: info: Received an update from plugin. extracting info from payload Feb 21 18:24:39 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:39 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:39 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:39 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:39 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:39 bureau volumio[2477]: info: ------------------------------ 26ms Feb 21 18:24:40 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:40 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:40 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:40 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:40 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 1 Feb 21 18:24:40 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 100 Feb 21 18:24:40 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 1 Feb 21 18:24:40 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:40 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 1 Feb 21 18:24:41 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:41 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:41 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:41 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:41 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 2 Feb 21 18:24:41 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 1 Feb 21 18:24:41 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 2 Feb 21 18:24:41 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:41 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:41 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:41 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:41 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:41 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 3 Feb 21 18:24:41 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 1 Feb 21 18:24:41 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 3 Feb 21 18:24:41 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:41 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 3 Feb 21 18:24:42 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:42 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:42 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:42 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 4 Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 3 Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 4 Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:42 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:42 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:42 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:42 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 5 Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 3 Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 5 Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:42 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 5 Feb 21 18:24:42 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:42 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:42 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:42 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 6 Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 5 Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 6 Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:42 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:42 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:42 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:42 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 7 Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 5 Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 7 Feb 21 18:24:42 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:42 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 7 Feb 21 18:24:43 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:43 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:43 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:43 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:43 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 8 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 7 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 8 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:43 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:43 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:43 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:43 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 9 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 7 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 9 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:43 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 9 Feb 21 18:24:43 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:43 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:43 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:43 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 9 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 10 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:43 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:43 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:43 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:43 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 11 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 9 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 11 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:43 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 11 Feb 21 18:24:43 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:43 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:43 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:43 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 12 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 11 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 12 Feb 21 18:24:43 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:43 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:44 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:44 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:44 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 13 Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 11 Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 13 Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:44 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 13 Feb 21 18:24:44 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:44 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:44 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:44 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 14 Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 13 Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 14 Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:44 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:44 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:44 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:44 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 15 Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 13 Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 15 Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:44 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 15 Feb 21 18:24:44 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:44 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:44 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:44 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 16 Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 15 Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 16 Feb 21 18:24:44 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:44 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:44 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:44 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:44 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 15 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 17 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:45 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 17 Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 18 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 17 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 18 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 17 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 19 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:45 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 19 Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 19 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 20 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 21 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 19 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 21 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:45 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 21 Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 21 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 22 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 21 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 23 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:45 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 23 Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 23 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 24 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 25 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 23 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 25 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:45 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 25 Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 25 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 26 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 27 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 25 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 27 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:45 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 27 Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 28 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 27 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 28 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 29 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 27 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 29 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:45 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 29 Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 30 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 29 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 30 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 32 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 29 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 32 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:45 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 32 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 32 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 33 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 32 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 33 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 32 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 34 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:45 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 34 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 34 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 35 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 34 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 36 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:45 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 36 Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 37 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 36 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 37 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 38 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 36 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 38 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:45 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 38 Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:45 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:45 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 39 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 38 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 39 Feb 21 18:24:45 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:45 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 38 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 40 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:46 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 40 Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 40 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 41 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 42 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 40 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 42 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:46 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 42 Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 43 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 42 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 43 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 44 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 42 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 44 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:46 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 44 Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 45 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 44 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 45 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 44 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 46 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:46 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 46 Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 46 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 47 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 46 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 48 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:46 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 48 Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 49 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 48 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 49 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 48 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 50 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:46 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 50 Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 50 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 51 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 52 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 50 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 52 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:46 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 52 Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 53 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 52 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 53 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 54 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 52 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 54 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:46 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 54 Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 55 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 54 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 55 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 54 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 56 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:46 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 56 Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 57 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 56 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 57 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 56 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 58 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:46 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 58 Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 58 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 59 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 58 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 60 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:46 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 60 Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 60 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 61 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 60 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 62 Feb 21 18:24:46 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:46 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 62 Feb 21 18:24:46 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:46 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:46 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 63 Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 62 Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 63 Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:47 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:47 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:47 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:47 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 62 Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 64 Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:47 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 64 Feb 21 18:24:47 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:47 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:47 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:47 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 64 Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 65 Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:47 bureau volumio[2477]: info: VolumeController::SetAlsaVolume+ Feb 21 18:24:47 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:47 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:47 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 64 Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 66 Feb 21 18:24:47 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:47 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 66 Feb 21 18:24:47 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:24:47 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:24:47 bureau volumio[2477]: info: Discovery: Getting this device information Feb 21 18:24:47 bureau volumio[2477]: info: CoreCommandRouter::volumioGetState Feb 21 18:24:47 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: SETTING SPOTIFY VOLUME 66 Feb 21 18:24:48 bureau volumio[2477]: info: Sending Spotify command with payload to local API: /player/volume Feb 21 18:24:48 bureau go-librespot[3442]: time="2025-02-21T18:24:48+01:00" level=debug msg="update volume to 43253/65535" Feb 21 18:24:48 bureau volumio[2477]: info: VolumeController::SetAlsaVolume- Feb 21 18:24:48 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:48 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:48 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 66 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 65 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:48 bureau volumio[2477]: info: VolumeController::SetAlsaVolume- Feb 21 18:24:48 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:48 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:48 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 66 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 64 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:48 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 64 Feb 21 18:24:48 bureau volumio[2477]: info: VolumeController::SetAlsaVolume- Feb 21 18:24:48 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:48 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:48 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 63 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 64 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 63 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:48 bureau volumio[2477]: info: VolumeController::SetAlsaVolume- Feb 21 18:24:48 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:48 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:48 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 64 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 62 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 21 18:24:48 bureau volumio[2477]: info: Setting Spotify Volume from Volumio: 62 Feb 21 18:24:48 bureau volumio[2477]: info: VolumeController::SetAlsaVolume- Feb 21 18:24:48 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:48 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:48 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: SPOTIFY VOLUME 62 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: VOLUMIO VOLUME 61 Feb 21 18:24:48 bureau volumio[2477]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 21 18:24:49 bureau go-librespot[3442]: time="2025-02-21T18:24:49+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Feb 21 18:24:49 bureau go-librespot[3442]: time="2025-02-21T18:24:49+01:00" level=trace msg="emitting websocket event: volume" Feb 21 18:24:49 bureau volumio[2477]: SPOTIFY: received: {"type":"volume","data":{"value":66,"max":100}} Feb 21 18:24:49 bureau volumio[2477]: SPOTIFY: RECEIVED SPOTIFY VOLUME 66 Feb 21 18:24:49 bureau volumio[2477]: info: Setting Volumio Volume from Spotify: 66 Feb 21 18:24:49 bureau volumio[2477]: info: VolumeController::SetAlsaVolume66 Feb 21 18:24:49 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:49 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:49 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:49 bureau volumio[2477]: SPOTIFY: received: {"type":"volume","data":{"value":66,"max":100}} Feb 21 18:24:49 bureau volumio[2477]: SPOTIFY: RECEIVED SPOTIFY VOLUME 66 Feb 21 18:24:49 bureau volumio[2477]: SPOTIFY: received: {"type":"volume","data":{"value":66,"max":100}} Feb 21 18:24:49 bureau volumio[2477]: SPOTIFY: RECEIVED SPOTIFY VOLUME 66 Feb 21 18:24:49 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Feb 21 18:24:50 bureau volumio[2477]: SPOTIFY: SETTING SPOTIFY VOLUME 62 Feb 21 18:24:50 bureau volumio[2477]: info: Sending Spotify command with payload to local API: /player/volume Feb 21 18:24:50 bureau go-librespot[3442]: time="2025-02-21T18:24:50+01:00" level=debug msg="update volume to 40631/65535" Feb 21 18:24:51 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 21 18:24:51 bureau volumio[2477]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 21 18:24:51 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 21 18:24:51 bureau volumio[2477]: info: Received Get System Version Feb 21 18:24:51 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 18:24:51 bureau volumio[2477]: info: Received Get System Info Feb 21 18:24:51 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:24:51 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:24:51 bureau volumio[2477]: info: Discovery: Getting this device information Feb 21 18:24:51 bureau volumio[2477]: info: CoreCommandRouter::volumioGetState Feb 21 18:24:51 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:24:51 bureau go-librespot[3442]: time="2025-02-21T18:24:51+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Feb 21 18:24:51 bureau go-librespot[3442]: time="2025-02-21T18:24:51+01:00" level=trace msg="emitting websocket event: volume" Feb 21 18:24:51 bureau volumio[2477]: SPOTIFY: received: {"type":"volume","data":{"value":62,"max":100}} Feb 21 18:24:51 bureau volumio[2477]: SPOTIFY: RECEIVED SPOTIFY VOLUME 62 Feb 21 18:24:51 bureau volumio[2477]: info: Setting Volumio Volume from Spotify: 62 Feb 21 18:24:51 bureau volumio[2477]: info: VolumeController::SetAlsaVolume62 Feb 21 18:24:51 bureau volumio[2477]: info: CoreStateMachine::pushState Feb 21 18:24:51 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:24:51 bureau volumio[2477]: info: CoreCommandRouter::volumioPushState Feb 21 18:24:51 bureau volumio[2477]: SPOTIFY: received: {"type":"volume","data":{"value":62,"max":100}} Feb 21 18:24:51 bureau volumio[2477]: SPOTIFY: RECEIVED SPOTIFY VOLUME 62 Feb 21 18:24:51 bureau volumio[2477]: SPOTIFY: received: {"type":"volume","data":{"value":62,"max":100}} Feb 21 18:24:51 bureau volumio[2477]: SPOTIFY: RECEIVED SPOTIFY VOLUME 62 Feb 21 18:24:51 bureau volumio[2477]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:54 bureau volumio[2477]: info: Retrieving Cloud Streaming UI Feb 21 18:24:54 bureau volumio[2477]: info: Getting Tidal Cloud Configuration Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:54 bureau volumio[2477]: info: Getting Qobuz Cloud Configuration Feb 21 18:24:54 bureau volumio[2477]: info: Asking plugin for UI Config Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:54 bureau volumio[2477]: info: Getting Spotify Cloud Configuration Feb 21 18:24:54 bureau volumio[2477]: info: Asking plugin for UI Config Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:54 bureau volumio[2477]: info: Saving Spotify Acccount Feb 21 18:24:54 bureau volumio[2477]: info: Got Tidal Cloud Configuration Feb 21 18:24:54 bureau volumio[2477]: info: Got it Feb 21 18:24:54 bureau volumio[2477]: info: Got it Feb 21 18:24:54 bureau volumio[2477]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:24:54 bureau volumio[2477]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::volumioGetBrowseSources Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::volumioGetBrowseSources Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::volumioGetBrowseSources Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 21 18:24:54 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 21 18:24:57 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Feb 21 18:24:57 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 18:24:57 bureau systemd[1]: systemd-timedated.service: Succeeded. Feb 21 18:24:57 bureau volumio-remote-updater[2278]: No test mode Feb 21 18:24:57 bureau volumio-remote-updater[2278]: No alpha test mode Feb 21 18:24:57 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 21 18:24:57 bureau volumio[2477]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 21 18:24:57 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 21 18:24:58 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 21 18:24:59 bureau volumio[2477]: info: Disabling MyMusic plugin upnp Feb 21 18:24:59 bureau sudo[4415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Feb 21 18:24:59 bureau sudo[4415]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 18:25:00 bureau systemd[1]: Stopping UPnP Renderer front-end to MPD... Feb 21 18:25:00 bureau volumio[2477]: error: Upnp client error: Error: This socket has been ended by the other party Feb 21 18:25:00 bureau volumio[2477]: info: Enabling MyMusic plugin upnp Feb 21 18:25:00 bureau volumio[2477]: info: Enabling plugin upnp Feb 21 18:25:00 bureau volumio[2477]: info: Loading plugin "upnp"... Feb 21 18:25:00 bureau volumio[2477]: info: [1740158700524] Starting Upmpd Daemon Feb 21 18:25:00 bureau volumio[2477]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 21 18:25:00 bureau volumio[2477]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 18:25:00 bureau volumio[2477]: Error: listen EADDRINUSE: address already in use :::6599 Feb 21 18:25:00 bureau volumio[2477]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Feb 21 18:25:00 bureau volumio[2477]: at listenInCluster (net.js:1379:12) Feb 21 18:25:00 bureau volumio[2477]: at Server.listen (net.js:1465:7) Feb 21 18:25:00 bureau volumio[2477]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Feb 21 18:25:00 bureau volumio[2477]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Feb 21 18:25:00 bureau volumio[2477]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Feb 21 18:25:00 bureau volumio[2477]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 21 18:25:00 bureau volumio[2477]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Feb 21 18:25:00 bureau volumio[2477]: code: 'EADDRINUSE', Feb 21 18:25:00 bureau volumio[2477]: errno: -98, Feb 21 18:25:00 bureau volumio[2477]: syscall: 'listen', Feb 21 18:25:00 bureau volumio[2477]: address: '::', Feb 21 18:25:00 bureau volumio[2477]: port: 6599 Feb 21 18:25:00 bureau volumio[2477]: } Feb 21 18:25:00 bureau volumio[2477]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 18:25:00 bureau sudo[4426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-21 18:24 Feb 21 18:25:00 bureau sudo[4426]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Sep 2024 11:32:28 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="odroidc4" VOLUMIO_DEVICENAME="Odroid-C4" VOLUMIO_HASH="bcf63729a67a1fb0048ee35bec188024"