-- Logs begin at Sun 2024-04-07 05:03:24 UTC, end at Wed 2024-04-24 13:37:34 UTC. -- Apr 24 13:36:22 volumio sudo[1540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 24 13:36:22 volumio sudo[1540]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:36:22 volumio sudo[1542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:36:22 volumio sudo[1540]: pam_unix(sudo:session): session closed for user root Apr 24 13:36:22 volumio sudo[1542]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:36:22 volumio sudo[1542]: pam_unix(sudo:session): session closed for user root Apr 24 13:36:23 volumio volumio[834]: info: CoreCommandRouter::volumioGetVisibleSources Apr 24 13:36:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 13:36:23 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Apr 24 13:36:23 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:36:23 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 24 13:36:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:36:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 24 13:36:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 24 13:36:23 volumio sudo[1562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:36:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 24 13:36:23 volumio volumio[834]: info: Listing playlists Apr 24 13:36:23 volumio sudo[1562]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:36:23 volumio sudo[1562]: pam_unix(sudo:session): session closed for user root Apr 24 13:36:23 volumio sudo[1566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:36:23 volumio sudo[1566]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:36:23 volumio sudo[1566]: pam_unix(sudo:session): session closed for user root Apr 24 13:36:25 volumio volumio[834]: info: CoreCommandRouter::volumioPlay Apr 24 13:36:25 volumio volumio[834]: UNSET VOLATILE Apr 24 13:36:25 volumio volumio[834]: info: CoreStateMachine::play index undefined Apr 24 13:36:25 volumio volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 13:36:25 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:25 volumio volumio[834]: info: CoreStateMachine::startPlaybackTimer Apr 24 13:36:25 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:25 volumio volumio[834]: info: ControllerMpd::clearAddPlayTracks USB/Transcend/05 Jerusalem.wav Apr 24 13:36:25 volumio volumio[834]: info: ControllerMpd::sendMpdCommand stop Apr 24 13:36:25 volumio volumio[834]: info: sending command... Apr 24 13:36:25 volumio volumio[834]: info: parsing response... Apr 24 13:36:25 volumio volumio[834]: info: ControllerMpd::sendMpdCommand clear Apr 24 13:36:25 volumio volumio[834]: info: sending command... Apr 24 13:36:25 volumio volumio[834]: info: Apr 24 13:36:25 volumio volumio[834]: ---------------------------- MPD announces system playlist update Apr 24 13:36:25 volumio volumio[834]: info: Ignoring MPD Status Update Apr 24 13:36:25 volumio volumio[834]: info: parsing response... Apr 24 13:36:25 volumio volumio[834]: info: ControllerMpd::sendMpdCommand add "USB/Transcend/05 Jerusalem.wav" Apr 24 13:36:25 volumio volumio[834]: info: sending command... Apr 24 13:36:25 volumio volumio[834]: info: Apr 24 13:36:25 volumio volumio[834]: ---------------------------- MPD announces system playlist update Apr 24 13:36:25 volumio volumio[834]: info: Ignoring MPD Status Update Apr 24 13:36:25 volumio volumio[834]: info: Apr 24 13:36:25 volumio volumio[834]: info: Apr 24 13:36:25 volumio volumio[834]: ---------------------------- MPD announces system playlist update Apr 24 13:36:25 volumio volumio[834]: info: Ignoring MPD Status Update Apr 24 13:36:25 volumio volumio[834]: info: ------------------------------ 74ms Apr 24 13:36:25 volumio volumio[834]: info: parsing response... Apr 24 13:36:25 volumio volumio[834]: info: ------------------------------ 47ms Apr 24 13:36:25 volumio volumio[834]: info: ControllerMpd::sendMpdCommand play Apr 24 13:36:25 volumio volumio[834]: info: sending command... Apr 24 13:36:25 volumio volumio[834]: info: Apr 24 13:36:25 volumio volumio[834]: ---------------------------- MPD announces system playlist update Apr 24 13:36:25 volumio volumio[834]: info: Ignoring MPD Status Update Apr 24 13:36:25 volumio volumio[834]: info: ------------------------------ 108ms Apr 24 13:36:25 volumio volumio[834]: info: parsing response... Apr 24 13:36:25 volumio volumio[834]: info: ------------------------------ 68ms Apr 24 13:36:25 volumio volumio[834]: info: Apr 24 13:36:25 volumio volumio[834]: ---------------------------- MPD announces state update: player Apr 24 13:36:25 volumio volumio[834]: info: ControllerMpd::getState Apr 24 13:36:25 volumio volumio[834]: info: ControllerMpd::sendMpdCommand status Apr 24 13:36:25 volumio volumio[834]: info: sending command... Apr 24 13:36:25 volumio volumio[834]: info: Apr 24 13:36:25 volumio volumio[834]: ---------------------------- MPD announces state update: player Apr 24 13:36:25 volumio volumio[834]: info: ControllerMpd::getState Apr 24 13:36:25 volumio volumio[834]: info: ControllerMpd::sendMpdCommand status Apr 24 13:36:25 volumio volumio[834]: info: sending command... Apr 24 13:36:26 volumio volumio[834]: info: Apr 24 13:36:26 volumio volumio[834]: ---------------------------- MPD announces state update: player Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::getState Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::sendMpdCommand status Apr 24 13:36:26 volumio volumio[834]: info: parsing response... Apr 24 13:36:26 volumio volumio[834]: info: parsing response... Apr 24 13:36:26 volumio volumio[834]: info: sending command... Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::parseState Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::parseState Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 24 13:36:26 volumio volumio[834]: info: sending command... Apr 24 13:36:26 volumio volumio[834]: info: sending command... Apr 24 13:36:26 volumio volumio[834]: info: Apr 24 13:36:26 volumio volumio[834]: ---------------------------- MPD announces state update: player Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::getState Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::sendMpdCommand status Apr 24 13:36:26 volumio volumio[834]: info: sending command... Apr 24 13:36:26 volumio volumio[834]: info: parsing response... Apr 24 13:36:26 volumio volumio[834]: info: parsing response... Apr 24 13:36:26 volumio volumio[834]: info: parsing response... Apr 24 13:36:26 volumio volumio[834]: info: parsing response... Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::parseState Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::parseTrackInfo Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::parseTrackInfo Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::parseState Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 24 13:36:26 volumio volumio[834]: info: sending command... Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::pushState Apr 24 13:36:26 volumio volumio[834]: info: CoreCommandRouter::servicePushState Apr 24 13:36:26 volumio volumio[834]: info: CoreStateMachine::syncState Apr 24 13:36:26 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:26 volumio volumio[834]: info: STATE SERVICE {"status":"play","position":0,"seek":673,"duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Jerusalem","artist":"BBC Chorus; BBC Symphony Orchestra","album":null,"uri":"USB/Transcend/05 Jerusalem.wav","trackType":"wav"} Apr 24 13:36:26 volumio volumio[834]: info: CURRENT POSITION 0 Apr 24 13:36:26 volumio volumio[834]: info: CoreStateMachine::syncState stateService play Apr 24 13:36:26 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus stop Apr 24 13:36:26 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:36:26 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:36:26 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:26 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:36:26 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:36:26 volumio volumio[834]: info: ControllerMpd::pushState Apr 24 13:36:26 volumio volumio[834]: info: CoreCommandRouter::servicePushState Apr 24 13:36:26 volumio volumio[834]: info: CoreStateMachine::syncState Apr 24 13:36:26 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:26 volumio volumio[834]: info: STATE SERVICE {"status":"play","position":0,"seek":766,"duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Jerusalem","artist":"BBC Chorus; BBC Symphony Orchestra","album":null,"uri":"USB/Transcend/05 Jerusalem.wav","trackType":"wav"} Apr 24 13:36:26 volumio volumio[834]: info: CURRENT POSITION 0 Apr 24 13:36:26 volumio volumio[834]: info: CoreStateMachine::syncState stateService play Apr 24 13:36:26 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus play Apr 24 13:36:26 volumio volumio[834]: info: Received an update from plugin. extracting info from payload Apr 24 13:36:26 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:36:26 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:36:26 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:26 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:36:26 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:36:26 volumio sudo[1589]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:36:26 volumio sudo[1589]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:36:26 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:36:26 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:36:26 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:26 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:36:26 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:36:26 volumio sudo[1589]: pam_unix(sudo:session): session closed for user root Apr 24 13:36:27 volumio volumio[834]: info: sending command... Apr 24 13:36:27 volumio sudo[1595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:36:27 volumio sudo[1595]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:36:27 volumio sudo[1595]: pam_unix(sudo:session): session closed for user root Apr 24 13:36:27 volumio sudo[1602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:36:27 volumio sudo[1602]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:36:27 volumio volumio[834]: info: ------------------------------ 1548ms Apr 24 13:36:27 volumio volumio[834]: info: ------------------------------ 1442ms Apr 24 13:36:27 volumio sudo[1602]: pam_unix(sudo:session): session closed for user root Apr 24 13:36:27 volumio volumio[834]: info: parsing response... Apr 24 13:36:27 volumio volumio[834]: info: parsing response... Apr 24 13:36:27 volumio volumio[834]: info: ControllerMpd::parseTrackInfo Apr 24 13:36:27 volumio volumio[834]: info: ControllerMpd::parseTrackInfo Apr 24 13:36:27 volumio volumio[834]: info: ControllerMpd::pushState Apr 24 13:36:27 volumio volumio[834]: info: CoreCommandRouter::servicePushState Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::syncState Apr 24 13:36:27 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:27 volumio volumio[834]: info: STATE SERVICE {"status":"play","position":0,"seek":975,"duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Jerusalem","artist":"BBC Chorus; BBC Symphony Orchestra","album":null,"uri":"USB/Transcend/05 Jerusalem.wav","trackType":"wav"} Apr 24 13:36:27 volumio volumio[834]: info: CURRENT POSITION 0 Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::syncState stateService play Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus play Apr 24 13:36:27 volumio volumio[834]: info: Received an update from plugin. extracting info from payload Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:36:27 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:27 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:36:27 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:36:27 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:27 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:36:27 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:36:27 volumio volumio[834]: info: ControllerMpd::pushState Apr 24 13:36:27 volumio sudo[1622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:36:27 volumio volumio[834]: info: CoreCommandRouter::servicePushState Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::syncState Apr 24 13:36:27 volumio sudo[1622]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:36:27 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:27 volumio volumio[834]: info: STATE SERVICE {"status":"play","position":0,"seek":1184,"duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Jerusalem","artist":"BBC Chorus; BBC Symphony Orchestra","album":null,"uri":"USB/Transcend/05 Jerusalem.wav","trackType":"wav"} Apr 24 13:36:27 volumio volumio[834]: info: CURRENT POSITION 0 Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::syncState stateService play Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus play Apr 24 13:36:27 volumio volumio[834]: info: Received an update from plugin. extracting info from payload Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:36:27 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:27 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:36:27 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:36:27 volumio sudo[1622]: pam_unix(sudo:session): session closed for user root Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:36:27 volumio sudo[1624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:36:27 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:36:27 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:27 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:36:27 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:36:28 volumio sudo[1624]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:36:28 volumio sudo[1624]: pam_unix(sudo:session): session closed for user root Apr 24 13:36:28 volumio sudo[1636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:36:28 volumio sudo[1636]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:36:28 volumio sudo[1636]: pam_unix(sudo:session): session closed for user root Apr 24 13:36:28 volumio sudo[1646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:36:28 volumio volumio[834]: info: ------------------------------ 2334ms Apr 24 13:36:28 volumio volumio[834]: info: ------------------------------ 2115ms Apr 24 13:36:28 volumio sudo[1646]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:36:28 volumio sudo[1646]: pam_unix(sudo:session): session closed for user root Apr 24 13:36:30 volumio volumio[834]: info: VolumeController::SetAlsaVolume+ Apr 24 13:36:30 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:36:30 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:36:30 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:30 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:36:30 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:36:31 volumio volumio[834]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 24 13:36:31 volumio sudo[1674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:36:31 volumio sudo[1674]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:36:31 volumio sudo[1674]: pam_unix(sudo:session): session closed for user root Apr 24 13:36:31 volumio volumio[834]: info: VolumeController::SetAlsaVolume85 Apr 24 13:36:31 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:36:31 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:36:31 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:36:31 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:36:31 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:36:31 volumio volumio[834]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 24 13:36:31 volumio sudo[1686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:36:31 volumio sudo[1686]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:36:31 volumio sudo[1686]: pam_unix(sudo:session): session closed for user root Apr 24 13:36:42 volumio volumio[834]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 13:36:42 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 24 13:36:42 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 13:36:42 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 24 13:36:43 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:36:43 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:36:43 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:36:43 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:36:43 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:36:43 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:36:43 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:36:43 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:36:43 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 24 13:36:43 volumio volumio[834]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 13:37:13 volumio volumio[834]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Apr 24 13:37:13 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Apr 24 13:37:13 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Apr 24 13:37:13 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:37:13 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:13 volumio volumio[834]: info: Restoring Previous Volume level: 85 false true Apr 24 13:37:13 volumio volumio[834]: info: VolumeController::SetAlsaVolume100 Apr 24 13:37:13 volumio volumio[834]: info: Enable softmixer device for audio device number Loopback Apr 24 13:37:13 volumio volumio[834]: info: Enable softmixer device for audio device number Loopback Apr 24 13:37:13 volumio volumio[834]: info: CoreCommandRouter::volumioStop Apr 24 13:37:13 volumio volumio[834]: info: CoreStateMachine::stop Apr 24 13:37:13 volumio volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 13:37:13 volumio volumio[834]: UNSET VOLATILE Apr 24 13:37:13 volumio volumio[834]: info: CoreStateMachine::stPlaybackTimer Apr 24 13:37:13 volumio volumio[834]: info: CoreStateMachine::updateTrackBlock Apr 24 13:37:13 volumio volumio[834]: info: CorePlayQueue::getTrackBlock Apr 24 13:37:13 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:37:13 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:37:13 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:13 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:37:13 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:37:14 volumio volumio[834]: info: CoreStateMachine::serviceStop Apr 24 13:37:14 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:14 volumio volumio[834]: info: CoreCommandRouter::serviceStop Apr 24 13:37:14 volumio volumio[834]: info: ControllerMpd::stop Apr 24 13:37:14 volumio volumio[834]: info: ControllerMpd::sendMpdCommand stop Apr 24 13:37:14 volumio sudo[1785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:37:14 volumio sudo[1785]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:14 volumio sudo[1785]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:14 volumio volumio[834]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 24 13:37:14 volumio volumio[834]: info: Updating Volume Controller Parameters: Device: Loopback Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Apr 24 13:37:14 volumio volumio[834]: info: Output device has changed, restarting MPD Apr 24 13:37:14 volumio volumio[834]: info: Output device has changed, restarting Shairport Sync Apr 24 13:37:14 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:14 volumio sudo[1799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 24 13:37:14 volumio sudo[1799]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:14 volumio sudo[1799]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:14 volumio sudo[1801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 24 13:37:14 volumio sudo[1801]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:14 volumio systemd[1]: Stopping Music Player Daemon... Apr 24 13:37:14 volumio volumio[834]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 24 13:37:14 volumio volumio[834]: info: Volume configurations have been set Apr 24 13:37:15 volumio volumio[834]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 24 13:37:15 volumio volumio[834]: info: Updating Volume Controller Parameters: Device: Loopback Name: softvolume Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Apr 24 13:37:15 volumio volumio[834]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 13:37:15 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:37:15 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:37:15 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:15 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:37:15 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:37:15 volumio systemd[1]: Starting Music Player Daemon... Apr 24 13:37:15 volumio volumio[834]: info: sending command... Apr 24 13:37:15 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:37:15 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:37:15 volumio sudo[1829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:37:15 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:15 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:37:15 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:37:15 volumio sudo[1829]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:16 volumio sudo[1829]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:16 volumio volumio[834]: error: MPD error: Error: write EPIPE Apr 24 13:37:16 volumio sudo[1835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:37:16 volumio sudo[1835]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:16 volumio sudo[1835]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:16 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:37:16 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:37:16 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:16 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:37:16 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:37:16 volumio volumio[834]: info: MPD Permissions set Apr 24 13:37:16 volumio volumio[834]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 24 13:37:16 volumio volumio[834]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 24 13:37:16 volumio sudo[1851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:37:16 volumio volumio[834]: info: Asound.conf file written Apr 24 13:37:16 volumio sudo[1851]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:17 volumio sudo[1851]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:17 volumio sudo[1856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 24 13:37:17 volumio sudo[1856]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:17 volumio sudo[1856]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:19 volumio volumio[834]: Playing WAVE '/volumio/app/silence.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Apr 24 13:37:19 volumio volumio[834]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" Apr 24 13:37:19 volumio volumio[834]: Hardware is initialized using a generic method Apr 24 13:37:19 volumio volumio[834]: info: Output device has changed, restarting MPD Apr 24 13:37:19 volumio volumio[834]: info: Output device has changed, restarting Shairport Sync Apr 24 13:37:19 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:19 volumio sudo[1877]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 24 13:37:19 volumio sudo[1877]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:20 volumio sudo[1877]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:20 volumio sudo[1879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 24 13:37:20 volumio sudo[1879]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:20 volumio systemd[1]: Stopping Music Player Daemon... Apr 24 13:37:20 volumio volumio[834]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 24 13:37:20 volumio systemd[1]: Starting Music Player Daemon... Apr 24 13:37:20 volumio volumio[834]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 24 13:37:20 volumio volumio[834]: info: Updating Volume Controller Parameters: Device: Loopback Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Apr 24 13:37:20 volumio volumio[834]: info: VolumeController::SetAlsaVolume85 Apr 24 13:37:21 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:37:21 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:37:21 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:21 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:37:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:37:21 volumio volumio[834]: { device: '1', Apr 24 13:37:21 volumio volumio[834]: name: 'HiFiBerry DAC Plus', Apr 24 13:37:21 volumio volumio[834]: mixer: '', Apr 24 13:37:21 volumio volumio[834]: mixertype: 'undefined', Apr 24 13:37:21 volumio volumio[834]: maxvolume: '100', Apr 24 13:37:21 volumio volumio[834]: volumecurve: 'logarithmic', Apr 24 13:37:21 volumio volumio[834]: volumestart: 'disabled', Apr 24 13:37:21 volumio volumio[834]: volumesteps: '10' } Apr 24 13:37:21 volumio volumio[834]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 24 13:37:21 volumio volumio[834]: info: Updating Volume Controller Parameters: Device: 1 Name: HiFiBerry DAC Plus Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Apr 24 13:37:21 volumio sudo[1907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:37:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:21 volumio sudo[1907]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:21 volumio sudo[1907]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:22 volumio sudo[1918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volparametriceq.service Apr 24 13:37:22 volumio sudo[1918]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:22 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:22 volumio systemd[1]: Starting alsaloop for volparametric equalizer... Apr 24 13:37:22 volumio systemd[1]: Started alsaloop for volparametric equalizer. Apr 24 13:37:22 volumio sudo[1918]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:22 volumio volumio[1928]: ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 24 13:37:22 volumio systemd[1]: volparametriceq.service: main process exited, code=exited, status=1/FAILURE Apr 24 13:37:22 volumio volumio[1928]: playback outplugin open error: No such file or directory Apr 24 13:37:22 volumio volumio[1928]: Loopback initialization failure. Apr 24 13:37:22 volumio systemd[1]: Unit volparametriceq.service entered failed state. Apr 24 13:37:22 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 24 13:37:22 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 13:37:22 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 24 13:37:22 volumio systemd[1]: volparametriceq.service holdoff time over, scheduling restart. Apr 24 13:37:22 volumio systemd[1]: Stopping alsaloop for volparametric equalizer... Apr 24 13:37:22 volumio systemd[1]: Starting alsaloop for volparametric equalizer... Apr 24 13:37:22 volumio systemd[1]: Started alsaloop for volparametric equalizer. Apr 24 13:37:23 volumio volumio[1935]: ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 24 13:37:23 volumio systemd[1]: volparametriceq.service: main process exited, code=exited, status=1/FAILURE Apr 24 13:37:23 volumio volumio[1935]: playback outplugin open error: No such file or directory Apr 24 13:37:23 volumio volumio[1935]: Loopback initialization failure. Apr 24 13:37:23 volumio systemd[1]: Unit volparametriceq.service entered failed state. Apr 24 13:37:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:37:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:37:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:37:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:37:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:37:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:37:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:37:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 13:37:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 24 13:37:23 volumio volumio[834]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 13:37:23 volumio systemd[1]: volparametriceq.service holdoff time over, scheduling restart. Apr 24 13:37:23 volumio systemd[1]: Stopping alsaloop for volparametric equalizer... Apr 24 13:37:23 volumio systemd[1]: Starting alsaloop for volparametric equalizer... Apr 24 13:37:23 volumio systemd[1]: Started alsaloop for volparametric equalizer. Apr 24 13:37:23 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:37:23 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:37:23 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:23 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:37:23 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:37:23 volumio systemd[1]: volparametriceq.service: main process exited, code=exited, status=1/FAILURE Apr 24 13:37:23 volumio systemd[1]: Unit volparametriceq.service entered failed state. Apr 24 13:37:23 volumio volumio[1939]: ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 24 13:37:23 volumio volumio[1939]: playback outplugin open error: No such file or directory Apr 24 13:37:23 volumio volumio[1939]: Loopback initialization failure. Apr 24 13:37:23 volumio systemd[1]: volparametriceq.service holdoff time over, scheduling restart. Apr 24 13:37:23 volumio systemd[1]: Stopping alsaloop for volparametric equalizer... Apr 24 13:37:23 volumio systemd[1]: Starting alsaloop for volparametric equalizer... Apr 24 13:37:23 volumio systemd[1]: Started alsaloop for volparametric equalizer. Apr 24 13:37:23 volumio volumio[834]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 24 13:37:23 volumio volumio[834]: info: MPD Permissions set Apr 24 13:37:24 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Apr 24 13:37:24 volumio sudo[1944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:37:24 volumio volumio[1945]: ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 24 13:37:24 volumio systemd[1]: volparametriceq.service: main process exited, code=exited, status=1/FAILURE Apr 24 13:37:24 volumio volumio[1945]: playback outplugin open error: No such file or directory Apr 24 13:37:24 volumio volumio[1945]: Loopback initialization failure. Apr 24 13:37:24 volumio sudo[1944]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:24 volumio systemd[1]: Unit volparametriceq.service entered failed state. Apr 24 13:37:24 volumio systemd[1]: volparametriceq.service holdoff time over, scheduling restart. Apr 24 13:37:24 volumio systemd[1]: Stopping alsaloop for volparametric equalizer... Apr 24 13:37:24 volumio systemd[1]: Starting alsaloop for volparametric equalizer... Apr 24 13:37:24 volumio systemd[1]: Started alsaloop for volparametric equalizer. Apr 24 13:37:24 volumio sudo[1944]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:24 volumio sudo[1949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 24 13:37:24 volumio volumio[1955]: ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 24 13:37:24 volumio volumio[1955]: playback outplugin open error: No such file or directory Apr 24 13:37:24 volumio volumio[1955]: Loopback initialization failure. Apr 24 13:37:24 volumio sudo[1949]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:24 volumio systemd[1]: volparametriceq.service: main process exited, code=exited, status=1/FAILURE Apr 24 13:37:24 volumio systemd[1]: Unit volparametriceq.service entered failed state. Apr 24 13:37:24 volumio systemd[1]: volparametriceq.service holdoff time over, scheduling restart. Apr 24 13:37:24 volumio systemd[1]: Stopping alsaloop for volparametric equalizer... Apr 24 13:37:24 volumio systemd[1]: Starting alsaloop for volparametric equalizer... Apr 24 13:37:24 volumio systemd[1]: volparametriceq.service start request repeated too quickly, refusing to start. Apr 24 13:37:24 volumio systemd[1]: Failed to start alsaloop for volparametric equalizer. Apr 24 13:37:24 volumio systemd[1]: Unit volparametriceq.service entered failed state. Apr 24 13:37:24 volumio systemd[1]: Stopping Music Player Daemon... Apr 24 13:37:25 volumio systemd[1]: Starting Music Player Daemon... Apr 24 13:37:25 volumio volumio[834]: info: VolumeController:: Volume=undefined Mute =false Apr 24 13:37:25 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:37:25 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:37:25 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:25 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:37:25 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:37:25 volumio volumio[834]: info: Alsaloop bridge ok Apr 24 13:37:25 volumio volumio[834]: { device: '1', Apr 24 13:37:25 volumio volumio[834]: name: 'HiFiBerry DAC Plus', Apr 24 13:37:25 volumio volumio[834]: mixer: '', Apr 24 13:37:25 volumio volumio[834]: mixertype: 'undefined', Apr 24 13:37:25 volumio volumio[834]: maxvolume: '100', Apr 24 13:37:25 volumio volumio[834]: volumecurve: 'logarithmic', Apr 24 13:37:25 volumio volumio[834]: volumestart: 'disabled', Apr 24 13:37:25 volumio volumio[834]: volumesteps: '10' } Apr 24 13:37:25 volumio volumio[834]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 24 13:37:25 volumio volumio[834]: info: Updating Volume Controller Parameters: Device: 1 Name: HiFiBerry DAC Plus Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Apr 24 13:37:25 volumio sudo[1973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:37:25 volumio sudo[1973]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:25 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:25 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:25 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:25 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:25 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:25 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:25 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:25 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:25 volumio sudo[1973]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:25 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 13:37:26 volumio volumio[834]: info: VolumeController::SetAlsaVolume0 Apr 24 13:37:26 volumio sudo[1989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Apr 24 13:37:26 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:37:26 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:37:26 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:26 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:37:26 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:37:26 volumio sudo[1989]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:26 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Apr 24 13:37:26 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Apr 24 13:37:26 volumio systemd[1]: Started ShairportSync AirTunes receiver. Apr 24 13:37:26 volumio sudo[1989]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:26 volumio shairport-sync[1998]: Successful Startup Apr 24 13:37:26 volumio sudo[1997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:37:26 volumio sudo[1997]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:27 volumio sudo[1997]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:27 volumio volumio[834]: info: CoreCommandRouter::volumioPlay Apr 24 13:37:27 volumio volumio[834]: UNSET VOLATILE Apr 24 13:37:27 volumio volumio[834]: info: CoreStateMachine::play index undefined Apr 24 13:37:27 volumio volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 13:37:27 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:27 volumio volumio[834]: info: CoreStateMachine::startPlaybackTimer Apr 24 13:37:27 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:27 volumio volumio[834]: info: ControllerMpd::clearAddPlayTracks USB/Transcend/05 Jerusalem.wav Apr 24 13:37:27 volumio volumio[834]: info: ControllerMpd::sendMpdCommand stop Apr 24 13:37:27 volumio sudo[2013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volparametriceq.service Apr 24 13:37:27 volumio sudo[2013]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:27 volumio volumio[834]: info: VolumeController:: Volume=undefined Mute =false Apr 24 13:37:27 volumio volumio[834]: info: CoreStateMachine::pushState Apr 24 13:37:27 volumio volumio[834]: info: CoreStateMachine::getState Apr 24 13:37:27 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:27 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Apr 24 13:37:27 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 13:37:27 volumio systemd[1]: Starting alsaloop for volparametric equalizer... Apr 24 13:37:27 volumio systemd[1]: volparametriceq.service start request repeated too quickly, refusing to start. Apr 24 13:37:27 volumio systemd[1]: Failed to start alsaloop for volparametric equalizer. Apr 24 13:37:27 volumio sudo[2013]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:27 volumio volumio[834]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 24 13:37:27 volumio volumio[834]: info: Shairport-Sync Started Apr 24 13:37:27 volumio volumio[834]: info: failed to bridge Error: Command failed: /usr/bin/sudo /bin/systemctl start volparametriceq.service Apr 24 13:37:27 volumio volumio[834]: Job for volparametriceq.service failed. See 'systemctl status volparametriceq.service' and 'journalctl -xn' for details. Apr 24 13:37:27 volumio sudo[2022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 13:37:27 volumio sudo[2022]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:28 volumio sudo[2022]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:28 volumio sudo[2029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Apr 24 13:37:28 volumio volumio[834]: info: CoreCommandRouter::volumioSeek Apr 24 13:37:28 volumio sudo[2029]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 13:37:28 volumio volumio[834]: info: CoreStateMachine::seek Apr 24 13:37:28 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:28 volumio volumio[834]: info: TRACKBLOCK {"uri":"mnt/USB/Transcend/05 Jerusalem.wav","service":"mpd","name":"Jerusalem","artist":"BBC Chorus; BBC Symphony Orchestra","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=71&web=BBC%20Chorus%3B%20BBC%20Symphony%20Orchestra//extralarge&path=%2FUSB%2FTranscend&metadata=false","duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"wav","channels":2} Apr 24 13:37:28 volumio volumio[834]: info: CoreStateMachine::startPlaybackTimer Apr 24 13:37:28 volumio volumio[834]: info: CorePlayQueue::getTrack 0 Apr 24 13:37:28 volumio volumio[834]: info: ControllerMpd::seek Apr 24 13:37:28 volumio volumio[834]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 13:37:28 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Apr 24 13:37:28 volumio volumio[834]: { AssertionError [ERR_ASSERTION]: false == true Apr 24 13:37:28 volumio volumio[834]: at MpdClient.sendCommand (/volumio/app/plugins/music_service/mpd/lib/mpd.js:92:9) Apr 24 13:37:28 volumio volumio[834]: at ControllerMpd.seek (/volumio/app/plugins/music_service/mpd/index.js:2841:24) Apr 24 13:37:28 volumio volumio[834]: at CoreStateMachine.seek (/volumio/app/statemachine.js:1242:15) Apr 24 13:37:28 volumio volumio[834]: at CoreCommandRouter.volumioSeek (/volumio/app/index.js:1390:27) Apr 24 13:37:28 volumio volumio[834]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:148:31) Apr 24 13:37:28 volumio volumio[834]: at emitTwo (events.js:126:13) Apr 24 13:37:28 volumio volumio[834]: at Socket.emit (events.js:214:7) Apr 24 13:37:28 volumio volumio[834]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Apr 24 13:37:28 volumio volumio[834]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Apr 24 13:37:28 volumio volumio[834]: at process._tickCallback (internal/process/next_tick.js:180:9) Apr 24 13:37:28 volumio volumio[834]: generatedMessage: true, Apr 24 13:37:28 volumio volumio[834]: name: 'AssertionError [ERR_ASSERTION]', Apr 24 13:37:28 volumio volumio[834]: code: 'ERR_ASSERTION', Apr 24 13:37:28 volumio volumio[834]: actual: false, Apr 24 13:37:28 volumio volumio[834]: expected: true, Apr 24 13:37:28 volumio volumio[834]: operator: '==' } Apr 24 13:37:28 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Apr 24 13:37:28 volumio systemd[1]: Started ShairportSync AirTunes receiver. Apr 24 13:37:28 volumio volumio[834]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 13:37:28 volumio sudo[2029]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:28 volumio shairport-sync[2042]: Successful Startup Apr 24 13:37:31 volumio systemd[1]: Started Music Player Daemon. Apr 24 13:37:31 volumio sudo[1801]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:31 volumio sudo[1879]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:31 volumio sudo[1949]: pam_unix(sudo:session): session closed for user root Apr 24 13:37:34 volumio sudo[2069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-24 13:36 Apr 24 13:37:34 volumio sudo[2069]: 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="76976c3150e60fa37f55c84c5ca4b7a47b667b83" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="2b418696ba9df7da37e66ecee4256e963897e4a2" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun Dec 1 01:32:00 CET 2019" VOLUMIO_VERSION="2.673" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="195d359258dcdb7969a22e2c84f33e21"