-- Logs begin at Tue 2020-12-22 13:39:52 UTC, end at Mon 2024-05-06 07:03:04 UTC. -- May 06 07:02:55 volumio systemd[1]: Time has been changed May 06 07:02:55 volumio volumio[816]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 06 07:02:55 volumio volumio[816]: info: [1714978975715] CoreMusicLibrary::Adding element Last_100 May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 06 07:02:55 volumio volumio[816]: info: [1714978975719] CoreMusicLibrary::Adding element Webradio May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 06 07:02:55 volumio volumio[816]: info: Configuring GPIO pins May 06 07:02:55 volumio sudo[1205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay lirc-rpi gpio_in_pin=17 May 06 07:02:55 volumio sudo[1207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service May 06 07:02:55 volumio volumio[816]: info: Soft shutdown GPIO binding... OK May 06 07:02:55 volumio sudo[1205]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:02:55 volumio volumio[816]: info: Hardware button GPIO binding... OK May 06 07:02:55 volumio sudo[1207]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:02:55 volumio volumio[816]: info: Boot OK GPIO binding... OK May 06 07:02:55 volumio systemd[1]: Starting RoonBridge... May 06 07:02:55 volumio systemd[1]: Started RoonBridge. May 06 07:02:55 volumio sudo[1207]: pam_unix(sudo:session): session closed for user root May 06 07:02:55 volumio volumio[816]: info: ------------------------------------------- May 06 07:02:55 volumio volumio[816]: info: ----- MyVolumio plugins startup ---- May 06 07:02:55 volumio volumio[816]: info: ------------------------------------------- May 06 07:02:55 volumio volumio[816]: info: [MyVolumio PluginManager] Fetching plans data.... May 06 07:02:55 volumio volumio[816]: info: Loading i18n strings for locale it May 06 07:02:55 volumio volumio[816]: Updating browse sources language May 06 07:02:55 volumio volumio[816]: Cannot find translation for sourceMedia Servers May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 07:02:55 volumio sudo[1205]: pam_unix(sudo:session): session closed for user root May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::initPlayerControls May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 07:02:55 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 07:02:56 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 07:02:56 volumio volumio[816]: info: BOOT COMPLETED May 06 07:02:56 volumio volumio[816]: [Metrics] CommandRouter: 9s 982.98ms May 06 07:02:56 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 06 07:02:57 volumio RoonBridge[1240]: 00:00:00.013 Warn: get lock file path: /tmp/.rnbgem0- May 06 07:02:57 volumio RoonBridge[1240]: 00:00:00.344 Trace: [childprocess] using unix child process May 06 07:02:57 volumio RoonBridge[1240]: Initializing May 06 07:02:57 volumio RoonBridge[1240]: 00:00:00.602 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper May 06 07:02:57 volumio RoonBridge[1240]: 00:00:00.644 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer May 06 07:02:57 volumio RoonBridge[1240]: Not Running (.o) May 06 07:02:57 volumio volumio-remote-updater[597]: [2024-05-06 07:02:57] [connect] Successful connection May 06 07:02:58 volumio RoonBridge[1240]: Running May 06 07:02:58 volumio RoonBridge[1240]: 00:00:00.027 Warn: get lock file path: /tmp/.rnbhgem0- May 06 07:03:01 volumio volumio[816]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo May 06 07:03:01 volumio volumio[816]: info: CoreCommandRouter::Close All Modals sent May 06 07:03:01 volumio volumio[816]: info: CoreCommandRouter::Close All Modals sent May 06 07:03:01 volumio volumio[816]: Express server listening on port 3000 May 06 07:03:01 volumio volumio[816]: [Metrics] WebUI: 16s 194.26ms May 06 07:03:01 volumio volumio[816]: Volumio Calling Home May 06 07:03:01 volumio volumio[816]: info: [GPIO_Control] GPIOs created May 06 07:03:01 volumio volumio[816]: info: CoreStateMachine::resetVolumioState May 06 07:03:01 volumio volumio[816]: info: CoreStateMachine::getcurrentVolume May 06 07:03:01 volumio volumio[816]: info: CoreCommandRouter::volumioRetrievevolume May 06 07:03:01 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 06 07:03:01 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 07:03:01 volumio sudo[1324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start rattenu.service May 06 07:03:01 volumio sudo[1324]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:01 volumio systemd[1]: Starting Allo Relay attenuator Service... May 06 07:03:01 volumio systemd[1]: Started Allo Relay attenuator Service. May 06 07:03:01 volumio sudo[1324]: pam_unix(sudo:session): session closed for user root May 06 07:03:01 volumio sudo[1331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 06 07:03:01 volumio sudo[1334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 06 07:03:01 volumio rattenu[1333]: Cannot retrive Volume May 06 07:03:01 volumio rattenu[1333]: Error: Writing on I2C May 06 07:03:01 volumio sudo[1331]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:01 volumio sudo[1334]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:01 volumio sudo[1331]: pam_unix(sudo:session): session closed for user root May 06 07:03:01 volumio sudo[1334]: pam_unix(sudo:session): session closed for user root May 06 07:03:02 volumio volumio[816]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 May 06 07:03:02 volumio volumio[816]: info: Setting Device type: Raspberry PI May 06 07:03:02 volumio volumio[816]: info: Error enabling lirc-rpi overlay: Error: Command failed: /usr/bin/sudo /usr/bin/dtoverlay lirc-rpi gpio_in_pin=17 May 06 07:03:02 volumio volumio[816]: DTOVERLAY[error]: failed to open '/boot/overlays/lirc-rpi.dtbo' May 06 07:03:02 volumio volumio[816]: * Failed to read '/boot/overlays/lirc-rpi.dtbo' May 06 07:03:02 volumio volumio[816]: info: MPD running with PID641 May 06 07:03:02 volumio volumio[816]: ,establishing connection May 06 07:03:02 volumio sudo[1371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 May 06 07:03:02 volumio sudo[1371]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:02 volumio sudo[1371]: pam_unix(sudo:session): session closed for user root May 06 07:03:02 volumio volumio-remote-updater[597]: [2024-05-06 07:03:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1714978977 101 May 06 07:03:02 volumio volumio[816]: info: VolumeController:: Volume=undefined Mute =false May 06 07:03:02 volumio volumio[816]: info: CoreStateMachine::pushState May 06 07:03:02 volumio volumio[816]: info: CorePlayQueue::getTrack 0 May 06 07:03:02 volumio volumio[816]: info: CoreCommandRouter::volumioPushState May 06 07:03:02 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 07:03:02 volumio volumio[816]: info: CoreStateMachine::updateTrackBlock May 06 07:03:02 volumio volumio[816]: info: CorePlayQueue::getTrackBlock May 06 07:03:02 volumio volumio[816]: info: CoreCommandRouter::volumioRetrievevolume May 06 07:03:02 volumio volumio[816]: info: R Attenu started May 06 07:03:02 volumio volumio[816]: info: Adding Allo Relay attenuator parameters{"enabled":true,"setvolumescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/setvolume.sh","getvolumescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/getvolume.sh","setmutescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/setmute.sh","getmutescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/getmute.sh","minVol":0,"maxVol":63,"mapTo100":false} May 06 07:03:02 volumio volumio[816]: info: CoreCommandRouter::volumioUpdateVolumeScripts May 06 07:03:02 volumio volumio[816]: info: Updating Volume script: {"enabled":true,"setvolumescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/setvolume.sh","getvolumescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/getvolume.sh","setmutescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/setmute.sh","getmutescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/getmute.sh","minVol":0,"maxVol":63,"mapTo100":false} May 06 07:03:02 volumio volumio[816]: info: May 06 07:03:02 volumio volumio[816]: ---------------------------- USB Audio Device Attached May 06 07:03:02 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach May 06 07:03:02 volumio volumio[816]: info: CoreCommandRouter::Close All Modals sent May 06 07:03:02 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 06 07:03:02 volumio volumio[816]: info: Output device has changed, restarting MPD May 06 07:03:02 volumio volumio[816]: info: Output device has changed, restarting Shairport Sync May 06 07:03:02 volumio sudo[1383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 06 07:03:02 volumio sudo[1383]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:02 volumio sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 06 07:03:02 volumio sudo[1383]: pam_unix(sudo:session): session closed for user root May 06 07:03:02 volumio sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:02 volumio systemd[1]: Stopping Music Player Daemon... May 06 07:03:02 volumio volumio[816]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 06 07:03:02 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 06 07:03:02 volumio volumio[816]: info: Setting mixer D90 for card D90 May 06 07:03:02 volumio volumio[816]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 06 07:03:02 volumio volumio[816]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: D90 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 May 06 07:03:02 volumio systemd[1]: Starting Music Player Daemon... May 06 07:03:02 volumio sudo[1411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/r_attenuc -c GET_VOLUME May 06 07:03:02 volumio sudo[1411]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:02 volumio sudo[1411]: pam_unix(sudo:session): session closed for user root May 06 07:03:02 volumio volumio[816]: [sudo] password for volumio: info: External Volume: 31 May 06 07:03:02 volumio sudo[1424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/r_attenuc -c GET_MUTE May 06 07:03:02 volumio sudo[1424]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:02 volumio sudo[1424]: pam_unix(sudo:session): session closed for user root May 06 07:03:02 volumio volumio[816]: [sudo] password for volumio: info: External Volume: 0 May 06 07:03:03 volumio sudo[1437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/r_attenuc -c GET_VOLUME May 06 07:03:03 volumio sudo[1437]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:03 volumio sudo[1437]: pam_unix(sudo:session): session closed for user root May 06 07:03:03 volumio volumio[816]: [sudo] password for volumio: info: External Volume: 31 May 06 07:03:03 volumio sudo[1453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/r_attenuc -c GET_MUTE May 06 07:03:03 volumio sudo[1453]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:03 volumio sudo[1453]: pam_unix(sudo:session): session closed for user root May 06 07:03:03 volumio volumio[816]: [sudo] password for volumio: info: External Volume: 0 May 06 07:03:03 volumio volumio[816]: info: VolumeController:: Volume=31 May 06 07:03:03 volumio volumio[816]: Mute =false May 06 07:03:03 volumio volumio[816]: info: CoreCommandRouter::getUIConfigOnPlugin May 06 07:03:03 volumio volumio[816]: info: CoreStateMachine::pushState May 06 07:03:03 volumio volumio[816]: info: CorePlayQueue::getTrack 0 May 06 07:03:03 volumio volumio[816]: info: CoreCommandRouter::volumioPushState May 06 07:03:03 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 07:03:03 volumio volumio[816]: info: May 06 07:03:03 volumio volumio[816]: ---------------------------- Client requests Volume 95 May 06 07:03:03 volumio volumio[816]: info: VolumeController::SetAlsaVolume95 May 06 07:03:03 volumio volumio[816]: info: Volume script /bin/sh /data/plugins/miscellanea/allo_relay_volume_attenuator/setvolume.sh 63 May 06 07:03:03 volumio sudo[1466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/r_attenuc -c SET_VOLUME=63 May 06 07:03:03 volumio sudo[1466]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:03 volumio rattenu[1333]: Error: Writing on I2C May 06 07:03:03 volumio sudo[1466]: pam_unix(sudo:session): session closed for user root May 06 07:03:03 volumio sudo[1479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/r_attenuc -c SET_MUTE=0 May 06 07:03:03 volumio sudo[1479]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:03 volumio rattenu[1333]: Error: Writing on I2C May 06 07:03:03 volumio sudo[1479]: pam_unix(sudo:session): session closed for user root May 06 07:03:03 volumio volumio[816]: [sudo] password for volumio: [sudo] password for volumio: info: External Volume: SUCCESS May 06 07:03:03 volumio volumio[816]: info: CoreStateMachine::pushState May 06 07:03:03 volumio volumio[816]: info: CorePlayQueue::getTrack 0 May 06 07:03:03 volumio volumio[816]: info: CoreCommandRouter::volumioPushState May 06 07:03:03 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 07:03:03 volumio volumio[816]: info: CoreStateMachine::pushState May 06 07:03:03 volumio volumio[816]: info: CorePlayQueue::getTrack 0 May 06 07:03:03 volumio volumio[816]: info: CoreCommandRouter::volumioPushState May 06 07:03:03 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 07:03:03 volumio volumio[816]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 May 06 07:03:03 volumio sudo[1492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/r_attenuc -c GET_VOLUME May 06 07:03:03 volumio sudo[1492]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:03 volumio sudo[1492]: pam_unix(sudo:session): session closed for user root May 06 07:03:03 volumio volumio[816]: [sudo] password for volumio: info: External Volume: 63 May 06 07:03:04 volumio sudo[1505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/r_attenuc -c GET_MUTE May 06 07:03:04 volumio sudo[1505]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 07:03:04 volumio sudo[1505]: pam_unix(sudo:session): session closed for user root May 06 07:03:04 volumio volumio[816]: [sudo] password for volumio: info: External Volume: 0 May 06 07:03:04 volumio volumio[816]: info: VolumeController:: Volume=undefined Mute =false May 06 07:03:04 volumio volumio[816]: info: CoreStateMachine::pushState May 06 07:03:04 volumio volumio[816]: info: CorePlayQueue::getTrack 0 May 06 07:03:04 volumio volumio[816]: info: CoreCommandRouter::volumioPushState May 06 07:03:04 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 07:03:04 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 06 07:03:04 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 06 07:03:04 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 06 07:03:04 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 06 07:03:04 volumio volumio[816]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat May 06 07:03:04 volumio volumio[816]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 07:03:04 volumio volumio[816]: { Error: write EPIPE May 06 07:03:04 volumio volumio[816]: at _errnoException (util.js:1022:11) May 06 07:03:04 volumio volumio[816]: at WriteWrap.afterWrite [as oncomplete] (net.js:880:14) code: 'EPIPE', errno: 'EPIPE', syscall: 'write' } May 06 07:03:04 volumio volumio[816]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 07:03:04 volumio sudo[1530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-06 07:02 May 06 07:03:04 volumio sudo[1530]: 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"