-- Logs begin at Sat 2024-07-13 22:47:15 CST, end at Sat 2024-07-13 23:00:51 CST. --
Jul 13 22:59:15 volumio volumio[859]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object]
Jul 13 22:59:15 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions
Jul 13 22:59:15 volumio volumio[859]: info: CoreCommandRouter::volumioGetState
Jul 13 22:59:15 volumio volumio[859]: info: Restoring Previous Volume level: 0 false true
Jul 13 22:59:15 volumio volumio[859]: info: VolumeController::SetAlsaVolume100
Jul 13 22:59:15 volumio volumio[859]: info: Volume configurations have been set
Jul 13 22:59:15 volumio volumio[859]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Jul 13 22:59:15 volumio volumio[859]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Jul 13 22:59:15 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Jul 13 22:59:15 volumio volumio[859]: info: Disabling external Volume Control
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 13 22:59:16 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 22:59:16 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jul 13 22:59:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 13 22:59:20 volumio volumio[859]: info: VolumeController::SetAlsaVolume0
Jul 13 22:59:20 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 22:59:20 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 22:59:20 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 22:59:20 volumio volumio[859]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command!
Jul 13 22:59:50 volumio volumio[859]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object]
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::volumioGetState
Jul 13 22:59:50 volumio volumio[859]: info: Disable softmixer device for audio device
Jul 13 22:59:50 volumio volumio[859]: info: Output device has changed, restarting MPD
Jul 13 22:59:50 volumio sudo[1872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 13 22:59:50 volumio sudo[1872]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 22:59:50 volumio volumio[859]: info: Output device has changed, restarting Shairport Sync
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 22:59:50 volumio sudo[1872]: pam_unix(sudo:session): session closed for user root
Jul 13 22:59:50 volumio sudo[1875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 13 22:59:50 volumio sudo[1875]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 22:59:50 volumio systemd[1]: Stopping Music Player Daemon...
Jul 13 22:59:50 volumio volumio[859]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 13 22:59:50 volumio volumio[859]: info: Restoring Previous Volume level: 0 false false
Jul 13 22:59:50 volumio volumio[859]: info: Volume configurations have been set
Jul 13 22:59:50 volumio systemd[1]: mpd.service: Succeeded.
Jul 13 22:59:50 volumio systemd[1]: Stopped Music Player Daemon.
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Jul 13 22:59:50 volumio volumio[859]: info: Updating Volume Controller Parameters: Device: 5 Name: xCORE USB Audio 2.0 Mixer: xCORE USB Audio 2.0 Output Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Jul 13 22:59:50 volumio volumio[859]: info: Disabling external Volume Control
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 13 22:59:50 volumio volumio[859]: info: Soft Volume ALSA configuration file deleted
Jul 13 22:59:50 volumio volumio[859]: info: Preparing to generate the ALSA configuration file
Jul 13 22:59:50 volumio volumio[859]: info: MPD Permissions set
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio systemd[1]: Starting Music Player Daemon...
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jul 13 22:59:50 volumio sudo[1882]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 22:59:50 volumio sudo[1882]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 13 22:59:50 volumio sudo[1882]: pam_unix(sudo:session): session closed for user root
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 13 22:59:50 volumio volumio[859]: info: VolumeController:: Volume=100 Mute =false
Jul 13 22:59:50 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 22:59:50 volumio volumio[859]: info: Starting Shairport Sync
Jul 13 22:59:50 volumio sudo[1896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 13 22:59:50 volumio sudo[1896]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 22:59:50 volumio volumio[859]: info: Asound.conf file written
Jul 13 22:59:50 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 13 22:59:50 volumio systemd[1]: shairport-sync.service: Succeeded.
Jul 13 22:59:50 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 13 22:59:50 volumio sudo[1899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jul 13 22:59:50 volumio sudo[1899]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 22:59:50 volumio sudo[1899]: pam_unix(sudo:session): session closed for user root
Jul 13 22:59:50 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 13 22:59:50 volumio volumio[859]: No state is present for card x20
Jul 13 22:59:50 volumio volumio[859]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:000a" "" ""
Jul 13 22:59:50 volumio volumio[859]: Hardware is initialized using a generic method
Jul 13 22:59:50 volumio volumio[859]: No state is present for card x20
Jul 13 22:59:50 volumio volumio[859]: info: Output device has changed, restarting MPD
Jul 13 22:59:50 volumio sudo[1896]: pam_unix(sudo:session): session closed for user root
Jul 13 22:59:50 volumio sudo[1906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 13 22:59:50 volumio sudo[1906]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 22:59:50 volumio volumio[859]: info: Output device has changed, restarting Shairport Sync
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 22:59:50 volumio sudo[1906]: pam_unix(sudo:session): session closed for user root
Jul 13 22:59:50 volumio sudo[1911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 13 22:59:50 volumio sudo[1911]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 22:59:50 volumio volumio[859]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 13 22:59:50 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jul 13 22:59:50 volumio systemd[1]: mpd.service: Succeeded.
Jul 13 22:59:50 volumio systemd[1]: Stopped Music Player Daemon.
Jul 13 22:59:50 volumio volumio[859]: info: MPD Permissions set
Jul 13 22:59:50 volumio volumio[859]: info: Shairport-Sync Started
Jul 13 22:59:50 volumio systemd[1]: Starting Music Player Daemon...
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 22:59:50 volumio volumio[859]: info: Starting Shairport Sync
Jul 13 22:59:50 volumio sudo[1922]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 13 22:59:50 volumio sudo[1922]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 22:59:50 volumio sudo[1916]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 13 22:59:50 volumio sudo[1916]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 22:59:50 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 13 22:59:50 volumio sudo[1916]: pam_unix(sudo:session): session closed for user root
Jul 13 22:59:50 volumio systemd[1]: shairport-sync.service: Succeeded.
Jul 13 22:59:50 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 13 22:59:50 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 13 22:59:50 volumio sudo[1922]: pam_unix(sudo:session): session closed for user root
Jul 13 22:59:50 volumio volumio[859]: info: Shairport-Sync Started
Jul 13 22:59:51 volumio mpd[1925]: Jul 13 22:59 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 13 22:59:51 volumio systemd[1]: Started Music Player Daemon.
Jul 13 22:59:51 volumio sudo[1875]: pam_unix(sudo:session): session closed for user root
Jul 13 22:59:51 volumio sudo[1911]: pam_unix(sudo:session): session closed for user root
Jul 13 22:59:51 volumio volumio[859]: error: MPD error: The expression evaluated to a falsy value:
Jul 13 22:59:51 volumio volumio[859]: assert.ok(self.idling)
Jul 13 22:59:51 volumio volumio[859]: error: The expression evaluated to a falsy value:
Jul 13 22:59:51 volumio volumio[859]: assert.ok(self.idling)
Jul 13 22:59:51 volumio volumio[859]: error: updateQueue error: null
Jul 13 22:59:54 volumio volumio[859]: info: VolumeController::SetAlsaVolume0
Jul 13 22:59:54 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 22:59:54 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 22:59:54 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 22:59:59 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 22:59:59 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 22:59:59 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 22:59:59 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 22:59:59 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 22:59:59 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 22:59:59 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 22:59:59 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:00 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:00 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:00 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:00 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:00 volumio volumio[859]: info: VolumeController::SetAlsaVolume10
Jul 13 23:00:00 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:00 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:00 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:01 volumio volumio[859]: info: VolumeController::SetAlsaVolume35
Jul 13 23:00:01 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:01 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:01 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:01 volumio volumio[859]: info: VolumeController::SetAlsaVolume50
Jul 13 23:00:01 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:01 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:01 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:03 volumio volumio[859]: info: VolumeController::SetAlsaVolume55
Jul 13 23:00:03 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:03 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:03 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:03 volumio volumio[859]: info: VolumeController::SetAlsaVolume75
Jul 13 23:00:03 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:03 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:03 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:04 volumio volumio[859]: info: VolumeController::SetAlsaVolume85
Jul 13 23:00:04 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:04 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:04 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:04 volumio volumio[859]: info: VolumeController::SetAlsaVolume80
Jul 13 23:00:04 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:04 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:04 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:04 volumio volumio[859]: info: VolumeController::SetAlsaVolume65
Jul 13 23:00:04 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:04 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:04 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:04 volumio volumio[859]: info: VolumeController::SetAlsaVolume50
Jul 13 23:00:04 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:04 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:04 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:20 volumio volumio[859]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object]
Jul 13 23:00:20 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions
Jul 13 23:00:20 volumio volumio[859]: info: CoreCommandRouter::volumioGetState
Jul 13 23:00:20 volumio volumio[859]: info: Restoring Previous Volume level: 50 false true
Jul 13 23:00:20 volumio volumio[859]: info: VolumeController::SetAlsaVolume100
Jul 13 23:00:20 volumio volumio[859]: info: Enable softmixer device for audio device number 5
Jul 13 23:00:20 volumio volumio[859]: info: CoreCommandRouter::volumioStop
Jul 13 23:00:20 volumio volumio[859]: info: CoreStateMachine::stop
Jul 13 23:00:20 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 13 23:00:20 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer
Jul 13 23:00:20 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock
Jul 13 23:00:20 volumio volumio[859]: info: CorePlayQueue::getTrackBlock
Jul 13 23:00:20 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:20 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:20 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:20 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:20 volumio volumio[859]: info: CoreStateMachine::serviceStop
Jul 13 23:00:20 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:20 volumio volumio[859]: info: CoreCommandRouter::serviceStop
Jul 13 23:00:20 volumio volumio[859]: info: [1720882820960] ControllerWebradio::stop
Jul 13 23:00:20 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Jul 13 23:00:20 volumio volumio[859]: info: Enable softmixer device for audio device undefined
Jul 13 23:00:20 volumio volumio[859]: info: Output device has changed, restarting MPD
Jul 13 23:00:20 volumio sudo[1986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 13 23:00:20 volumio sudo[1986]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:20 volumio volumio[859]: info: Output device has changed, restarting Shairport Sync
Jul 13 23:00:20 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:20 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 23:00:20 volumio sudo[1986]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:21 volumio sudo[1989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 13 23:00:21 volumio sudo[1989]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:21 volumio systemd[1]: Stopping Music Player Daemon...
Jul 13 23:00:21 volumio volumio[859]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 13 23:00:21 volumio volumio[859]: info: Volume configurations have been set
Jul 13 23:00:21 volumio systemd[1]: mpd.service: Succeeded.
Jul 13 23:00:21 volumio systemd[1]: Stopped Music Player Daemon.
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Jul 13 23:00:21 volumio volumio[859]: info: Updating Volume Controller Parameters: Device: 5 Name: xCORE USB Audio 2.0 Mixer: xCORE USB Audio 2.0 Output Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Jul 13 23:00:21 volumio volumio[859]: info: Disabling external Volume Control
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 13 23:00:21 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:21 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:21 volumio systemd[1]: Starting Music Player Daemon...
Jul 13 23:00:21 volumio volumio[859]: error: MPD error: Error: write EPIPE
Jul 13 23:00:21 volumio volumio[859]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"}
Jul 13 23:00:21 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:21 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:21 volumio volumio[859]: info: MPD Permissions set
Jul 13 23:00:21 volumio volumio[859]: info: Software Volume ALSA configuration written
Jul 13 23:00:21 volumio volumio[859]: info: Preparing to generate the ALSA configuration file
Jul 13 23:00:21 volumio volumio[859]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Jul 13 23:00:21 volumio volumio[859]: info: Reading ALSA contributions from plugins.
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:21 volumio sudo[1995]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 13 23:00:21 volumio sudo[1995]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:21 volumio sudo[1995]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 13 23:00:21 volumio volumio[859]: info: Starting Shairport Sync
Jul 13 23:00:21 volumio sudo[2016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 13 23:00:21 volumio sudo[2016]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:21 volumio volumio[859]: info: Asound.conf file written
Jul 13 23:00:21 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 13 23:00:21 volumio systemd[1]: shairport-sync.service: Succeeded.
Jul 13 23:00:21 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 13 23:00:21 volumio sudo[2019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jul 13 23:00:21 volumio sudo[2019]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:21 volumio volumio[859]: No state is present for card x20
Jul 13 23:00:21 volumio volumio[859]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:000a" "" ""
Jul 13 23:00:21 volumio volumio[859]: Hardware is initialized using a generic method
Jul 13 23:00:21 volumio volumio[859]: No state is present for card x20
Jul 13 23:00:21 volumio volumio[859]: info: Output device has changed, restarting MPD
Jul 13 23:00:21 volumio sudo[2019]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:21 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 13 23:00:21 volumio sudo[2016]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:21 volumio volumio[859]: info: Output device has changed, restarting Shairport Sync
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 23:00:21 volumio sudo[2027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 13 23:00:21 volumio sudo[2027]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:21 volumio sudo[2028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 13 23:00:21 volumio sudo[2027]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:21 volumio sudo[2028]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:21 volumio volumio[859]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 13 23:00:21 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jul 13 23:00:21 volumio systemd[1]: mpd.service: Succeeded.
Jul 13 23:00:21 volumio systemd[1]: Stopped Music Player Daemon.
Jul 13 23:00:21 volumio systemd[1]: Starting Music Player Daemon...
Jul 13 23:00:21 volumio sudo[2036]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 13 23:00:21 volumio sudo[2036]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:21 volumio sudo[2036]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:22 volumio mpd[2040]: Jul 13 23:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 13 23:00:22 volumio systemd[1]: Started Music Player Daemon.
Jul 13 23:00:22 volumio sudo[2028]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:22 volumio sudo[1989]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:22 volumio kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 1
Jul 13 23:00:22 volumio kernel: xhci_hcd 0000:01:00.0: @000000042a1191d0 00000000 00000000 0e000000 02028000
Jul 13 23:00:22 volumio volumio[859]: Playing WAVE '/volumio/app/silence.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Jul 13 23:00:22 volumio volumio[859]: No state is present for card x20
Jul 13 23:00:22 volumio volumio[859]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:000a" "" ""
Jul 13 23:00:22 volumio volumio[859]: Hardware is initialized using a generic method
Jul 13 23:00:22 volumio volumio[859]: No state is present for card x20
Jul 13 23:00:22 volumio volumio[859]: info: Output device has changed, restarting MPD
Jul 13 23:00:22 volumio sudo[2046]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 13 23:00:22 volumio sudo[2046]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:22 volumio volumio[859]: info: Output device has changed, restarting Shairport Sync
Jul 13 23:00:22 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:22 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 23:00:22 volumio sudo[2046]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:22 volumio sudo[2049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 13 23:00:22 volumio sudo[2049]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:22 volumio systemd[1]: Stopping Music Player Daemon...
Jul 13 23:00:22 volumio volumio[859]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 13 23:00:22 volumio systemd[1]: mpd.service: Succeeded.
Jul 13 23:00:22 volumio systemd[1]: Stopped Music Player Daemon.
Jul 13 23:00:22 volumio volumio[859]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Jul 13 23:00:22 volumio volumio[859]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Jul 13 23:00:22 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Jul 13 23:00:22 volumio volumio[859]: info: Disabling external Volume Control
Jul 13 23:00:22 volumio volumio[859]: info: MPD Permissions set
Jul 13 23:00:22 volumio volumio[859]: info: MPD Permissions set
Jul 13 23:00:22 volumio volumio[859]: info: Shairport-Sync Started
Jul 13 23:00:22 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:22 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:22 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:22 volumio systemd[1]: Starting Music Player Daemon...
Jul 13 23:00:22 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:22 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:22 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:22 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:22 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:22 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:22 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:22 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:23 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 23:00:23 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:23 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:23 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:23 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:23 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:23 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:23 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:23 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:23 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:23 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 23:00:23 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 23:00:23 volumio volumio[859]: info: Starting Shairport Sync
Jul 13 23:00:23 volumio sudo[2055]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 13 23:00:23 volumio sudo[2055]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:23 volumio sudo[2055]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:23 volumio volumio[859]: info: Starting Shairport Sync
Jul 13 23:00:23 volumio sudo[2076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 13 23:00:23 volumio sudo[2076]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:23 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 13 23:00:23 volumio sudo[2079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 13 23:00:23 volumio sudo[2079]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:23 volumio systemd[1]: shairport-sync.service: Succeeded.
Jul 13 23:00:23 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 13 23:00:23 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 13 23:00:23 volumio sudo[2076]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:23 volumio volumio[859]: info: Shairport-Sync Started
Jul 13 23:00:23 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 13 23:00:23 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jul 13 23:00:23 volumio systemd[1]: shairport-sync.service: Succeeded.
Jul 13 23:00:23 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 13 23:00:23 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 13 23:00:23 volumio sudo[2079]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:23 volumio volumio[859]: info: Shairport-Sync Started
Jul 13 23:00:23 volumio mpd[2077]: Jul 13 23:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 13 23:00:23 volumio systemd[1]: Started Music Player Daemon.
Jul 13 23:00:23 volumio volumio[859]: error: MPD error: The expression evaluated to a falsy value:
Jul 13 23:00:23 volumio volumio[859]: assert.ok(self.idling)
Jul 13 23:00:23 volumio volumio[859]: error: The expression evaluated to a falsy value:
Jul 13 23:00:23 volumio volumio[859]: assert.ok(self.idling)
Jul 13 23:00:23 volumio sudo[2049]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:23 volumio volumio[859]: error: updateQueue error: null
Jul 13 23:00:23 volumio volumio[859]: error: updateQueue error: null
Jul 13 23:00:24 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd
Jul 13 23:00:24 volumio sudo[2090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 13 23:00:24 volumio sudo[2090]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:24 volumio systemd[1]: Stopping Music Player Daemon...
Jul 13 23:00:24 volumio systemd[1]: mpd.service: Succeeded.
Jul 13 23:00:24 volumio systemd[1]: Stopped Music Player Daemon.
Jul 13 23:00:24 volumio systemd[1]: Starting Music Player Daemon...
Jul 13 23:00:24 volumio sudo[2092]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 13 23:00:24 volumio sudo[2092]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 23:00:24 volumio sudo[2092]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:24 volumio volumio[859]: info: CoreCommandRouter::volumioPlay
Jul 13 23:00:24 volumio volumio[859]: info: CoreStateMachine::play index undefined
Jul 13 23:00:24 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 13 23:00:24 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:24 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer
Jul 13 23:00:24 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:24 volumio volumio[859]: info: [1720882824732] ControllerWebradio::clearAddPlayTrack
Jul 13 23:00:24 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Jul 13 23:00:24 volumio volumio[859]: error: MPD error: Error: This socket has been ended by the other party
Jul 13 23:00:24 volumio volumio[859]: error: This socket has been ended by the other party {"code":"EPIPE"}
Jul 13 23:00:24 volumio volumio[859]: error: MPD error: Error: This socket has been ended by the other party
Jul 13 23:00:24 volumio volumio[859]: error: This socket has been ended by the other party {"code":"EPIPE"}
Jul 13 23:00:24 volumio volumio[859]: error: MPD error: Error: This socket has been ended by the other party
Jul 13 23:00:24 volumio volumio[859]: error: This socket has been ended by the other party {"code":"EPIPE"}
Jul 13 23:00:25 volumio mpd[2095]: Jul 13 23:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 13 23:00:25 volumio systemd[1]: Started Music Player Daemon.
Jul 13 23:00:25 volumio sudo[2090]: pam_unix(sudo:session): session closed for user root
Jul 13 23:00:25 volumio volumio[859]: error: updateQueue error: null
Jul 13 23:00:25 volumio volumio[859]: info: VolumeController::SetAlsaVolume50
Jul 13 23:00:25 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:25 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:25 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:25 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:29 volumio volumio[859]: info: CoreCommandRouter::volumioPlay
Jul 13 23:00:29 volumio volumio[859]: info: CoreStateMachine::play index undefined
Jul 13 23:00:29 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 13 23:00:29 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:29 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer
Jul 13 23:00:29 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:29 volumio volumio[859]: info: [1720882829196] ControllerWebradio::clearAddPlayTrack
Jul 13 23:00:29 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Jul 13 23:00:29 volumio volumio[859]: info: sendMpdCommand stop took 0 milliseconds
Jul 13 23:00:29 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear
Jul 13 23:00:29 volumio volumio[859]: info:
Jul 13 23:00:29 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:29 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:29 volumio volumio[859]: info: sendMpdCommand clear took 1 milliseconds
Jul 13 23:00:29 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012"
Jul 13 23:00:29 volumio volumio[859]: error: updateQueue error: null
Jul 13 23:00:29 volumio volumio[859]: info: ------------------------------ 2ms
Jul 13 23:00:30 volumio volumio[859]: info: CoreCommandRouter::volumioPlay
Jul 13 23:00:30 volumio volumio[859]: info: CoreStateMachine::play index undefined
Jul 13 23:00:30 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 13 23:00:30 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:30 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer
Jul 13 23:00:30 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:30 volumio volumio[859]: info: [1720882830021] ControllerWebradio::clearAddPlayTrack
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Jul 13 23:00:30 volumio volumio[859]: info: CoreCommandRouter::volumioPlay
Jul 13 23:00:30 volumio volumio[859]: info: CoreStateMachine::play index undefined
Jul 13 23:00:30 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 13 23:00:30 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:30 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer
Jul 13 23:00:30 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:30 volumio volumio[859]: info: [1720882830648] ControllerWebradio::clearAddPlayTrack
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Jul 13 23:00:30 volumio volumio[859]: info: CoreCommandRouter::volumioPlay
Jul 13 23:00:30 volumio volumio[859]: info: CoreStateMachine::play index undefined
Jul 13 23:00:30 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 13 23:00:30 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:30 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer
Jul 13 23:00:30 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:30 volumio volumio[859]: info: [1720882830813] ControllerWebradio::clearAddPlayTrack
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Jul 13 23:00:30 volumio volumio[859]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" took 1782 milliseconds
Jul 13 23:00:30 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play
Jul 13 23:00:30 volumio volumio[859]: info:
Jul 13 23:00:30 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:30 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:30 volumio volumio[859]: info: sendMpdCommand stop took 961 milliseconds
Jul 13 23:00:30 volumio volumio[859]: info: sendMpdCommand stop took 334 milliseconds
Jul 13 23:00:30 volumio volumio[859]: info: sendMpdCommand stop took 170 milliseconds
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear
Jul 13 23:00:30 volumio volumio[859]: info: sendMpdCommand play took 3 milliseconds
Jul 13 23:00:30 volumio volumio[859]: info: ------------------------------ 3ms
Jul 13 23:00:30 volumio volumio[859]: info: CoreCommandRouter::volumioPlay
Jul 13 23:00:30 volumio volumio[859]: info: CoreStateMachine::play index undefined
Jul 13 23:00:30 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 13 23:00:30 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:30 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer
Jul 13 23:00:30 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:30 volumio volumio[859]: info: [1720882830986] ControllerWebradio::clearAddPlayTrack
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Jul 13 23:00:30 volumio volumio[859]: info:
Jul 13 23:00:30 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:30 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:30 volumio volumio[859]: info:
Jul 13 23:00:30 volumio volumio[859]: ---------------------------- MPD announces state update: player
Jul 13 23:00:30 volumio volumio[859]: info:
Jul 13 23:00:30 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:30 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:30 volumio volumio[859]: info: sendMpdCommand clear took 7 milliseconds
Jul 13 23:00:30 volumio volumio[859]: info: ControllerMpd::getState
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Jul 13 23:00:30 volumio volumio[859]: info: sendMpdCommand clear took 8 milliseconds
Jul 13 23:00:30 volumio volumio[859]: info: sendMpdCommand clear took 8 milliseconds
Jul 13 23:00:30 volumio volumio[859]: info: sendMpdCommand stop took 4 milliseconds
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012"
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012"
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012"
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear
Jul 13 23:00:30 volumio volumio[859]: error: updateQueue error: null
Jul 13 23:00:30 volumio volumio[859]: info: ------------------------------ 7ms
Jul 13 23:00:30 volumio volumio[859]: info: sendMpdCommand status took 8 milliseconds
Jul 13 23:00:30 volumio volumio[859]: verbose: ControllerMpd::parseState
Jul 13 23:00:30 volumio volumio[859]: info: ControllerMpd::pushState
Jul 13 23:00:31 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Jul 13 23:00:31 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:31 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:31 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:31 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:31 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:31 volumio volumio[859]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 13 23:00:31 volumio volumio[859]: info: ------------------------------ 21ms
Jul 13 23:00:31 volumio volumio[859]: info: CoreCommandRouter::volumioPlay
Jul 13 23:00:31 volumio volumio[859]: info: CoreStateMachine::play index undefined
Jul 13 23:00:31 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 13 23:00:31 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:31 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer
Jul 13 23:00:31 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:31 volumio volumio[859]: info: [1720882831146] ControllerWebradio::clearAddPlayTrack
Jul 13 23:00:31 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Jul 13 23:00:33 volumio volumio[859]: info: CoreCommandRouter::volumioPlay
Jul 13 23:00:33 volumio volumio[859]: info: CoreStateMachine::play index undefined
Jul 13 23:00:33 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 13 23:00:33 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:33 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer
Jul 13 23:00:33 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:33 volumio volumio[859]: info: [1720882833160] ControllerWebradio::clearAddPlayTrack
Jul 13 23:00:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Jul 13 23:00:33 volumio volumio[859]: error: updateQueue error: null
Jul 13 23:00:33 volumio volumio[859]: info:
Jul 13 23:00:33 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:33 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:33 volumio volumio[859]: info: ------------------------------ 2376ms
Jul 13 23:00:33 volumio volumio[859]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" took 2372 milliseconds
Jul 13 23:00:33 volumio volumio[859]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" took 2372 milliseconds
Jul 13 23:00:33 volumio volumio[859]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" took 2372 milliseconds
Jul 13 23:00:33 volumio volumio[859]: info: sendMpdCommand clear took 2373 milliseconds
Jul 13 23:00:33 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 13 23:00:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play
Jul 13 23:00:33 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 13 23:00:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play
Jul 13 23:00:33 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 13 23:00:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play
Jul 13 23:00:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012"
Jul 13 23:00:33 volumio volumio[859]: error: updateQueue error: null
Jul 13 23:00:33 volumio volumio[859]: info: sendMpdCommand stop took 2220 milliseconds
Jul 13 23:00:33 volumio volumio[859]: info: sendMpdCommand stop took 207 milliseconds
Jul 13 23:00:33 volumio volumio[859]: info: ------------------------------ 3ms
Jul 13 23:00:33 volumio volumio[859]: info: sendMpdCommand play took 2 milliseconds
Jul 13 23:00:33 volumio volumio[859]: info: sendMpdCommand play took 2 milliseconds
Jul 13 23:00:33 volumio volumio[859]: info: sendMpdCommand play took 3 milliseconds
Jul 13 23:00:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear
Jul 13 23:00:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear
Jul 13 23:00:33 volumio volumio[859]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" took 284 milliseconds
Jul 13 23:00:33 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 13 23:00:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play
Jul 13 23:00:33 volumio volumio[859]: info:
Jul 13 23:00:33 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:33 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:33 volumio volumio[859]: info:
Jul 13 23:00:33 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:33 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:33 volumio volumio[859]: info: sendMpdCommand clear took 284 milliseconds
Jul 13 23:00:33 volumio volumio[859]: info: sendMpdCommand clear took 284 milliseconds
Jul 13 23:00:33 volumio volumio[859]: info: sendMpdCommand play took 2 milliseconds
Jul 13 23:00:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012"
Jul 13 23:00:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012"
Jul 13 23:00:33 volumio volumio[859]: error: updateQueue error: null
Jul 13 23:00:33 volumio volumio[859]: error: updateQueue error: null
Jul 13 23:00:33 volumio volumio[859]: info: ------------------------------ 2ms
Jul 13 23:00:33 volumio volumio[859]: info: ------------------------------ 3ms
Jul 13 23:00:34 volumio volumio[859]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" took 923 milliseconds
Jul 13 23:00:34 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 13 23:00:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play
Jul 13 23:00:34 volumio volumio[859]: info:
Jul 13 23:00:34 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:34 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:34 volumio volumio[859]: info:
Jul 13 23:00:34 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:34 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:34 volumio volumio[859]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" took 1205 milliseconds
Jul 13 23:00:34 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 13 23:00:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play
Jul 13 23:00:34 volumio volumio[859]: info: sendMpdCommand play took 283 milliseconds
Jul 13 23:00:34 volumio volumio[859]: info: ------------------------------ 3ms
Jul 13 23:00:34 volumio volumio[859]: info: ------------------------------ 2ms
Jul 13 23:00:34 volumio volumio[859]: info: sendMpdCommand play took 1 milliseconds
Jul 13 23:00:37 volumio volumio[859]: info:
Jul 13 23:00:37 volumio volumio[859]: ---------------------------- MPD announces state update: player
Jul 13 23:00:37 volumio volumio[859]: info: ControllerMpd::getState
Jul 13 23:00:37 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Jul 13 23:00:37 volumio volumio[859]: info:
Jul 13 23:00:37 volumio volumio[859]: ---------------------------- MPD announces state update: player
Jul 13 23:00:37 volumio volumio[859]: info: sendMpdCommand status took 16 milliseconds
Jul 13 23:00:37 volumio volumio[859]: info: ControllerMpd::getState
Jul 13 23:00:37 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Jul 13 23:00:37 volumio volumio[859]: verbose: ControllerMpd::parseState
Jul 13 23:00:37 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 13 23:00:37 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds
Jul 13 23:00:37 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 13 23:00:37 volumio volumio[859]: verbose: ControllerMpd::parseState
Jul 13 23:00:37 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 13 23:00:37 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Jul 13 23:00:37 volumio volumio[859]: info: ControllerMpd::pushState
Jul 13 23:00:37 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Jul 13 23:00:37 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:37 volumio volumio[859]: 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":"rockantenne","artist":"(#1 - 3392/500000) ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""}
Jul 13 23:00:37 volumio volumio[859]: verbose: CURRENT POSITION 0
Jul 13 23:00:37 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Jul 13 23:00:37 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop
Jul 13 23:00:37 volumio volumio[859]: info: ------------------------------ 20ms
Jul 13 23:00:37 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 13 23:00:37 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Jul 13 23:00:37 volumio volumio[859]: info: ControllerMpd::pushState
Jul 13 23:00:37 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Jul 13 23:00:37 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:37 volumio volumio[859]: 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":"rockantenne","artist":"(#1 - 3392/500000) ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""}
Jul 13 23:00:37 volumio volumio[859]: verbose: CURRENT POSITION 0
Jul 13 23:00:37 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Jul 13 23:00:37 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Jul 13 23:00:37 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Jul 13 23:00:37 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 13 23:00:37 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:37 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:37 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:37 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:37 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:37 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:37 volumio volumio[859]: info: ------------------------------ 21ms
Jul 13 23:00:38 volumio volumio[859]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/(%231%20-%203392%2F500000)%20ROCK%20ANTENNE/c78f3285-9627-462d-8382-e8f1ec42b132.jpg'
Jul 13 23:00:38 volumio volumio[859]: info:
Jul 13 23:00:38 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:38 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:38 volumio volumio[859]: info:
Jul 13 23:00:38 volumio volumio[859]: ---------------------------- MPD announces state update: player
Jul 13 23:00:38 volumio volumio[859]: info: ControllerMpd::getState
Jul 13 23:00:38 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Jul 13 23:00:38 volumio volumio[859]: info:
Jul 13 23:00:38 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:38 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:38 volumio volumio[859]: info:
Jul 13 23:00:38 volumio volumio[859]: ---------------------------- MPD announces state update: player
Jul 13 23:00:38 volumio volumio[859]: info: ControllerMpd::getState
Jul 13 23:00:38 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Jul 13 23:00:38 volumio volumio[859]: info: ------------------------------ 6ms
Jul 13 23:00:38 volumio volumio[859]: info: sendMpdCommand status took 5 milliseconds
Jul 13 23:00:38 volumio volumio[859]: verbose: ControllerMpd::parseState
Jul 13 23:00:38 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 13 23:00:38 volumio volumio[859]: info:
Jul 13 23:00:38 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:38 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:38 volumio volumio[859]: info:
Jul 13 23:00:38 volumio volumio[859]: ---------------------------- MPD announces state update: player
Jul 13 23:00:38 volumio volumio[859]: info: ControllerMpd::getState
Jul 13 23:00:38 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Jul 13 23:00:38 volumio volumio[859]: info: ------------------------------ 5ms
Jul 13 23:00:38 volumio volumio[859]: info: sendMpdCommand status took 4 milliseconds
Jul 13 23:00:38 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 13 23:00:38 volumio volumio[859]: verbose: ControllerMpd::parseState
Jul 13 23:00:38 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 13 23:00:38 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Jul 13 23:00:38 volumio volumio[859]: info: ControllerMpd::pushState
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Jul 13 23:00:38 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:38 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Rock Nonstop","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""}
Jul 13 23:00:38 volumio volumio[859]: verbose: CURRENT POSITION 0
Jul 13 23:00:38 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Jul 13 23:00:38 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Jul 13 23:00:38 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 13 23:00:38 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:38 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:38 volumio volumio[859]: info: ------------------------------ 44ms
Jul 13 23:00:38 volumio volumio[859]: info: ------------------------------ 38ms
Jul 13 23:00:38 volumio volumio[859]: info: sendMpdCommand status took 37 milliseconds
Jul 13 23:00:38 volumio volumio[859]: info: sendMpdCommand playlistinfo took 32 milliseconds
Jul 13 23:00:38 volumio volumio[859]: verbose: ControllerMpd::parseState
Jul 13 23:00:38 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 13 23:00:38 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Jul 13 23:00:38 volumio volumio[859]: info: ControllerMpd::pushState
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Jul 13 23:00:38 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:38 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Rock Nonstop","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""}
Jul 13 23:00:38 volumio volumio[859]: verbose: CURRENT POSITION 0
Jul 13 23:00:38 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Jul 13 23:00:38 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Jul 13 23:00:38 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 13 23:00:38 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:38 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:38 volumio volumio[859]: info: ------------------------------ 64ms
Jul 13 23:00:38 volumio volumio[859]: info: sendMpdCommand playlistinfo took 26 milliseconds
Jul 13 23:00:38 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Jul 13 23:00:38 volumio volumio[859]: info: ControllerMpd::pushState
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Jul 13 23:00:38 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:38 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Rock Nonstop","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""}
Jul 13 23:00:38 volumio volumio[859]: verbose: CURRENT POSITION 0
Jul 13 23:00:38 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Jul 13 23:00:38 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Jul 13 23:00:38 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 13 23:00:38 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:38 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:38 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:38 volumio volumio[859]: info: ------------------------------ 89ms
Jul 13 23:00:38 volumio volumio[859]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/ROCK%20ANTENNE/8ec957c4-360c-4b68-ac20-0d46428d0d64.jpg'
Jul 13 23:00:39 volumio volumio[859]: info:
Jul 13 23:00:39 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:39 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:39 volumio volumio[859]: info:
Jul 13 23:00:39 volumio volumio[859]: ---------------------------- MPD announces state update: player
Jul 13 23:00:39 volumio volumio[859]: info: ControllerMpd::getState
Jul 13 23:00:39 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Jul 13 23:00:39 volumio volumio[859]: info: ------------------------------ 2ms
Jul 13 23:00:39 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds
Jul 13 23:00:39 volumio volumio[859]: verbose: ControllerMpd::parseState
Jul 13 23:00:39 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 13 23:00:39 volumio volumio[859]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jul 13 23:00:39 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Jul 13 23:00:39 volumio volumio[859]: info: ControllerMpd::pushState
Jul 13 23:00:39 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Jul 13 23:00:39 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:39 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Rock Nonstop","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""}
Jul 13 23:00:39 volumio volumio[859]: verbose: CURRENT POSITION 0
Jul 13 23:00:39 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Jul 13 23:00:39 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Jul 13 23:00:39 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Jul 13 23:00:39 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 13 23:00:39 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:39 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:39 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:39 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:39 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:39 volumio volumio[859]: info: ------------------------------ 26ms
Jul 13 23:00:40 volumio volumio[859]: info:
Jul 13 23:00:40 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Jul 13 23:00:40 volumio volumio[859]: info: Ignoring MPD Status Update
Jul 13 23:00:40 volumio volumio[859]: info:
Jul 13 23:00:40 volumio volumio[859]: ---------------------------- MPD announces state update: player
Jul 13 23:00:40 volumio volumio[859]: info: ControllerMpd::getState
Jul 13 23:00:40 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Jul 13 23:00:40 volumio volumio[859]: info: ------------------------------ 2ms
Jul 13 23:00:40 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds
Jul 13 23:00:40 volumio volumio[859]: verbose: ControllerMpd::parseState
Jul 13 23:00:40 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 13 23:00:40 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 13 23:00:40 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Jul 13 23:00:40 volumio volumio[859]: info: ControllerMpd::pushState
Jul 13 23:00:40 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Jul 13 23:00:40 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Jul 13 23:00:40 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2734,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Rock Nonstop","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""}
Jul 13 23:00:40 volumio volumio[859]: verbose: CURRENT POSITION 0
Jul 13 23:00:40 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Jul 13 23:00:40 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Jul 13 23:00:40 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Jul 13 23:00:40 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 13 23:00:40 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:40 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:40 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:40 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:40 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:40 volumio volumio[859]: info: ------------------------------ 19ms
Jul 13 23:00:41 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:41 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:41 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:41 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:42 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:42 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:42 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:42 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:42 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:42 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:42 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:42 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:42 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:42 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:42 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:42 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:42 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:42 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:42 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:42 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:42 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:42 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:42 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:42 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:43 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:43 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:43 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:43 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:43 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:43 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:43 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:43 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:43 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:43 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:43 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:43 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:43 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:43 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:43 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:43 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:44 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:44 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:44 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:44 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:44 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:44 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:44 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:44 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:44 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:44 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:44 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:44 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:44 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:44 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:44 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:44 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:44 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:44 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:44 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:45 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:45 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:45 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:45 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:45 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:45 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:45 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:45 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:45 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:45 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:45 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:45 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:45 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:45 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:45 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:45 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:45 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:45 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:45 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:45 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:46 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:46 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:46 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:46 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:46 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:46 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:46 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:46 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:46 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:46 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:46 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:46 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:46 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:46 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:46 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:46 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:46 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:46 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:46 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:46 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:46 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:46 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:46 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:46 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:47 volumio volumio[859]: info: VolumeController::SetAlsaVolume+
Jul 13 23:00:47 volumio volumio[859]: info: CoreStateMachine::pushState
Jul 13 23:00:47 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 23:00:47 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Jul 13 23:00:51 volumio volumio[859]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 13 23:00:51 volumio volumio[859]: Error: connect ETIMEDOUT 202.160.130.66:80
Jul 13 23:00:51 volumio volumio[859]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Jul 13 23:00:51 volumio volumio[859]: errno: -110,
Jul 13 23:00:51 volumio volumio[859]: code: 'ETIMEDOUT',
Jul 13 23:00:51 volumio volumio[859]: syscall: 'connect',
Jul 13 23:00:51 volumio volumio[859]: address: '202.160.130.66',
Jul 13 23:00:51 volumio volumio[859]: port: 80
Jul 13 23:00:51 volumio volumio[859]: }
Jul 13 23:00:51 volumio volumio[859]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 13 23:00:51 volumio sudo[2145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-13 22:59
Jul 13 23:00:51 volumio sudo[2145]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"