-- Logs begin at Sat 2022-10-08 11:18:23 UTC, end at Sun 2024-05-12 19:18:35 UTC. -- May 12 19:18:27 volumiogranja systemd[1]: Time has been changed May 12 19:18:27 volumiogranja volumio[771]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 19:18:27 volumiogranja volumio[771]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 19:18:27 volumiogranja volumio[771]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 19:18:27 volumiogranja volumio[771]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 19:18:27 volumiogranja volumio[771]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 19:18:27 volumiogranja volumio[771]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 19:18:27 volumiogranja volumio[771]: info: BOOT COMPLETED May 12 19:18:27 volumiogranja volumio[771]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 19:18:27 volumiogranja volumio[771]: info: CoreCommandRouter::Close All Modals sent May 12 19:18:27 volumiogranja volumio[771]: Express server listening on port 3000 May 12 19:18:27 volumiogranja volumio[771]: Volumio Calling Home May 12 19:18:27 volumiogranja volumio[771]: info: CoreStateMachine::resetVolumioState May 12 19:18:27 volumiogranja volumio[771]: info: CoreStateMachine::getcurrentVolume May 12 19:18:27 volumiogranja volumio[771]: info: CoreCommandRouter::volumioRetrievevolume May 12 19:18:27 volumiogranja volumio[771]: info: CoreStateMachine::updateTrackBlock May 12 19:18:27 volumiogranja volumio[771]: info: CorePlayQueue::getTrackBlock May 12 19:18:28 volumiogranja kernel: Under-voltage detected! (0x00050005) May 12 19:18:28 volumiogranja volumio[771]: info: Setting Device type: Raspberry PI May 12 19:18:28 volumiogranja volumio[771]: info: MPD running with PID561 ,establishing connection May 12 19:18:28 volumiogranja sudo[922]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 May 12 19:18:28 volumiogranja sudo[922]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 19:18:28 volumiogranja sudo[922]: pam_unix(sudo:session): session closed for user root May 12 19:18:28 volumiogranja volumio[771]: info: VolumeController:: Volume=90 Mute =false May 12 19:18:28 volumiogranja volumio[771]: info: CoreStateMachine::pushState May 12 19:18:28 volumiogranja volumio[771]: info: CoreStateMachine::getState May 12 19:18:28 volumiogranja volumio[771]: info: CorePlayQueue::getTrack 0 May 12 19:18:28 volumiogranja volumio[771]: info: CoreCommandRouter::volumioPushState May 12 19:18:28 volumiogranja volumio[771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 19:18:28 volumiogranja volumio[771]: info: interfaceApi::pushState May 12 19:18:28 volumiogranja volumio[771]: info: Pushing Favourites {"service":"mpd","uri":"","favourite":false} May 12 19:18:28 volumiogranja volumio[771]: info: AutoStart - mpd ready May 12 19:18:28 volumiogranja volumio[771]: info: Reloading queue from file May 12 19:18:29 volumiogranja volumio[771]: info: May 12 19:18:29 volumiogranja volumio[771]: info: CoreStateMachine::setRepeat null single undefined May 12 19:18:29 volumiogranja volumio[771]: info: CoreStateMachine::pushState May 12 19:18:29 volumiogranja volumio[771]: info: CoreStateMachine::getState May 12 19:18:29 volumiogranja volumio[771]: info: CorePlayQueue::getTrack 0 May 12 19:18:29 volumiogranja volumio[771]: info: CoreCommandRouter::volumioPushState May 12 19:18:29 volumiogranja volumio[771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 19:18:29 volumiogranja volumio[771]: info: interfaceApi::pushState May 12 19:18:29 volumiogranja volumio[771]: info: CoreStateMachine::setRandom true May 12 19:18:29 volumiogranja volumio[771]: info: CoreStateMachine::pushState May 12 19:18:29 volumiogranja volumio[771]: info: CoreStateMachine::getState May 12 19:18:29 volumiogranja volumio[771]: info: CorePlayQueue::getTrack 0 May 12 19:18:29 volumiogranja volumio[771]: info: CoreCommandRouter::volumioPushState May 12 19:18:29 volumiogranja volumio[771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 19:18:29 volumiogranja volumio[771]: info: interfaceApi::pushState May 12 19:18:29 volumiogranja volumio[771]: info: Pushing Favourites {"service":"webradio","uri":"http://192.168.1.80:8000/sendaviva.m3u","favourite":false} May 12 19:18:29 volumiogranja volumio[771]: info: Pushing Favourites {"service":"webradio","uri":"http://192.168.1.80:8000/sendaviva.m3u","favourite":false} May 12 19:18:29 volumiogranja volumio[771]: info: mDNS: A device disapperared from network May 12 19:18:29 volumiogranja volumio[771]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined May 12 19:18:29 volumiogranja volumio[771]: Discovery: adding fd334fbf-6eda-4523-953c-fa985f930e1d May 12 19:18:29 volumiogranja volumio[771]: info: mDNS: Found device Volumio-estacion May 12 19:18:29 volumiogranja sudo[932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay May 12 19:18:29 volumiogranja sudo[932]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 19:18:29 volumiogranja systemd[1]: Starting ShairportSync AirTunes receiver... May 12 19:18:29 volumiogranja systemd[1]: Started ShairportSync AirTunes receiver. May 12 19:18:29 volumiogranja sudo[932]: pam_unix(sudo:session): session closed for user root May 12 19:18:29 volumiogranja shairport-sync[938]: Successful Startup May 12 19:18:29 volumiogranja volumio[771]: info: [1715541509832] Shairport-Sync Started May 12 19:18:29 volumiogranja volumio[771]: Error adding Membership: Error: addMembership EINVAL May 12 19:18:29 volumiogranja volumio[771]: Discovery: this is already registered, fd334fbf-6eda-4523-953c-fa985f930e1d May 12 19:18:29 volumiogranja volumio[771]: info: mDNS: Found device Volumio-estacion May 12 19:18:30 volumiogranja volumio[771]: info: May 12 19:18:30 volumiogranja volumio[771]: ---------------------------- Client requests Volume 90 May 12 19:18:30 volumiogranja volumio[771]: info: VolumeController::SetAlsaVolume90 May 12 19:18:30 volumiogranja volumio[771]: null May 12 19:18:30 volumiogranja volumio[771]: info: VolumeController::Volume 90 May 12 19:18:30 volumiogranja volumio[771]: info: CoreStateMachine::pushState May 12 19:18:30 volumiogranja volumio[771]: info: CoreStateMachine::getState May 12 19:18:30 volumiogranja volumio[771]: info: CorePlayQueue::getTrack 0 May 12 19:18:30 volumiogranja volumio[771]: info: CoreCommandRouter::volumioPushState May 12 19:18:30 volumiogranja volumio[771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 19:18:30 volumiogranja volumio[771]: info: interfaceApi::pushState May 12 19:18:30 volumiogranja volumio[771]: info: Setting volume on startup at 90 May 12 19:18:30 volumiogranja volumio[771]: info: Pushing Favourites {"service":"webradio","uri":"http://192.168.1.80:8000/sendaviva.m3u","favourite":false} May 12 19:18:30 volumiogranja volumio[771]: info: CoreCommandRouter::volumioGetState May 12 19:18:30 volumiogranja volumio[771]: info: CoreStateMachine::getState May 12 19:18:30 volumiogranja volumio[771]: info: CorePlayQueue::getTrack 0 May 12 19:18:31 volumiogranja volumio[771]: Discovery: ecc TypeError: argument 8 must be an integer (port) May 12 19:18:31 volumiogranja volumio[771]: Discovery: StartAdv! false May 12 19:18:31 volumiogranja volumio[771]: Discovery: Started advertising... undefined - false May 12 19:18:32 volumiogranja kernel: Voltage normalised (0x00000000) May 12 19:18:33 volumiogranja volumio[771]: info: AutoStart - getting queue May 12 19:18:33 volumiogranja volumio[771]: info: CoreCommandRouter::volumioGetQueue May 12 19:18:33 volumiogranja volumio[771]: info: CoreStateMachine::getQueue May 12 19:18:33 volumiogranja volumio[771]: info: CorePlayQueue::getQueue May 12 19:18:33 volumiogranja volumio[771]: info: AutoStart - start playing -> queue is not empty May 12 19:18:33 volumiogranja volumio[771]: info: CoreCommandRouter::volumioPlay May 12 19:18:33 volumiogranja volumio[771]: UNSET VOLATILE May 12 19:18:33 volumiogranja volumio[771]: info: CoreStateMachine::play index undefined May 12 19:18:33 volumiogranja volumio[771]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 19:18:33 volumiogranja volumio[771]: info: CorePlayQueue::getTrack 0 May 12 19:18:33 volumiogranja volumio[771]: info: CoreStateMachine::startPlaybackTimer May 12 19:18:33 volumiogranja volumio[771]: info: CorePlayQueue::getTrack 0 May 12 19:18:33 volumiogranja volumio[771]: info: [1715541513931] ControllerWebradio::clearAddPlayTrack May 12 19:18:33 volumiogranja volumio[771]: info: ControllerMpd::sendMpdCommand stop May 12 19:18:33 volumiogranja volumio[771]: info: sending command... May 12 19:18:33 volumiogranja volumio[771]: info: parsing response... May 12 19:18:33 volumiogranja volumio[771]: info: ControllerMpd::sendMpdCommand clear May 12 19:18:33 volumiogranja volumio[771]: info: sending command... May 12 19:18:33 volumiogranja volumio[771]: info: May 12 19:18:33 volumiogranja volumio[771]: ---------------------------- MPD announces system playlist update May 12 19:18:33 volumiogranja volumio[771]: info: Ignoring MPD Status Update May 12 19:18:33 volumiogranja volumio[771]: info: parsing response... May 12 19:18:33 volumiogranja volumio[771]: info: ControllerMpd::sendMpdCommand load "http://192.168.1.80:8000/sendaviva.m3u" May 12 19:18:33 volumiogranja volumio[771]: info: sending command... May 12 19:18:33 volumiogranja volumio[771]: info: May 12 19:18:33 volumiogranja volumio[771]: info: ------------------------------ 16ms May 12 19:18:34 volumiogranja volumio[771]: info: May 12 19:18:34 volumiogranja volumio[771]: ---------------------------- MPD announces system playlist update May 12 19:18:34 volumiogranja volumio[771]: info: Ignoring MPD Status Update May 12 19:18:34 volumiogranja volumio[771]: info: parsing response... May 12 19:18:34 volumiogranja volumio[771]: info: CoreStateMachine::setConsumeUpdateService mpd May 12 19:18:34 volumiogranja volumio[771]: info: ControllerMpd::sendMpdCommand play May 12 19:18:34 volumiogranja volumio[771]: info: sending command... May 12 19:18:34 volumiogranja volumio[771]: info: ------------------------------ 33ms May 12 19:18:34 volumiogranja volumio[771]: info: parsing response... May 12 19:18:34 volumiogranja volumio[771]: info: May 12 19:18:34 volumiogranja volumio[771]: ---------------------------- MPD announces state update: player May 12 19:18:34 volumiogranja volumio[771]: info: ControllerMpd::getState May 12 19:18:34 volumiogranja volumio[771]: info: ControllerMpd::sendMpdCommand status May 12 19:18:34 volumiogranja volumio[771]: info: sending command... May 12 19:18:34 volumiogranja volumio[771]: info: parsing response... May 12 19:18:34 volumiogranja volumio[771]: info: ControllerMpd::sendMpdCommand clearerror May 12 19:18:34 volumiogranja volumio[771]: info: sending command... May 12 19:18:34 volumiogranja volumio[771]: info: ControllerMpd::parseState May 12 19:18:34 volumiogranja volumio[771]: info: ControllerMpd::sendMpdCommand playlistinfo May 12 19:18:34 volumiogranja volumio[771]: info: sending command... May 12 19:18:34 volumiogranja volumio[771]: info: parsing response... May 12 19:18:34 volumiogranja volumio[771]: info: parsing response... May 12 19:18:34 volumiogranja volumio[771]: info: ControllerMpd::parseTrackInfo May 12 19:18:34 volumiogranja volumio[771]: info: ControllerMpd::pushState May 12 19:18:34 volumiogranja volumio[771]: info: CoreCommandRouter::servicePushState May 12 19:18:34 volumiogranja volumio[771]: info: CoreStateMachine::syncState May 12 19:18:34 volumiogranja volumio[771]: info: CorePlayQueue::getTrack 0 May 12 19:18:34 volumiogranja volumio[771]: info: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"sendaviva","artist":null,"album":null,"uri":"http://192.168.1.80:8000/sendaviva","trackType":"80:8000/sendaviva"} May 12 19:18:34 volumiogranja volumio[771]: info: CURRENT POSITION 0 May 12 19:18:34 volumiogranja volumio[771]: info: CoreStateMachine::syncState stateService stop May 12 19:18:34 volumiogranja volumio[771]: info: CoreStateMachine::syncState currentStatus stop May 12 19:18:34 volumiogranja volumio[771]: info: CoreStateMachine::pushState May 12 19:18:34 volumiogranja volumio[771]: info: CoreStateMachine::getState May 12 19:18:34 volumiogranja volumio[771]: info: CoreCommandRouter::volumioPushState May 12 19:18:34 volumiogranja volumio[771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 19:18:34 volumiogranja volumio[771]: info: interfaceApi::pushState May 12 19:18:34 volumiogranja volumio[771]: info: No code May 12 19:18:34 volumiogranja volumio[771]: info: CoreStateMachine::pushState May 12 19:18:34 volumiogranja volumio[771]: info: CoreStateMachine::getState May 12 19:18:34 volumiogranja volumio[771]: info: CoreCommandRouter::volumioPushState May 12 19:18:34 volumiogranja volumio[771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 19:18:34 volumiogranja volumio[771]: info: interfaceApi::pushState May 12 19:18:34 volumiogranja volumio[771]: info: ------------------------------ 71ms May 12 19:18:34 volumiogranja volumio[771]: info: Pushing Favourites {"service":"mpd","favourite":false} May 12 19:18:34 volumiogranja volumio[771]: info: Pushing Favourites {"service":"mpd","favourite":false} May 12 19:18:35 volumiogranja volumio[771]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 19:18:35 volumiogranja volumio[771]: TypeError: Cannot read property 'charAt' of undefined May 12 19:18:35 volumiogranja volumio[771]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:193:27) May 12 19:18:35 volumiogranja volumio[771]: at ontimeout (timers.js:386:14) May 12 19:18:35 volumiogranja volumio[771]: at tryOnTimeout (timers.js:250:5) May 12 19:18:35 volumiogranja volumio[771]: at Timer.listOnTimeout (timers.js:214:5) May 12 19:18:35 volumiogranja volumio[771]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 19:18:35 volumiogranja sudo[956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-12 19:17 May 12 19:18:35 volumiogranja sudo[956]: 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="0047b8c9feaa5e4ceb66739aad5c179741acce54" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="9ec9402ca0a423856feda09b210aa4e517a345ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Mar 26 20:20:16 CEST 2018" VOLUMIO_VERSION="2.389" VOLUMIO_HARDWARE="pi"