-- Logs begin at Fri 2024-08-30 08:47:44 UTC, end at Fri 2024-08-30 08:57:43 UTC. -- Aug 30 08:56:02 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:56:10 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:56:18 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:56:21 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 08:56:21 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 08:56:21 volumio volumio[2109]: info: Discovery: Getting this device information Aug 30 08:56:21 volumio volumio[2109]: info: CoreCommandRouter::volumioGetState Aug 30 08:56:21 volumio volumio[2109]: info: CorePlayQueue::getTrack 1 Aug 30 08:56:21 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Aug 30 08:56:21 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 30 08:56:21 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 30 08:56:25 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:56:33 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:56:40 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:56:48 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:56:51 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 08:56:51 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 08:56:51 volumio volumio[2109]: info: Discovery: Getting this device information Aug 30 08:56:51 volumio volumio[2109]: info: CoreCommandRouter::volumioGetState Aug 30 08:56:51 volumio volumio[2109]: info: CorePlayQueue::getTrack 1 Aug 30 08:56:51 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Aug 30 08:56:51 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 30 08:56:51 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 30 08:56:56 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:56:58 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 08:56:58 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 08:56:58 volumio volumio[2109]: info: Discovery: Getting this device information Aug 30 08:56:58 volumio volumio[2109]: info: CoreCommandRouter::volumioGetState Aug 30 08:56:58 volumio volumio[2109]: info: CorePlayQueue::getTrack 1 Aug 30 08:56:58 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Aug 30 08:56:58 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 30 08:56:58 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 30 08:56:58 volumio volumio[2109]: info: CoreCommandRouter::volumioGetState Aug 30 08:56:58 volumio volumio[2109]: info: CorePlayQueue::getTrack 1 Aug 30 08:56:58 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 08:56:58 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 08:56:59 volumio sudo[2971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 08:56:59 volumio sudo[2971]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 08:56:59 volumio sudo[2973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 08:56:59 volumio sudo[2971]: pam_unix(sudo:session): session closed for user root Aug 30 08:56:59 volumio sudo[2973]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 08:56:59 volumio sudo[2973]: pam_unix(sudo:session): session closed for user root Aug 30 08:56:59 volumio sudo[2989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 08:56:59 volumio sudo[2989]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 08:56:59 volumio sudo[2991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 08:56:59 volumio sudo[2989]: pam_unix(sudo:session): session closed for user root Aug 30 08:56:59 volumio sudo[2991]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 08:56:59 volumio sudo[2991]: pam_unix(sudo:session): session closed for user root Aug 30 08:56:59 volumio volumio[2109]: info: CoreCommandRouter::volumioGetState Aug 30 08:56:59 volumio volumio[2109]: info: CorePlayQueue::getTrack 1 Aug 30 08:56:59 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 08:56:59 volumio volumio[2109]: info: Listing playlists Aug 30 08:56:59 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 30 08:56:59 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 08:56:59 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 08:56:59 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 08:57:03 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:57:10 volumio volumio[2109]: info: CoreCommandRouter::volumioGetQueue Aug 30 08:57:10 volumio volumio[2109]: info: CoreStateMachine::getQueue Aug 30 08:57:10 volumio volumio[2109]: info: CorePlayQueue::getQueue Aug 30 08:57:10 volumio volumio[2109]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ella%20Vos/In%20Your%20Corner/fb8efab8-c50e-4dad-9edc-3fffe0930b4b.jpg' Aug 30 08:57:11 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:57:13 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 08:57:14 volumio volumio[2109]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 08:57:14 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 30 08:57:14 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 08:57:14 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 30 08:57:14 volumio volumio[2109]: info: Getting Alsa Cards List without I2S DAC Aug 30 08:57:15 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Aug 30 08:57:15 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 08:57:15 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:15 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:15 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:15 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:15 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:15 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:15 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:15 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 30 08:57:15 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 30 08:57:16 volumio volumio[2109]: info: CorePlayQueue::getTrack 1 Aug 30 08:57:16 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:16 volumio volumio[2109]: info: Prefetching next song Aug 30 08:57:16 volumio volumio[2109]: info: DOING PREFETCH IN MPD Aug 30 08:57:16 volumio volumio[2109]: verbose: ControllerMpd::sendMpdCommand add "USB/43CC-F0A2/｛ 空灵女声 ｝好听到完全窒息/Ella Vos - In Your Corner.mp3" Aug 30 08:57:16 volumio volumio[2109]: info: Aug 30 08:57:16 volumio volumio[2109]: ---------------------------- MPD announces system playlist update Aug 30 08:57:16 volumio volumio[2109]: info: Ignoring MPD Status Update Aug 30 08:57:16 volumio volumio[2109]: verbose: ControllerMpd::sendMpdCommand consume 1 Aug 30 08:57:16 volumio volumio[2109]: info: ------------------------------ 2ms Aug 30 08:57:18 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:57:21 volumio volumio[2109]: info: CoreStateMachine::startPlaybackTimer Aug 30 08:57:21 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:21 volumio volumio[2109]: info: Aug 30 08:57:21 volumio volumio[2109]: ---------------------------- MPD announces system playlist update Aug 30 08:57:21 volumio volumio[2109]: info: Ignoring MPD Status Update Aug 30 08:57:21 volumio volumio[2109]: info: Aug 30 08:57:21 volumio volumio[2109]: ---------------------------- MPD announces state update: player Aug 30 08:57:21 volumio volumio[2109]: info: ControllerMpd::getState Aug 30 08:57:21 volumio volumio[2109]: verbose: ControllerMpd::sendMpdCommand status Aug 30 08:57:21 volumio volumio[2109]: info: ------------------------------ 2ms Aug 30 08:57:21 volumio volumio[2109]: verbose: ControllerMpd::parseState Aug 30 08:57:21 volumio volumio[2109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 08:57:21 volumio volumio[2109]: verbose: ControllerMpd::parseTrackInfo Aug 30 08:57:21 volumio volumio[2109]: info: ControllerMpd::pushState Aug 30 08:57:21 volumio volumio[2109]: info: CoreCommandRouter::servicePushState Aug 30 08:57:21 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:21 volumio volumio[2109]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23,"duration":199,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"In Your Corner","artist":"Ella Vos","album":"In Your Corner","uri":"USB/43CC-F0A2/｛ 空灵女声 ｝好听到完全窒息/Ella Vos - In Your Corner.mp3","trackType":"mp3"} Aug 30 08:57:21 volumio volumio[2109]: verbose: CURRENT POSITION 2 Aug 30 08:57:21 volumio volumio[2109]: info: CoreStateMachine::syncState stateService play Aug 30 08:57:21 volumio volumio[2109]: info: CoreStateMachine::syncState currentStatus play Aug 30 08:57:21 volumio volumio[2109]: info: Received an update from plugin. extracting info from payload Aug 30 08:57:21 volumio volumio[2109]: info: CoreStateMachine::pushState Aug 30 08:57:21 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:21 volumio volumio[2109]: info: CoreCommandRouter::volumioPushState Aug 30 08:57:21 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 08:57:21 volumio volumio[2109]: info: CoreStateMachine::pushState Aug 30 08:57:21 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:21 volumio volumio[2109]: info: CoreCommandRouter::volumioPushState Aug 30 08:57:21 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 08:57:21 volumio volumio[2109]: info: ------------------------------ 14ms Aug 30 08:57:21 volumio volumio[2109]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ella%20Vos/In%20Your%20Corner/fb8efab8-c50e-4dad-9edc-3fffe0930b4b.jpg' Aug 30 08:57:21 volumio volumio[2109]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ella%20Vos/In%20Your%20Corner/fb8efab8-c50e-4dad-9edc-3fffe0930b4b.jpg' Aug 30 08:57:21 volumio volumio[2109]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ella%20Vos/In%20Your%20Corner/fb8efab8-c50e-4dad-9edc-3fffe0930b4b.jpg' Aug 30 08:57:26 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:57:26 volumio volumio[2109]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::volumioGetState Aug 30 08:57:26 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:26 volumio volumio[2109]: info: Restoring Previous Volume level: 100 false true Aug 30 08:57:26 volumio volumio[2109]: info: VolumeController::SetAlsaVolume100 Aug 30 08:57:26 volumio volumio[2109]: info: Enable softmixer device for audio device number 2 Aug 30 08:57:26 volumio volumio[2109]: info: Enable softmixer device for audio device number 2 Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::volumioStop Aug 30 08:57:26 volumio volumio[2109]: info: CoreStateMachine::stop Aug 30 08:57:26 volumio volumio[2109]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 08:57:26 volumio volumio[2109]: UNSET VOLATILE Aug 30 08:57:26 volumio volumio[2109]: info: CoreStateMachine::stPlaybackTimer Aug 30 08:57:26 volumio volumio[2109]: info: CoreStateMachine::updateTrackBlock Aug 30 08:57:26 volumio volumio[2109]: info: CorePlayQueue::getTrackBlock Aug 30 08:57:26 volumio volumio[2109]: info: CoreStateMachine::pushState Aug 30 08:57:26 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::volumioPushState Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 08:57:26 volumio volumio[2109]: info: CoreStateMachine::serviceStop Aug 30 08:57:26 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::serviceStop Aug 30 08:57:26 volumio volumio[2109]: info: ControllerMpd::stop Aug 30 08:57:26 volumio volumio[2109]: verbose: ControllerMpd::sendMpdCommand stop Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 30 08:57:26 volumio volumio[2109]: info: Updating Volume Controller Parameters: Device: 2 Name: Hifiberry DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Aug 30 08:57:26 volumio volumio[2109]: info: Output device has changed, restarting MPD Aug 30 08:57:26 volumio sudo[3094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 08:57:26 volumio volumio[2109]: info: Output device has changed, restarting Shairport Sync Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:26 volumio sudo[3094]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 08:57:26 volumio sudo[3094]: pam_unix(sudo:session): session closed for user root Aug 30 08:57:26 volumio sudo[3097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 08:57:26 volumio sudo[3097]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 08:57:26 volumio systemd[1]: Stopping Music Player Daemon... Aug 30 08:57:26 volumio volumio[2109]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 08:57:26 volumio volumio[2109]: info: Volume configurations have been set Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 30 08:57:26 volumio volumio[2109]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 08:57:26 volumio volumio[2109]: info: CoreStateMachine::pushState Aug 30 08:57:26 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::volumioPushState Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 08:57:26 volumio volumio[2109]: info: CoreStateMachine::pushState Aug 30 08:57:26 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::volumioPushState Aug 30 08:57:26 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 08:57:26 volumio volumio[2109]: error: MPD error: Error: write EPIPE Aug 30 08:57:26 volumio volumio[2109]: info: MPD Permissions set Aug 30 08:57:26 volumio volumio[2109]: info: Asound.conf file written Aug 30 08:57:26 volumio sudo[3120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 30 08:57:26 volumio sudo[3120]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 08:57:26 volumio sudo[3120]: pam_unix(sudo:session): session closed for user root Aug 30 08:57:26 volumio systemd[1]: Starting Music Player Daemon... Aug 30 08:57:27 volumio systemd[1]: Started Music Player Daemon. Aug 30 08:57:27 volumio sudo[3097]: pam_unix(sudo:session): session closed for user root Aug 30 08:57:28 volumio volumio[2109]: Playing WAVE '/volumio/app/silence.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Aug 30 08:57:28 volumio volumio[2109]: info: Output device has changed, restarting MPD Aug 30 08:57:28 volumio volumio[2109]: info: Output device has changed, restarting Shairport Sync Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio sudo[3144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 08:57:28 volumio sudo[3144]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 08:57:28 volumio sudo[3144]: pam_unix(sudo:session): session closed for user root Aug 30 08:57:28 volumio sudo[3147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 08:57:28 volumio sudo[3147]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 08:57:28 volumio systemd[1]: Stopping Music Player Daemon... Aug 30 08:57:28 volumio volumio[2109]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 30 08:57:28 volumio volumio[2109]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio systemd[1]: Starting Music Player Daemon... Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 30 08:57:28 volumio volumio[2109]: info: Getting Alsa Cards List without I2S DAC Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 30 08:57:28 volumio volumio[2109]: error: Upnp client error: Error: This socket has been ended by the other party Aug 30 08:57:28 volumio volumio[2109]: info: MPD Permissions set Aug 30 08:57:28 volumio volumio[2109]: info: CoreStateMachine::pushState Aug 30 08:57:28 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::volumioPushState Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 08:57:28 volumio volumio[2109]: info: CoreStateMachine::pushState Aug 30 08:57:28 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::volumioPushState Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 08:57:28 volumio volumio[2109]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 08:57:28 volumio volumio[2109]: info: Discovery: Getting this device information Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::volumioGetState Aug 30 08:57:28 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:28 volumio volumio[2109]: info: Starting Shairport Sync Aug 30 08:57:28 volumio mpd[3177]: output: No 'AudioOutput' defined in config file Aug 30 08:57:28 volumio mpd[3177]: output: Attempt to detect audio output device Aug 30 08:57:28 volumio mpd[3177]: output: Attempting to detect a alsa audio device Aug 30 08:57:28 volumio volumio[2109]: info: Starting Shairport Sync Aug 30 08:57:28 volumio sudo[3189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 08:57:28 volumio mpd[3177]: output: Successfully detected a alsa audio device Aug 30 08:57:28 volumio sudo[3189]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 08:57:28 volumio sudo[3147]: pam_unix(sudo:session): session closed for user root Aug 30 08:57:28 volumio systemd[1]: Started Music Player Daemon. Aug 30 08:57:28 volumio volumio[2109]: error: updateQueue error: null Aug 30 08:57:28 volumio sudo[3194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 08:57:28 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 08:57:28 volumio sudo[3194]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 08:57:28 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Aug 30 08:57:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 08:57:28 volumio sudo[3189]: pam_unix(sudo:session): session closed for user root Aug 30 08:57:28 volumio volumio[2109]: error: updateQueue error: null Aug 30 08:57:28 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 08:57:28 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Aug 30 08:57:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 08:57:28 volumio sudo[3194]: pam_unix(sudo:session): session closed for user root Aug 30 08:57:28 volumio volumio[2109]: info: Shairport-Sync Started Aug 30 08:57:28 volumio volumio[2109]: info: Shairport-Sync Started Aug 30 08:57:29 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Aug 30 08:57:29 volumio sudo[3229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 08:57:29 volumio sudo[3229]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 08:57:29 volumio systemd[1]: Stopping Music Player Daemon... Aug 30 08:57:29 volumio systemd[1]: Starting Music Player Daemon... Aug 30 08:57:30 volumio systemd[1]: Started Music Player Daemon. Aug 30 08:57:30 volumio sudo[3229]: pam_unix(sudo:session): session closed for user root Aug 30 08:57:30 volumio volumio[2109]: error: updateQueue error: null Aug 30 08:57:31 volumio volumio[2109]: info: VolumeController::SetAlsaVolume100 Aug 30 08:57:31 volumio volumio[2109]: info: CoreStateMachine::pushState Aug 30 08:57:31 volumio volumio[2109]: info: CorePlayQueue::getTrack 2 Aug 30 08:57:31 volumio volumio[2109]: info: CoreCommandRouter::volumioPushState Aug 30 08:57:31 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 08:57:31 volumio volumio[2109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 08:57:31 volumio volumio[2109]: error: updateQueue error: null Aug 30 08:57:34 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:57:41 volumio wpa_supplicant[999]: wlan0: Failed to initiate sched scan Aug 30 08:57:43 volumio volumio[2109]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 08:57:43 volumio volumio[2109]: { Error: connect ETIMEDOUT 157.240.12.36:443 Aug 30 08:57:43 volumio volumio[2109]: at Object._errnoException (util.js:1022:11) Aug 30 08:57:43 volumio volumio[2109]: at _exceptionWithHostPort (util.js:1044:20) Aug 30 08:57:43 volumio volumio[2109]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Aug 30 08:57:43 volumio volumio[2109]: code: 'ETIMEDOUT', Aug 30 08:57:43 volumio volumio[2109]: errno: 'ETIMEDOUT', Aug 30 08:57:43 volumio volumio[2109]: syscall: 'connect', Aug 30 08:57:43 volumio volumio[2109]: address: '157.240.12.36', Aug 30 08:57:43 volumio volumio[2109]: port: 443 } Aug 30 08:57:43 volumio volumio[2109]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 08:57:43 volumio sudo[3253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-30 08:56 Aug 30 08:57:43 volumio sudo[3253]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="03f7bbd984817e093cac62b7ff876f3c2cfabc1d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 22 14:39:52 CET 2020" VOLUMIO_VERSION="2.861" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="097e28ee6263e31d0bf6b690a02dcab3"