-- Logs begin at Thu 2025-02-20 23:07:28 EET, end at Thu 2025-02-20 23:34:16 EET. --
Feb 20 23:33:04 fcm go-librespot[1761]: time="2025-02-20T23:33:04+02:00" level=trace msg="sent dealer ping"
Feb 20 23:33:04 fcm go-librespot[1761]: time="2025-02-20T23:33:04+02:00" level=trace msg="received dealer pong"
Feb 20 23:33:06 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 20 23:33:06 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 20 23:33:06 fcm volumio[1299]: info: Discovery: Getting this device information
Feb 20 23:33:06 fcm volumio[1299]: info: CoreCommandRouter::volumioGetState
Feb 20 23:33:06 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 20 23:33:08 fcm volumio[1299]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 20 23:33:09 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 20 23:33:09 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Feb 20 23:33:09 fcm sudo[5950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Feb 20 23:33:09 fcm sudo[5950]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 20 23:33:09 fcm sudo[5950]: pam_unix(sudo:session): session closed for user root
Feb 20 23:33:09 fcm sudo[5956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Feb 20 23:33:09 fcm sudo[5956]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 20 23:33:09 fcm sudo[5956]: pam_unix(sudo:session): session closed for user root
Feb 20 23:33:09 fcm sudo[5965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Feb 20 23:33:09 fcm sudo[5965]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 20 23:33:09 fcm sudo[5965]: pam_unix(sudo:session): session closed for user root
Feb 20 23:33:09 fcm sudo[5970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Feb 20 23:33:09 fcm sudo[5970]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 20 23:33:09 fcm sudo[5970]: pam_unix(sudo:session): session closed for user root
Feb 20 23:33:09 fcm sudo[5976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 20 23:33:09 fcm sudo[5976]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 20 23:33:09 fcm sudo[5976]: pam_unix(sudo:session): session closed for user root
Feb 20 23:33:09 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Feb 20 23:33:09 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Feb 20 23:33:09 fcm sudo[5979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 20 23:33:09 fcm sudo[5979]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 20 23:33:09 fcm sudo[5979]: pam_unix(sudo:session): session closed for user root
Feb 20 23:33:09 fcm sudo[5982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Feb 20 23:33:09 fcm sudo[5982]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 20 23:33:10 fcm sudo[5982]: pam_unix(sudo:session): session closed for user root
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:19 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:19 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:19 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:19 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:19 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:19 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:19 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:19 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:19 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:19 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:19 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:19 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:19 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::servicePushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:20 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:20 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:20 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:20 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:20 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:20 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:20 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:20 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:20 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:20 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:20 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:20 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:20 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Feb 20 23:33:21 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:21 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:21 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:21 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:21 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 99
Feb 20 23:33:21 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 100
Feb 20 23:33:21 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 99
Feb 20 23:33:21 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:21 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:21 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:21 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:21 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:21 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Feb 20 23:33:21 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 100
Feb 20 23:33:21 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 98
Feb 20 23:33:21 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:21 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 98
Feb 20 23:33:22 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:22 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:22 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:22 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 97
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 98
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 97
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:22 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:22 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:22 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:22 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 96
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 98
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 96
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:22 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 96
Feb 20 23:33:22 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:22 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:22 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:22 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 96
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 95
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:22 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:22 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:22 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:22 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 96
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 94
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:22 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 94
Feb 20 23:33:22 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:22 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:22 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:22 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 94
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 93
Feb 20 23:33:22 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:23 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:23 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:23 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:23 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:23 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 92
Feb 20 23:33:23 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 94
Feb 20 23:33:23 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 92
Feb 20 23:33:23 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:23 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 92
Feb 20 23:33:25 fcm volumio[1299]: SPOTIFY: SETTING SPOTIFY VOLUME 92
Feb 20 23:33:25 fcm volumio[1299]: info: Sending Spotify command with payload to local API: /player/volume
Feb 20 23:33:25 fcm go-librespot[1761]: time="2025-02-20T23:33:25+02:00" level=debug msg="update volume to 60292/65535"
Feb 20 23:33:26 fcm go-librespot[1761]: time="2025-02-20T23:33:26+02:00" level=debug msg="put connect state because VOLUME_CHANGED"
Feb 20 23:33:26 fcm go-librespot[1761]: time="2025-02-20T23:33:26+02:00" level=trace msg="emitting websocket event: volume"
Feb 20 23:33:26 fcm volumio[1299]: SPOTIFY: received: {"type":"volume","data":{"value":92,"max":100}}
Feb 20 23:33:26 fcm volumio[1299]: SPOTIFY: RECEIVED SPOTIFY VOLUME 92
Feb 20 23:33:28 fcm volumio[1299]: info: VolumeController::SetAlsaVolume+
Feb 20 23:33:28 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:28 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:28 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:28 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93
Feb 20 23:33:28 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 92
Feb 20 23:33:28 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 93
Feb 20 23:33:28 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:29 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:29 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:29 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:29 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:29 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 92
Feb 20 23:33:29 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:29 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:29 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:29 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:29 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 91
Feb 20 23:33:29 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 92
Feb 20 23:33:29 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 91
Feb 20 23:33:29 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:30 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:30 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:30 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:30 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:30 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
Feb 20 23:33:30 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 92
Feb 20 23:33:30 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 90
Feb 20 23:33:30 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:30 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 90
Feb 20 23:33:30 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:30 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:30 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:30 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:30 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 89
Feb 20 23:33:30 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 90
Feb 20 23:33:30 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 89
Feb 20 23:33:30 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:30 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:30 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:30 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:30 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:30 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 88
Feb 20 23:33:30 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 90
Feb 20 23:33:30 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 88
Feb 20 23:33:30 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:30 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 88
Feb 20 23:33:31 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:31 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:31 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:31 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:31 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 87
Feb 20 23:33:31 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 88
Feb 20 23:33:31 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 87
Feb 20 23:33:31 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:32 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:32 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 88
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 86
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:32 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 86
Feb 20 23:33:32 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:32 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 86
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 85
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:32 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:32 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:32 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:32 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 86
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 84
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:32 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 84
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 84
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 83
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:32 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:32 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:32 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:32 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 84
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 82
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:32 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 82
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 82
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 81
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:32 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:32 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:32 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:32 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 82
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 80
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:32 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 80
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 80
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 79
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:32 fcm volumio[1299]: info: VolumeController::SetAlsaVolume+
Feb 20 23:33:32 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:32 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:32 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80
Feb 20 23:33:33 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:33 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 80
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 79
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:33 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:33 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 80
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 78
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:33 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 78
Feb 20 23:33:33 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:33 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 77
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 78
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 77
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:33 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:33 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 78
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 76
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:33 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 76
Feb 20 23:33:33 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:33 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:33 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:33 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 76
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 75
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 76
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 74
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:33 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 74
Feb 20 23:33:33 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:33 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:33 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:33 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 74
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 73
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 72
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 74
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 72
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:33 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 72
Feb 20 23:33:33 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:33 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:33 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:33 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 71
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 72
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 71
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 72
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 70
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:33 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 70
Feb 20 23:33:33 fcm volumio[1299]: info: VolumeController::SetAlsaVolume+
Feb 20 23:33:33 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 71
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 70
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 71
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:33 fcm volumio[1299]: info: VolumeController::SetAlsaVolume+
Feb 20 23:33:33 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:33 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 72
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 70
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 72
Feb 20 23:33:33 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: true
Feb 20 23:33:33 fcm volumio[1299]: info: Setting Spotify Volume from Volumio: 72
Feb 20 23:33:34 fcm go-librespot[1761]: time="2025-02-20T23:33:34+02:00" level=trace msg="sent dealer ping"
Feb 20 23:33:34 fcm go-librespot[1761]: time="2025-02-20T23:33:34+02:00" level=trace msg="received dealer pong"
Feb 20 23:33:35 fcm volumio[1299]: SPOTIFY: SETTING SPOTIFY VOLUME 72
Feb 20 23:33:35 fcm volumio[1299]: info: Sending Spotify command with payload to local API: /player/volume
Feb 20 23:33:35 fcm go-librespot[1761]: time="2025-02-20T23:33:35+02:00" level=debug msg="update volume to 47185/65535"
Feb 20 23:33:36 fcm go-librespot[1761]: time="2025-02-20T23:33:36+02:00" level=debug msg="put connect state because VOLUME_CHANGED"
Feb 20 23:33:36 fcm go-librespot[1761]: time="2025-02-20T23:33:36+02:00" level=trace msg="emitting websocket event: volume"
Feb 20 23:33:36 fcm volumio[1299]: SPOTIFY: received: {"type":"volume","data":{"value":72,"max":100}}
Feb 20 23:33:36 fcm volumio[1299]: SPOTIFY: RECEIVED SPOTIFY VOLUME 72
Feb 20 23:33:36 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 20 23:33:36 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 20 23:33:36 fcm volumio[1299]: info: Discovery: Getting this device information
Feb 20 23:33:36 fcm volumio[1299]: info: CoreCommandRouter::volumioGetState
Feb 20 23:33:36 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 20 23:33:46 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:46 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:46 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:46 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:46 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 71
Feb 20 23:33:46 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 72
Feb 20 23:33:46 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 71
Feb 20 23:33:46 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:47 fcm volumio[1299]: info: VolumeController::SetAlsaVolume+
Feb 20 23:33:47 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:47 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:47 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:47 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 72
Feb 20 23:33:47 fcm volumio[1299]: info: VolumeController::SetAlsaVolume+
Feb 20 23:33:47 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:47 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:47 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:47 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73
Feb 20 23:33:47 fcm volumio[1299]: SPOTIFY: SPOTIFY VOLUME 72
Feb 20 23:33:47 fcm volumio[1299]: SPOTIFY: VOLUMIO VOLUME 73
Feb 20 23:33:47 fcm volumio[1299]: SPOTIFY: DELTA VOLUME ENOUGH: false
Feb 20 23:33:50 fcm volumio[1299]: info: VolumeController::SetAlsaVolume-
Feb 20 23:33:50 fcm volumio[1299]: info: CoreStateMachine::pushState
Feb 20 23:33:50 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 20 23:33:50 fcm volumio[1299]: info: CoreCommandRouter::volumioPushState
Feb 20 23:33:50 fcm volumio[1299]: SPOTIFY: RECEIVED VOLUMIO VOLUME 72
Feb 20 23:34:00 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: alarm-clock , getSleep
Feb 20 23:34:04 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: alarm-clock , setSleep
Feb 20 23:34:04 fcm volumio[1299]: info: [1740087244580] SetSleep: 0 hours 0 minutes , enabled: false
Feb 20 23:34:04 fcm go-librespot[1761]: time="2025-02-20T23:34:04+02:00" level=trace msg="received accesspoint ping"
Feb 20 23:34:04 fcm go-librespot[1761]: time="2025-02-20T23:34:04+02:00" level=trace msg="received accesspoint pong ack"
Feb 20 23:34:04 fcm go-librespot[1761]: time="2025-02-20T23:34:04+02:00" level=trace msg="sent dealer ping"
Feb 20 23:34:04 fcm go-librespot[1761]: time="2025-02-20T23:34:04+02:00" level=trace msg="received dealer pong"
Feb 20 23:34:06 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 20 23:34:06 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 20 23:34:06 fcm volumio[1299]: info: Discovery: Getting this device information
Feb 20 23:34:06 fcm volumio[1299]: info: CoreCommandRouter::volumioGetState
Feb 20 23:34:06 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 20 23:34:10 fcm volumio[1299]: info: Retrieving Cloud Streaming UI
Feb 20 23:34:10 fcm volumio[1299]: info: Getting Tidal Cloud Configuration
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 20 23:34:10 fcm volumio[1299]: info: Getting Qobuz Cloud Configuration
Feb 20 23:34:10 fcm volumio[1299]: info: Asking plugin for UI Config
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 20 23:34:10 fcm volumio[1299]: info: Getting Spotify Cloud Configuration
Feb 20 23:34:10 fcm volumio[1299]: info: Asking plugin for UI Config
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 20 23:34:10 fcm volumio[1299]: info: Saving Spotify Acccount
Feb 20 23:34:10 fcm volumio[1299]: info: Got Tidal Cloud Configuration
Feb 20 23:34:10 fcm volumio[1299]: info: Got it
Feb 20 23:34:10 fcm volumio[1299]: info: Got it
Feb 20 23:34:10 fcm volumio[1299]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 20 23:34:10 fcm volumio[1299]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 20 23:34:10 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Feb 20 23:34:14 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 20 23:34:15 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Feb 20 23:34:15 fcm volumio[1299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Feb 20 23:34:15 fcm volumio[1299]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 20 23:34:15 fcm volumio[1299]: Error: getaddrinfo -3007
Feb 20 23:34:15 fcm volumio[1299]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Feb 20 23:34:15 fcm volumio[1299]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Feb 20 23:34:15 fcm volumio[1299]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Feb 20 23:34:15 fcm volumio[1299]: code: -3007,
Feb 20 23:34:15 fcm volumio[1299]: errno: -3007,
Feb 20 23:34:15 fcm volumio[1299]: syscall: 'getaddrinfo'
Feb 20 23:34:15 fcm volumio[1299]: }
Feb 20 23:34:15 fcm volumio[1299]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 20 23:34:16 fcm sudo[6202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-20 23:33
Feb 20 23:34:16 fcm sudo[6202]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"