-- Logs begin at Sat 2022-10-08 11:18:23 UTC, end at Sun 2024-05-12 19:28:11 UTC. -- May 12 19:28:02 volumiogranja systemd[1]: Time has been changed May 12 19:28:02 volumiogranja volumio[775]: info: Plugin mpdemulation is not enabled May 12 19:28:02 volumiogranja volumio[775]: info: Loading plugin "rest_api"... May 12 19:28:02 volumiogranja volumio[775]: info: Loading plugin "websocket"... May 12 19:28:02 volumiogranja volumio[775]: info: Loading plugin "autostart"... May 12 19:28:02 volumiogranja volumio[775]: info: AutoStart - connecting mpd on host: localhost; port: 6600 May 12 19:28:02 volumiogranja volumio[775]: info: ___________ START PLUGINS ___________ May 12 19:28:02 volumiogranja volumio[775]: info: PLUGIN START: appearance May 12 19:28:02 volumiogranja volumio[775]: info: PLUGIN START: wizard May 12 19:28:02 volumiogranja volumio[775]: info: PLUGIN START: upnp_browser May 12 19:28:02 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 19:28:02 volumiogranja volumio[775]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 12 19:28:02 volumiogranja volumio[775]: info: [1715542082912] CoreMusicLibrary::Adding element Media Servers May 12 19:28:02 volumiogranja volumio[775]: info: PLUGIN START: last_100 May 12 19:28:02 volumiogranja volumio[775]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 12 19:28:02 volumiogranja volumio[775]: info: [1715542082961] CoreMusicLibrary::Adding element Last_100 May 12 19:28:02 volumiogranja volumio[775]: info: PLUGIN START: webradio May 12 19:28:02 volumiogranja volumio[775]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 12 19:28:02 volumiogranja volumio[775]: info: [1715542082970] CoreMusicLibrary::Adding element Webradio May 12 19:28:02 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 12 19:28:02 volumiogranja volumio[775]: info: PLUGIN START: autostart May 12 19:28:02 volumiogranja volumio[775]: info: Loading i18n strings for locale es May 12 19:28:03 volumiogranja volumio[775]: Updating browse sources language May 12 19:28:03 volumiogranja volumio[775]: Cannot find translation for sourceMedia Servers May 12 19:28:03 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 19:28:03 volumiogranja volumio[775]: info: CoreCommandRouter::initPlayerControls May 12 19:28:03 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 19:28:03 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards May 12 19:28:03 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 19:28:03 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 19:28:03 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 19:28:03 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 19:28:03 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 19:28:03 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 19:28:03 volumiogranja volumio[775]: info: BOOT COMPLETED May 12 19:28:03 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 19:28:03 volumiogranja volumio[775]: info: CoreCommandRouter::Close All Modals sent May 12 19:28:03 volumiogranja volumio[775]: Express server listening on port 3000 May 12 19:28:03 volumiogranja volumio[775]: Volumio Calling Home May 12 19:28:03 volumiogranja volumio[775]: info: CoreStateMachine::resetVolumioState May 12 19:28:03 volumiogranja volumio[775]: info: CoreStateMachine::getcurrentVolume May 12 19:28:03 volumiogranja volumio[775]: info: CoreCommandRouter::volumioRetrievevolume May 12 19:28:03 volumiogranja kernel: Under-voltage detected! (0x00050005) May 12 19:28:03 volumiogranja volumio[775]: info: CoreStateMachine::updateTrackBlock May 12 19:28:03 volumiogranja volumio[775]: info: CorePlayQueue::getTrackBlock May 12 19:28:03 volumiogranja volumio[775]: info: Setting Device type: Raspberry PI May 12 19:28:04 volumiogranja volumio[775]: info: MPD running with PID551 ,establishing connection May 12 19:28:04 volumiogranja sudo[933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 May 12 19:28:04 volumiogranja sudo[933]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 19:28:04 volumiogranja volumio-remote-updater[518]: [2024-05-12 19:28:04] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1665227922 101 May 12 19:28:04 volumiogranja sudo[933]: pam_unix(sudo:session): session closed for user root May 12 19:28:04 volumiogranja volumio[775]: info: VolumeController:: Volume=90 Mute =false May 12 19:28:04 volumiogranja volumio[775]: info: CoreStateMachine::pushState May 12 19:28:04 volumiogranja volumio[775]: info: CoreStateMachine::getState May 12 19:28:04 volumiogranja volumio[775]: info: CorePlayQueue::getTrack 0 May 12 19:28:04 volumiogranja volumio[775]: info: CoreCommandRouter::volumioPushState May 12 19:28:04 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 19:28:04 volumiogranja volumio[775]: info: interfaceApi::pushState May 12 19:28:04 volumiogranja volumio[775]: info: AutoStart - mpd ready May 12 19:28:04 volumiogranja volumio[775]: info: Pushing Favourites {"service":"mpd","uri":"","favourite":false} May 12 19:28:04 volumiogranja volumio[775]: info: Reloading queue from file May 12 19:28:04 volumiogranja volumio[775]: info: May 12 19:28:04 volumiogranja volumio[775]: info: CoreStateMachine::setRepeat null single undefined May 12 19:28:04 volumiogranja volumio[775]: info: CoreStateMachine::pushState May 12 19:28:04 volumiogranja volumio[775]: info: CoreStateMachine::getState May 12 19:28:04 volumiogranja volumio[775]: info: CorePlayQueue::getTrack 0 May 12 19:28:04 volumiogranja volumio[775]: info: CoreCommandRouter::volumioPushState May 12 19:28:04 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 19:28:04 volumiogranja volumio[775]: info: interfaceApi::pushState May 12 19:28:04 volumiogranja volumio[775]: info: CoreStateMachine::setRandom true May 12 19:28:04 volumiogranja volumio[775]: info: CoreStateMachine::pushState May 12 19:28:04 volumiogranja volumio[775]: info: CoreStateMachine::getState May 12 19:28:04 volumiogranja volumio[775]: info: CorePlayQueue::getTrack 0 May 12 19:28:04 volumiogranja volumio[775]: info: CoreCommandRouter::volumioPushState May 12 19:28:04 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 19:28:04 volumiogranja volumio[775]: info: interfaceApi::pushState May 12 19:28:04 volumiogranja volumio[775]: info: Pushing Favourites {"service":"webradio","uri":"http://192.168.1.80:8000/sendaviva.m3u","favourite":false} May 12 19:28:04 volumiogranja volumio[775]: info: Pushing Favourites {"service":"webradio","uri":"http://192.168.1.80:8000/sendaviva.m3u","favourite":false} May 12 19:28:04 volumiogranja sudo[943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay May 12 19:28:04 volumiogranja sudo[943]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 19:28:04 volumiogranja systemd[1]: Starting ShairportSync AirTunes receiver... May 12 19:28:04 volumiogranja systemd[1]: Started ShairportSync AirTunes receiver. May 12 19:28:04 volumiogranja sudo[943]: pam_unix(sudo:session): session closed for user root May 12 19:28:05 volumiogranja shairport-sync[948]: Successful Startup May 12 19:28:05 volumiogranja volumio[775]: Discovery: adding fd334fbf-6eda-4523-953c-fa985f930e1d May 12 19:28:05 volumiogranja volumio[775]: info: mDNS: Found device Volumio-estacion May 12 19:28:05 volumiogranja volumio[775]: info: [1715542085235] Shairport-Sync Started May 12 19:28:05 volumiogranja volumio[775]: Error adding Membership: Error: addMembership EINVAL May 12 19:28:05 volumiogranja volumio[775]: info: May 12 19:28:05 volumiogranja volumio[775]: ---------------------------- Client requests Volume 90 May 12 19:28:05 volumiogranja volumio[775]: info: VolumeController::SetAlsaVolume90 May 12 19:28:05 volumiogranja volumio[775]: null May 12 19:28:05 volumiogranja volumio[775]: info: VolumeController::Volume 90 May 12 19:28:05 volumiogranja volumio[775]: info: CoreStateMachine::pushState May 12 19:28:05 volumiogranja volumio[775]: info: CoreStateMachine::getState May 12 19:28:05 volumiogranja volumio[775]: info: CorePlayQueue::getTrack 0 May 12 19:28:05 volumiogranja volumio[775]: info: CoreCommandRouter::volumioPushState May 12 19:28:05 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 19:28:05 volumiogranja volumio[775]: info: interfaceApi::pushState May 12 19:28:05 volumiogranja volumio[775]: info: Pushing Favourites {"service":"webradio","uri":"http://192.168.1.80:8000/sendaviva.m3u","favourite":false} May 12 19:28:05 volumiogranja volumio[775]: info: Setting volume on startup at 90 May 12 19:28:06 volumiogranja volumio[775]: info: CoreCommandRouter::volumioGetState May 12 19:28:06 volumiogranja volumio[775]: info: CoreStateMachine::getState May 12 19:28:06 volumiogranja volumio[775]: info: CorePlayQueue::getTrack 0 May 12 19:28:07 volumiogranja volumio[775]: Discovery: ecc TypeError: argument 8 must be an integer (port) May 12 19:28:07 volumiogranja volumio[775]: Discovery: StartAdv! false May 12 19:28:07 volumiogranja volumio[775]: Discovery: Started advertising... undefined - false May 12 19:28:07 volumiogranja kernel: Voltage normalised (0x00000000) May 12 19:28:09 volumiogranja volumio[775]: info: AutoStart - getting queue May 12 19:28:09 volumiogranja volumio[775]: info: CoreCommandRouter::volumioGetQueue May 12 19:28:09 volumiogranja volumio[775]: info: CoreStateMachine::getQueue May 12 19:28:09 volumiogranja volumio[775]: info: CorePlayQueue::getQueue May 12 19:28:09 volumiogranja volumio[775]: info: AutoStart - start playing -> queue is not empty May 12 19:28:09 volumiogranja volumio[775]: info: CoreCommandRouter::volumioPlay May 12 19:28:09 volumiogranja volumio[775]: UNSET VOLATILE May 12 19:28:09 volumiogranja volumio[775]: info: CoreStateMachine::play index undefined May 12 19:28:09 volumiogranja volumio[775]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 19:28:09 volumiogranja volumio[775]: info: CorePlayQueue::getTrack 0 May 12 19:28:09 volumiogranja volumio[775]: info: CoreStateMachine::startPlaybackTimer May 12 19:28:09 volumiogranja volumio[775]: info: CorePlayQueue::getTrack 0 May 12 19:28:09 volumiogranja volumio[775]: info: [1715542089464] ControllerWebradio::clearAddPlayTrack May 12 19:28:09 volumiogranja volumio[775]: info: ControllerMpd::sendMpdCommand stop May 12 19:28:09 volumiogranja volumio[775]: info: sending command... May 12 19:28:09 volumiogranja volumio[775]: info: parsing response... May 12 19:28:09 volumiogranja volumio[775]: info: ControllerMpd::sendMpdCommand clear May 12 19:28:09 volumiogranja volumio[775]: info: sending command... May 12 19:28:09 volumiogranja volumio[775]: info: May 12 19:28:09 volumiogranja volumio[775]: ---------------------------- MPD announces system playlist update May 12 19:28:09 volumiogranja volumio[775]: info: Ignoring MPD Status Update May 12 19:28:09 volumiogranja volumio[775]: info: parsing response... May 12 19:28:09 volumiogranja volumio[775]: info: ControllerMpd::sendMpdCommand load "http://192.168.1.80:8000/sendaviva.m3u" May 12 19:28:09 volumiogranja volumio[775]: info: sending command... May 12 19:28:09 volumiogranja volumio[775]: info: May 12 19:28:09 volumiogranja volumio[775]: info: ------------------------------ 12ms May 12 19:28:09 volumiogranja volumio[775]: info: May 12 19:28:09 volumiogranja volumio[775]: ---------------------------- MPD announces system playlist update May 12 19:28:09 volumiogranja volumio[775]: info: Ignoring MPD Status Update May 12 19:28:09 volumiogranja volumio[775]: info: parsing response... May 12 19:28:09 volumiogranja volumio[775]: info: CoreStateMachine::setConsumeUpdateService mpd May 12 19:28:09 volumiogranja volumio[775]: info: ControllerMpd::sendMpdCommand play May 12 19:28:09 volumiogranja volumio[775]: info: sending command... May 12 19:28:09 volumiogranja volumio[775]: info: ------------------------------ 25ms May 12 19:28:09 volumiogranja volumio[775]: info: parsing response... May 12 19:28:09 volumiogranja volumio[775]: info: May 12 19:28:09 volumiogranja volumio[775]: ---------------------------- MPD announces state update: player May 12 19:28:09 volumiogranja volumio[775]: info: ControllerMpd::getState May 12 19:28:09 volumiogranja volumio[775]: info: ControllerMpd::sendMpdCommand status May 12 19:28:09 volumiogranja volumio[775]: info: sending command... May 12 19:28:09 volumiogranja volumio[775]: info: parsing response... May 12 19:28:09 volumiogranja volumio[775]: info: ControllerMpd::sendMpdCommand clearerror May 12 19:28:09 volumiogranja volumio[775]: info: sending command... May 12 19:28:09 volumiogranja volumio[775]: info: ControllerMpd::parseState May 12 19:28:09 volumiogranja volumio[775]: info: ControllerMpd::sendMpdCommand playlistinfo May 12 19:28:09 volumiogranja volumio[775]: info: sending command... May 12 19:28:09 volumiogranja volumio[775]: info: parsing response... May 12 19:28:09 volumiogranja volumio[775]: info: parsing response... May 12 19:28:09 volumiogranja volumio[775]: info: ControllerMpd::parseTrackInfo May 12 19:28:09 volumiogranja volumio[775]: info: ControllerMpd::pushState May 12 19:28:09 volumiogranja volumio[775]: info: CoreCommandRouter::servicePushState May 12 19:28:09 volumiogranja volumio[775]: info: CoreStateMachine::syncState May 12 19:28:09 volumiogranja volumio[775]: info: CorePlayQueue::getTrack 0 May 12 19:28:09 volumiogranja volumio[775]: 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:28:09 volumiogranja volumio[775]: info: CURRENT POSITION 0 May 12 19:28:09 volumiogranja volumio[775]: info: CoreStateMachine::syncState stateService stop May 12 19:28:09 volumiogranja volumio[775]: info: CoreStateMachine::syncState currentStatus stop May 12 19:28:09 volumiogranja volumio[775]: info: CoreStateMachine::pushState May 12 19:28:09 volumiogranja volumio[775]: info: CoreStateMachine::getState May 12 19:28:09 volumiogranja volumio[775]: info: CoreCommandRouter::volumioPushState May 12 19:28:09 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 19:28:09 volumiogranja volumio[775]: info: interfaceApi::pushState May 12 19:28:09 volumiogranja volumio[775]: info: No code May 12 19:28:09 volumiogranja volumio[775]: info: CoreStateMachine::pushState May 12 19:28:09 volumiogranja volumio[775]: info: CoreStateMachine::getState May 12 19:28:09 volumiogranja volumio[775]: info: CoreCommandRouter::volumioPushState May 12 19:28:09 volumiogranja volumio[775]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 19:28:09 volumiogranja volumio[775]: info: interfaceApi::pushState May 12 19:28:09 volumiogranja volumio[775]: info: ------------------------------ 66ms May 12 19:28:09 volumiogranja volumio[775]: info: Pushing Favourites {"service":"mpd","favourite":false} May 12 19:28:09 volumiogranja volumio[775]: info: Pushing Favourites {"service":"mpd","favourite":false} May 12 19:28:10 volumiogranja volumio[775]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 19:28:10 volumiogranja volumio[775]: TypeError: Cannot read property 'charAt' of undefined May 12 19:28:10 volumiogranja volumio[775]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:193:27) May 12 19:28:10 volumiogranja volumio[775]: at ontimeout (timers.js:386:14) May 12 19:28:10 volumiogranja volumio[775]: at tryOnTimeout (timers.js:250:5) May 12 19:28:10 volumiogranja volumio[775]: at Timer.listOnTimeout (timers.js:214:5) May 12 19:28:10 volumiogranja volumio[775]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 19:28:11 volumiogranja sudo[966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-12 19:27 May 12 19:28:11 volumiogranja sudo[966]: 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"