-- 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"