-- Logs begin at Sat 2024-10-26 00:20:37 UTC, end at Sat 2024-10-26 00:24:13 UTC. --
Oct 26 00:23:30 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 26 00:23:30 volumio volumio-remote-updater[560]: No test mode
Oct 26 00:23:30 volumio volumio-remote-updater[560]: No alpha test mode
Oct 26 00:23:30 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Oct 26 00:23:36 volumio volumio[791]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Improved translations
- Fix for Wizard not showing on second start
- Fix for Playback Queue not advancing
NEW ADDITIONS
- Add DSD Quirk for Marantz SA-12 on Rivo and Primo v2
","title":"Update v3.757","updateavailable":true}
Oct 26 00:23:36 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Oct 26 00:23:52 volumio volumio[791]: info: CoreCommandRouter::volumioGetState
Oct 26 00:23:52 volumio volumio[791]: info: CorePlayQueue::getTrack 0
Oct 26 00:23:58 volumio volumio[791]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 26 00:23:58 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 26 00:23:58 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 00:23:58 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 26 00:23:58 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:23:58 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:23:58 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:23:58 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:23:58 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:23:58 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:23:58 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:23:58 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 26 00:23:58 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 26 00:24:08 volumio volumio[791]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 26 00:24:08 volumio volumio[791]: info: Found match in Cards Database: setting mixer HDMI for card HDMI
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 26 00:24:08 volumio volumio[791]: info: Updating Volume Controller Parameters: Device: 0,3 Name: softvolume Mixer: HDMI Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Oct 26 00:24:08 volumio volumio[791]: info: Disabling external Volume Control
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 26 00:24:08 volumio volumio[791]: info: Enable softmixer device for audio device undefined
Oct 26 00:24:08 volumio volumio[791]: info: Software Volume ALSA configuration written
Oct 26 00:24:08 volumio volumio[791]: info: Preparing to generate the ALSA configuration file
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 26 00:24:08 volumio volumio[791]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Oct 26 00:24:08 volumio volumio[791]: info: Reading ALSA contributions from plugins.
Oct 26 00:24:08 volumio volumio[791]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'HDMI',0
Oct 26 00:24:08 volumio volumio[791]: info: Asound.conf file written
Oct 26 00:24:08 volumio sudo[1863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Oct 26 00:24:08 volumio sudo[1863]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 00:24:08 volumio sudo[1863]: pam_unix(sudo:session): session closed for user root
Oct 26 00:24:08 volumio volumio[791]: info: Output device has changed, restarting MPD
Oct 26 00:24:08 volumio sudo[1868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 26 00:24:08 volumio sudo[1868]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 00:24:08 volumio sudo[1868]: pam_unix(sudo:session): session closed for user root
Oct 26 00:24:08 volumio volumio[791]: info: Output device has changed, restarting Shairport Sync
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:08 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 00:24:08 volumio sudo[1871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 26 00:24:08 volumio sudo[1871]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 00:24:08 volumio systemd[1]: Stopping Music Player Daemon...
Oct 26 00:24:09 volumio volumio[791]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 26 00:24:09 volumio volumio[791]: info: Output device has changed, restarting MPD
Oct 26 00:24:09 volumio sudo[1877]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 26 00:24:09 volumio sudo[1877]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 00:24:09 volumio volumio[791]: info: Output device has changed, restarting Shairport Sync
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 00:24:09 volumio sudo[1877]: pam_unix(sudo:session): session closed for user root
Oct 26 00:24:09 volumio sudo[1880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 26 00:24:09 volumio sudo[1880]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 00:24:09 volumio volumio[791]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 26 00:24:09 volumio volumio[791]: info: MPD Permissions set
Oct 26 00:24:09 volumio volumio[791]: info: MPD Permissions set
Oct 26 00:24:09 volumio volumio[791]: info: VolumeController:: Volume=undefined Mute =false
Oct 26 00:24:09 volumio volumio[791]: info: CoreStateMachine::pushState
Oct 26 00:24:09 volumio volumio[791]: info: CorePlayQueue::getTrack 0
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::volumioPushState
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Oct 26 00:24:09 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 00:24:09 volumio volumio[791]: info: Starting Shairport Sync
Oct 26 00:24:09 volumio volumio[791]: info: Starting Shairport Sync
Oct 26 00:24:09 volumio sudo[1898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 26 00:24:09 volumio sudo[1898]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 00:24:09 volumio sudo[1900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 26 00:24:09 volumio sudo[1900]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 00:24:09 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 26 00:24:09 volumio systemd[1]: shairport-sync.service: Succeeded.
Oct 26 00:24:09 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 26 00:24:09 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 26 00:24:09 volumio sudo[1898]: pam_unix(sudo:session): session closed for user root
Oct 26 00:24:09 volumio sudo[1900]: pam_unix(sudo:session): session closed for user root
Oct 26 00:24:09 volumio volumio[791]: info: Shairport-Sync Started
Oct 26 00:24:09 volumio volumio[791]: info: Shairport-Sync Started
Oct 26 00:24:09 volumio systemd[1]: mpd.service: Succeeded.
Oct 26 00:24:09 volumio systemd[1]: Stopped Music Player Daemon.
Oct 26 00:24:09 volumio systemd[1]: Starting Music Player Daemon...
Oct 26 00:24:09 volumio volumio[791]: error: Upnp client error: Error: This socket has been ended by the other party
Oct 26 00:24:09 volumio mpd[1908]: Oct 26 00:24 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Oct 26 00:24:09 volumio mpd[1908]: Oct 26 00:24 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Oct 26 00:24:09 volumio mpd[1908]: Oct 26 00:24 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Oct 26 00:24:09 volumio systemd[1]: Started Music Player Daemon.
Oct 26 00:24:09 volumio sudo[1880]: pam_unix(sudo:session): session closed for user root
Oct 26 00:24:09 volumio sudo[1871]: pam_unix(sudo:session): session closed for user root
Oct 26 00:24:09 volumio volumio[791]: error: MPD error: The expression evaluated to a falsy value:
Oct 26 00:24:09 volumio volumio[791]: assert.ok(self.idling)
Oct 26 00:24:09 volumio volumio[791]: error: The expression evaluated to a falsy value:
Oct 26 00:24:09 volumio volumio[791]: assert.ok(self.idling)
Oct 26 00:24:09 volumio volumio[791]: error: updateQueue error: null
Oct 26 00:24:12 volumio volumio[791]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Oct 26 00:24:12 volumio volumio[791]: info: CoreStateMachine::getcurrentVolume
Oct 26 00:24:12 volumio volumio[791]: info: CoreCommandRouter::volumioRetrievevolume
Oct 26 00:24:12 volumio volumio[791]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'HDMI',0
Oct 26 00:24:12 volumio volumio[791]: info: VolumeController:: Volume=undefined Mute =false
Oct 26 00:24:12 volumio volumio[791]: info: CoreStateMachine::pushState
Oct 26 00:24:12 volumio volumio[791]: info: CorePlayQueue::getTrack 0
Oct 26 00:24:12 volumio volumio[791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 00:24:12 volumio volumio[791]: info: CoreCommandRouter::volumioPushState
Oct 26 00:24:12 volumio volumio[791]: info: CoreStateMachine::updateTrackBlock
Oct 26 00:24:12 volumio volumio[791]: info: CorePlayQueue::getTrackBlock
Oct 26 00:24:12 volumio volumio[791]: info: CoreCommandRouter::volumioRetrievevolume
Oct 26 00:24:12 volumio volumio[791]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'HDMI',0
Oct 26 00:24:12 volumio volumio[791]: info: VolumeController:: Volume=undefined Mute =false
Oct 26 00:24:12 volumio volumio[791]: info: CoreStateMachine::pushState
Oct 26 00:24:12 volumio volumio[791]: info: CorePlayQueue::getTrack 0
Oct 26 00:24:12 volumio volumio[791]: info: CoreCommandRouter::volumioPushState
Oct 26 00:24:13 volumio volumio[791]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 26 00:24:13 volumio volumio[791]: Error: connect ETIMEDOUT 108.160.166.61:443
Oct 26 00:24:13 volumio volumio[791]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Oct 26 00:24:13 volumio volumio[791]: errno: -110,
Oct 26 00:24:13 volumio volumio[791]: code: 'ETIMEDOUT',
Oct 26 00:24:13 volumio volumio[791]: syscall: 'connect',
Oct 26 00:24:13 volumio volumio[791]: address: '108.160.166.61',
Oct 26 00:24:13 volumio volumio[791]: port: 443
Oct 26 00:24:13 volumio volumio[791]: }
Oct 26 00:24:13 volumio volumio[791]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 26 00:24:13 volumio sudo[1930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-26 00:23
Oct 26 00:24:13 volumio sudo[1930]: 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 06:04:32 PM CEST"
VOLUMIO_VERSION="3.512"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="dd58c1c2d5a97e584de8089531ce548f"