-- Logs begin at Sat 2025-01-11 18:12:07 UTC, end at Mon 2025-01-20 22:22:40 UTC. -- Jan 20 22:21:16 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 20 22:21:16 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 20 22:21:16 volumio volumio[1017]: info: Discovery: Getting this device information Jan 20 22:21:16 volumio volumio[1017]: info: CoreCommandRouter::volumioGetState Jan 20 22:21:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jan 20 22:21:16 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jan 20 22:21:16 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 20 22:21:16 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 20 22:21:41 volumio volumio[1017]: info: CoreCommandRouter::volumioPlay Jan 20 22:21:41 volumio volumio[1017]: verbose: UNSET VOLATILE Jan 20 22:21:41 volumio volumio[1017]: info: CoreStateMachine::play index undefined Jan 20 22:21:41 volumio volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 22:21:41 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jan 20 22:21:41 volumio volumio[1017]: info: CoreStateMachine::startPlaybackTimer Jan 20 22:21:41 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jan 20 22:21:41 volumio volumio[1017]: info: [1737411701583] ControllerWebradio::clearAddPlayTrack Jan 20 22:21:41 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 22:21:41 volumio volumio[1017]: info: sendMpdCommand stop took 8 milliseconds Jan 20 22:21:41 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand clear Jan 20 22:21:41 volumio volumio[1017]: info: Jan 20 22:21:41 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Jan 20 22:21:41 volumio volumio[1017]: info: Ignoring MPD Status Update Jan 20 22:21:41 volumio volumio[1017]: info: sendMpdCommand clear took 4 milliseconds Jan 20 22:21:41 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99509174" Jan 20 22:21:41 volumio volumio[1017]: info: VolumeController::SetAlsaVolume90 Jan 20 22:21:41 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:21:41 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jan 20 22:21:41 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:21:41 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:21:41 volumio volumio[1017]: error: updateQueue error: null Jan 20 22:21:41 volumio volumio[1017]: info: ------------------------------ 41ms Jan 20 22:21:42 volumio volumio[1017]: info: Jan 20 22:21:42 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Jan 20 22:21:42 volumio volumio[1017]: info: Ignoring MPD Status Update Jan 20 22:21:42 volumio volumio[1017]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99509174" took 642 milliseconds Jan 20 22:21:42 volumio volumio[1017]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 20 22:21:42 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand play Jan 20 22:21:42 volumio volumio[1017]: info: ------------------------------ 5ms Jan 20 22:21:42 volumio volumio[1017]: info: sendMpdCommand play took 3 milliseconds Jan 20 22:21:43 volumio volumio[1017]: info: Jan 20 22:21:43 volumio volumio[1017]: ---------------------------- MPD announces state update: player Jan 20 22:21:43 volumio volumio[1017]: info: ControllerMpd::getState Jan 20 22:21:43 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jan 20 22:21:43 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Jan 20 22:21:43 volumio volumio[1017]: info: Jan 20 22:21:43 volumio volumio[1017]: ---------------------------- MPD announces state update: player Jan 20 22:21:43 volumio volumio[1017]: info: sendMpdCommand status took 16 milliseconds Jan 20 22:21:43 volumio volumio[1017]: info: ControllerMpd::getState Jan 20 22:21:43 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jan 20 22:21:43 volumio volumio[1017]: verbose: ControllerMpd::parseState Jan 20 22:21:43 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 22:21:43 volumio volumio[1017]: info: Jan 20 22:21:43 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Jan 20 22:21:43 volumio volumio[1017]: info: Ignoring MPD Status Update Jan 20 22:21:43 volumio volumio[1017]: info: sendMpdCommand status took 9 milliseconds Jan 20 22:21:43 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 20 22:21:43 volumio volumio[1017]: verbose: ControllerMpd::parseState Jan 20 22:21:43 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 22:21:43 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jan 20 22:21:43 volumio volumio[1017]: info: ControllerMpd::pushState Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jan 20 22:21:43 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jan 20 22:21:43 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"65 Kbps","isStreaming":false,"title":"60smovil","artist":"Best 60s","album":null,"uri":"https://c4.auracast.net:8020/60smovil","trackType":""} Jan 20 22:21:43 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jan 20 22:21:43 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Jan 20 22:21:43 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus stop Jan 20 22:21:43 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:21:43 volumio volumio[1017]: info: ------------------------------ 53ms Jan 20 22:21:43 volumio volumio[1017]: info: Jan 20 22:21:43 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Jan 20 22:21:43 volumio volumio[1017]: info: Ignoring MPD Status Update Jan 20 22:21:43 volumio volumio[1017]: info: Jan 20 22:21:43 volumio volumio[1017]: ---------------------------- MPD announces state update: player Jan 20 22:21:43 volumio volumio[1017]: info: ------------------------------ 31ms Jan 20 22:21:43 volumio volumio[1017]: info: ControllerMpd::getState Jan 20 22:21:43 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jan 20 22:21:43 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 29 milliseconds Jan 20 22:21:43 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jan 20 22:21:43 volumio volumio[1017]: info: ControllerMpd::pushState Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jan 20 22:21:43 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jan 20 22:21:43 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"60 Kbps","isStreaming":false,"title":"Alain Barriere - Ma Vie","artist":"Best 60s","album":null,"uri":"https://c4.auracast.net:8020/60smovil","trackType":""} Jan 20 22:21:43 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jan 20 22:21:43 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Jan 20 22:21:43 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Jan 20 22:21:43 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 22:21:43 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:21:43 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:21:43 volumio volumio[1017]: info: ------------------------------ 66ms Jan 20 22:21:43 volumio volumio[1017]: info: ------------------------------ 52ms Jan 20 22:21:43 volumio volumio[1017]: info: sendMpdCommand status took 50 milliseconds Jan 20 22:21:43 volumio volumio[1017]: verbose: ControllerMpd::parseState Jan 20 22:21:43 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 22:21:43 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 20 22:21:43 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jan 20 22:21:43 volumio volumio[1017]: info: ControllerMpd::pushState Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jan 20 22:21:43 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jan 20 22:21:43 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"62 Kbps","isStreaming":false,"title":"Alain Barriere - Ma Vie","artist":"Best 60s","album":null,"uri":"https://c4.auracast.net:8020/60smovil","trackType":""} Jan 20 22:21:43 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jan 20 22:21:43 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Jan 20 22:21:43 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Jan 20 22:21:43 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 22:21:43 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:21:43 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:21:43 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:21:43 volumio volumio[1017]: info: ------------------------------ 78ms Jan 20 22:21:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 20 22:21:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 20 22:21:46 volumio volumio[1017]: info: Discovery: Getting this device information Jan 20 22:21:46 volumio volumio[1017]: info: CoreCommandRouter::volumioGetState Jan 20 22:21:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jan 20 22:21:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 20 22:21:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 20 22:21:56 volumio volumio[1017]: info: VolumeController::SetAlsaVolume- Jan 20 22:21:56 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:21:56 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:21:56 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:21:58 volumio volumio[1017]: info: VolumeController::SetAlsaVolume+ Jan 20 22:21:58 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:21:58 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:21:58 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:21:58 volumio volumio[1017]: info: VolumeController::SetAlsaVolume+ Jan 20 22:21:58 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:21:58 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:21:58 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:21:58 volumio volumio[1017]: info: VolumeController::SetAlsaVolume+ Jan 20 22:21:58 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:21:58 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:21:58 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:22:06 volumio volumio[1017]: info: VolumeController::SetAlsaVolume- Jan 20 22:22:06 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:22:06 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:22:06 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:22:06 volumio volumio[1017]: info: VolumeController::SetAlsaVolume- Jan 20 22:22:06 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:22:06 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:22:06 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:22:06 volumio volumio[1017]: info: VolumeController::SetAlsaVolume- Jan 20 22:22:07 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:22:07 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:22:07 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:22:16 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 20 22:22:16 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 20 22:22:16 volumio volumio[1017]: info: Discovery: Getting this device information Jan 20 22:22:16 volumio volumio[1017]: info: CoreCommandRouter::volumioGetState Jan 20 22:22:16 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jan 20 22:22:16 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 20 22:22:16 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 20 22:22:16 volumio volumio[1017]: info: VolumeController::SetAlsaVolume+ Jan 20 22:22:16 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:22:16 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:22:16 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:22:17 volumio volumio[1017]: info: VolumeController::SetAlsaVolume+ Jan 20 22:22:17 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:22:17 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:22:17 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:22:18 volumio volumio[1017]: info: VolumeController::SetAlsaVolume+ Jan 20 22:22:18 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:22:18 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:22:18 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:22:20 volumio volumio[1017]: info: VolumeController::SetAlsaVolume- Jan 20 22:22:20 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:22:20 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:22:20 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:22:21 volumio volumio[1017]: info: VolumeController::SetAlsaVolume- Jan 20 22:22:21 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:22:21 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:22:21 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:22:21 volumio volumio[1017]: info: VolumeController::SetAlsaVolume- Jan 20 22:22:21 volumio volumio[1017]: info: CoreStateMachine::pushState Jan 20 22:22:21 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jan 20 22:22:21 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:22:40 volumio volumio[1017]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:22:40 volumio volumio[1017]: { Error: connect ETIMEDOUT 146.75.54.79:443 Jan 20 22:22:40 volumio volumio[1017]: at Object._errnoException (util.js:1022:11) Jan 20 22:22:40 volumio volumio[1017]: at _exceptionWithHostPort (util.js:1044:20) Jan 20 22:22:40 volumio volumio[1017]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jan 20 22:22:40 volumio volumio[1017]: code: 'ETIMEDOUT', Jan 20 22:22:40 volumio volumio[1017]: errno: 'ETIMEDOUT', Jan 20 22:22:40 volumio volumio[1017]: syscall: 'connect', Jan 20 22:22:40 volumio volumio[1017]: address: '146.75.54.79', Jan 20 22:22:40 volumio volumio[1017]: port: 443 } Jan 20 22:22:40 volumio volumio[1017]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:22:40 volumio sudo[3160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 22:21 Jan 20 22:22:40 volumio sudo[3160]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"