-- Logs begin at Thu 2019-02-14 13:11:59 +03, end at Sun 2024-08-25 17:24:31 +03. -- Aug 25 17:23:06 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 17:23:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 25 17:23:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 17:23:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 25 17:23:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:23:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:23:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:23:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:23:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:23:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:23:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:23:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 25 17:23:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 25 17:23:59 volumio volumio[909]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Aug 25 17:23:59 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 25 17:23:59 volumio volumio[909]: info: Preparing to save Alsa Options, stopping services first Aug 25 17:23:59 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Aug 25 17:23:59 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Aug 25 17:23:59 volumio volumio[909]: info: CoreCommandRouter::volumioPause Aug 25 17:23:59 volumio volumio[909]: info: CoreStateMachine::pause Aug 25 17:23:59 volumio volumio[909]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"ADI-2 DAC (58580002)"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Aug 25 17:23:59 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 25 17:24:00 volumio volumio[909]: info: Setting mixer AES Rate for card ADI-2 DAC (58580002) Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 25 17:24:00 volumio volumio[909]: info: Updating Volume Controller Parameters: Device: 5 Name: ADI-2 DAC (58580002) Mixer: AES Rate Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 25 17:24:00 volumio volumio[909]: info: Disabling external Volume Control Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 17:24:00 volumio volumio[909]: info: Preparing to generate the ALSA configuration file Aug 25 17:24:00 volumio volumio[909]: Unable to parse: Aug 25 17:24:00 volumio volumio[909]: Simple mixer control 'AES Rate',0 Aug 25 17:24:00 volumio volumio[909]: Capabilities: volume volume-joined Aug 25 17:24:00 volumio volumio[909]: Playback channels: Mono Aug 25 17:24:00 volumio volumio[909]: Capture channels: Mono Aug 25 17:24:00 volumio volumio[909]: Limits: 0 - 200000 Aug 25 17:24:00 volumio volumio[909]: Mono: 0 [0%] Aug 25 17:24:00 volumio volumio[909]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 25 17:24:00 volumio volumio[909]: info: Asound.conf file unchanged, so no further update is needed Aug 25 17:24:00 volumio volumio[909]: info: Output device has changed, restarting MPD Aug 25 17:24:00 volumio sudo[24880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 25 17:24:00 volumio sudo[24880]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 17:24:00 volumio volumio[909]: info: Output device has changed, restarting Shairport Sync Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 17:24:00 volumio sudo[24880]: pam_unix(sudo:session): session closed for user root Aug 25 17:24:00 volumio sudo[24882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 25 17:24:00 volumio sudo[24882]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 17:24:00 volumio systemd[1]: Stopping Music Player Daemon... Aug 25 17:24:00 volumio volumio[909]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 25 17:24:00 volumio systemd[1]: mpd.service: Succeeded. Aug 25 17:24:00 volumio systemd[1]: Stopped Music Player Daemon. Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 25 17:24:00 volumio systemd[1]: Starting Music Player Daemon... Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 25 17:24:00 volumio volumio[909]: info: MPD Permissions set Aug 25 17:24:00 volumio volumio[909]: Unable to parse: Aug 25 17:24:00 volumio volumio[909]: Simple mixer control 'AES Rate',0 Aug 25 17:24:00 volumio volumio[909]: Capabilities: volume volume-joined Aug 25 17:24:00 volumio volumio[909]: Playback channels: Mono Aug 25 17:24:00 volumio volumio[909]: Capture channels: Mono Aug 25 17:24:00 volumio volumio[909]: Limits: 0 - 200000 Aug 25 17:24:00 volumio volumio[909]: Mono: 0 [0%] Aug 25 17:24:00 volumio volumio[909]: info: VolumeController:: Volume=undefined Mute =false Aug 25 17:24:00 volumio volumio[909]: info: CoreStateMachine::pushState Aug 25 17:24:00 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 17:24:00 volumio sudo[24888]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 25 17:24:00 volumio sudo[24888]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 17:24:00 volumio sudo[24888]: pam_unix(sudo:session): session closed for user root Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 17:24:00 volumio volumio[909]: info: Starting Shairport Sync Aug 25 17:24:00 volumio sudo[24901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 25 17:24:00 volumio sudo[24901]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 17:24:00 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 25 17:24:00 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 25 17:24:00 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 25 17:24:00 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 25 17:24:00 volumio sudo[24901]: pam_unix(sudo:session): session closed for user root Aug 25 17:24:00 volumio volumio[909]: info: Shairport-Sync Started Aug 25 17:24:00 volumio mpd[24899]: Aug 25 17:24 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 25 17:24:01 volumio systemd[1]: Started Music Player Daemon. Aug 25 17:24:01 volumio sudo[24882]: pam_unix(sudo:session): session closed for user root Aug 25 17:24:01 volumio volumio[909]: error: updateQueue error: null Aug 25 17:24:04 volumio volumio[909]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 25 17:24:04 volumio volumio[909]: info: CoreStateMachine::getcurrentVolume Aug 25 17:24:04 volumio volumio[909]: info: CoreCommandRouter::volumioRetrievevolume Aug 25 17:24:04 volumio volumio[909]: Unable to parse: Aug 25 17:24:04 volumio volumio[909]: Simple mixer control 'AES Rate',0 Aug 25 17:24:04 volumio volumio[909]: Capabilities: volume volume-joined Aug 25 17:24:04 volumio volumio[909]: Playback channels: Mono Aug 25 17:24:04 volumio volumio[909]: Capture channels: Mono Aug 25 17:24:04 volumio volumio[909]: Limits: 0 - 200000 Aug 25 17:24:04 volumio volumio[909]: Mono: 0 [0%] Aug 25 17:24:04 volumio volumio[909]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 25 17:24:04 volumio volumio[909]: Unable to parse: Aug 25 17:24:04 volumio volumio[909]: Simple mixer control 'AES Rate',0 Aug 25 17:24:04 volumio volumio[909]: Capabilities: volume volume-joined Aug 25 17:24:04 volumio volumio[909]: Playback channels: Mono Aug 25 17:24:04 volumio volumio[909]: Capture channels: Mono Aug 25 17:24:04 volumio volumio[909]: Limits: 0 - 200000 Aug 25 17:24:04 volumio volumio[909]: Mono: 0 [0%] Aug 25 17:24:04 volumio volumio[909]: info: VolumeController:: Volume=undefined Mute =false Aug 25 17:24:04 volumio volumio[909]: info: CoreStateMachine::pushState Aug 25 17:24:04 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Aug 25 17:24:04 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Aug 25 17:24:04 volumio volumio[909]: info: CoreStateMachine::updateTrackBlock Aug 25 17:24:04 volumio volumio[909]: info: CorePlayQueue::getTrackBlock Aug 25 17:24:04 volumio volumio[909]: info: CoreCommandRouter::volumioRetrievevolume Aug 25 17:24:04 volumio volumio[909]: Unable to parse: Aug 25 17:24:04 volumio volumio[909]: Simple mixer control 'AES Rate',0 Aug 25 17:24:04 volumio volumio[909]: Capabilities: volume volume-joined Aug 25 17:24:04 volumio volumio[909]: Playback channels: Mono Aug 25 17:24:04 volumio volumio[909]: Capture channels: Mono Aug 25 17:24:04 volumio volumio[909]: Limits: 0 - 200000 Aug 25 17:24:04 volumio volumio[909]: Mono: 0 [0%] Aug 25 17:24:04 volumio volumio[909]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 25 17:24:04 volumio volumio[909]: Unable to parse: Aug 25 17:24:04 volumio volumio[909]: Simple mixer control 'AES Rate',0 Aug 25 17:24:04 volumio volumio[909]: Capabilities: volume volume-joined Aug 25 17:24:04 volumio volumio[909]: Playback channels: Mono Aug 25 17:24:04 volumio volumio[909]: Capture channels: Mono Aug 25 17:24:04 volumio volumio[909]: Limits: 0 - 200000 Aug 25 17:24:04 volumio volumio[909]: Mono: 0 [0%] Aug 25 17:24:04 volumio volumio[909]: info: VolumeController:: Volume=undefined Mute =false Aug 25 17:24:04 volumio volumio[909]: info: CoreStateMachine::pushState Aug 25 17:24:04 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Aug 25 17:24:04 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 17:24:18 volumio volumio[909]: info: Retrieving Cloud Streaming UI Aug 25 17:24:18 volumio volumio[909]: info: Getting Tidal Cloud Configuration Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 17:24:18 volumio volumio[909]: info: Getting Qobuz Cloud Configuration Aug 25 17:24:18 volumio volumio[909]: info: Asking plugin for UI Config Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 17:24:18 volumio volumio[909]: info: Getting Spotify Cloud Configuration Aug 25 17:24:18 volumio volumio[909]: info: Asking plugin for UI Config Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 17:24:18 volumio volumio[909]: info: Saving Spotify Acccount Aug 25 17:24:18 volumio volumio[909]: info: Got Tidal Cloud Configuration Aug 25 17:24:18 volumio volumio[909]: info: Got it Aug 25 17:24:18 volumio volumio[909]: info: Got it Aug 25 17:24:18 volumio volumio[909]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 17:24:18 volumio volumio[909]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::volumioGetBrowseSources Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::volumioGetBrowseSources Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::volumioGetBrowseSources Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 17:24:18 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 25 17:24:22 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 17:24:26 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 17:24:30 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 17:24:31 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Aug 25 17:24:31 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Aug 25 17:24:31 volumio volumio[909]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 17:24:31 volumio volumio[909]: Error: getaddrinfo -3007 Aug 25 17:24:31 volumio volumio[909]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Aug 25 17:24:31 volumio volumio[909]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Aug 25 17:24:31 volumio volumio[909]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Aug 25 17:24:31 volumio volumio[909]: code: -3007, Aug 25 17:24:31 volumio volumio[909]: errno: -3007, Aug 25 17:24:31 volumio volumio[909]: syscall: 'getaddrinfo' Aug 25 17:24:31 volumio volumio[909]: } Aug 25 17:24:31 volumio volumio[909]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 17:24:31 volumio sudo[24926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-25 17:23 Aug 25 17:24:31 volumio sudo[24926]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"