-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Sat 2024-08-17 18:31:38 BST. -- Aug 17 18:31:36 volumio ntpd[793]: receive: Unexpected origin timestamp 0xea661451.5aed6a0f does not match aorg 0000000000.00000000 from server@195.171.43.12 xmt 0xea6b5cf8.1675bfbf Aug 17 18:31:36 volumio systemd[1]: Starting Daily apt download activities... Aug 17 18:31:36 volumio volumio[986]: info: MyVolumio status changed Aug 17 18:31:36 volumio volumio[986]: info: Streaming services startup Aug 17 18:31:36 volumio volumio[986]: info: Starting Streaming Daemon Aug 17 18:31:36 volumio volumio[986]: info: Removing browser output: myVolumio user plan is not superstar Aug 17 18:31:36 volumio volumio[986]: info: Removing audio output: Aug 17 18:31:36 volumio volumio[986]: info: Stoppping Tunnel 1 Aug 17 18:31:36 volumio sudo[1361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 17 18:31:36 volumio sudo[1361]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 18:31:36 volumio volumio[986]: error: MyVolumio Plugin failed to authenticate in a timely fashion Aug 17 18:31:36 volumio volumio[986]: info: Completed starting MyVolumio Plugin Aug 17 18:31:36 volumio volumio[986]: info: BOOT COMPLETED Aug 17 18:31:36 volumio volumio[986]: [Metrics] CommandRouter: 55s 766.64ms Aug 17 18:31:36 volumio volumio[986]: info: CoreCommandRouter::volumiosetStartupVolume Aug 17 18:31:36 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 18:31:36 volumio sudo[1361]: pam_unix(sudo:session): session closed for user root Aug 17 18:31:36 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 18:31:36 volumio sudo[1367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Aug 17 18:31:36 volumio sudo[1367]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::Close All Modals sent Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::Close All Modals sent Aug 17 18:31:37 volumio volumio[986]: info: sendMpdCommand playlistinfo took 346280021 milliseconds Aug 17 18:31:37 volumio volumio[986]: info: sendMpdCommand playlistinfo took 346280017 milliseconds Aug 17 18:31:37 volumio volumio[986]: info: sendMpdCommand playlistinfo took 346280017 milliseconds Aug 17 18:31:37 volumio volumio[986]: verbose: ControllerMpd::parseTrackInfo Aug 17 18:31:37 volumio volumio[986]: verbose: ControllerMpd::parseTrackInfo Aug 17 18:31:37 volumio volumio[986]: verbose: ControllerMpd::parseTrackInfo Aug 17 18:31:37 volumio volumio[986]: info: ControllerMpd::pushState Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::servicePushState Aug 17 18:31:37 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Aug 17 18:31:37 volumio volumio[986]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"O'o - Indigo - Indigo [InFiné 2023]","artist":".","album":null,"uri":"https://ice04.fluidstream.net/openlab.mp3","trackType":"mp3"} Aug 17 18:31:37 volumio volumio[986]: verbose: CURRENT POSITION 0 Aug 17 18:31:37 volumio volumio[986]: info: CoreStateMachine::syncState stateService play Aug 17 18:31:37 volumio volumio[986]: info: CoreStateMachine::syncState currentStatus play Aug 17 18:31:37 volumio volumio[986]: info: Received an update from plugin. extracting info from payload Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 17 18:31:37 volumio volumio[986]: info: CoreStateMachine::pushState Aug 17 18:31:37 volumio sudo[1367]: pam_unix(sudo:session): session closed for user root Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::volumioPushState Aug 17 18:31:37 volumio volumio[986]: info: CoreStateMachine::pushState Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::volumioPushState Aug 17 18:31:37 volumio volumio[986]: info: ControllerMpd::pushState Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::servicePushState Aug 17 18:31:37 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Aug 17 18:31:37 volumio volumio[986]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"O'o - Indigo - Indigo [InFiné 2023]","artist":".","album":null,"uri":"https://ice04.fluidstream.net/openlab.mp3","trackType":"mp3"} Aug 17 18:31:37 volumio volumio[986]: verbose: CURRENT POSITION 0 Aug 17 18:31:37 volumio volumio[986]: info: CoreStateMachine::syncState stateService play Aug 17 18:31:37 volumio volumio[986]: info: CoreStateMachine::syncState currentStatus play Aug 17 18:31:37 volumio volumio[986]: info: Received an update from plugin. extracting info from payload Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 17 18:31:37 volumio volumio[986]: info: CoreStateMachine::pushState Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::volumioPushState Aug 17 18:31:37 volumio volumio[986]: info: CoreStateMachine::pushState Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::volumioPushState Aug 17 18:31:37 volumio volumio[986]: info: ControllerMpd::pushState Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::servicePushState Aug 17 18:31:37 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Aug 17 18:31:37 volumio volumio[986]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"O'o - Indigo - Indigo [InFiné 2023]","artist":".","album":null,"uri":"https://ice04.fluidstream.net/openlab.mp3","trackType":"mp3"} Aug 17 18:31:37 volumio volumio[986]: verbose: CURRENT POSITION 0 Aug 17 18:31:37 volumio volumio[986]: info: CoreStateMachine::syncState stateService play Aug 17 18:31:37 volumio volumio[986]: info: CoreStateMachine::syncState currentStatus play Aug 17 18:31:37 volumio volumio[986]: info: Received an update from plugin. extracting info from payload Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 17 18:31:37 volumio volumio[986]: info: CoreStateMachine::pushState Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::volumioPushState Aug 17 18:31:37 volumio volumio[986]: info: CoreStateMachine::pushState Aug 17 18:31:37 volumio volumio[986]: info: CoreCommandRouter::volumioPushState Aug 17 18:31:37 volumio volumio[986]: info: ------------------------------ 346280278ms Aug 17 18:31:37 volumio volumio[986]: info: ------------------------------ 346280247ms Aug 17 18:31:37 volumio volumio[986]: info: ------------------------------ 346280235ms Aug 17 18:31:37 volumio volumio[986]: error: Failed to ping endpoint eu4.myvolumio.org : unknown error Aug 17 18:31:37 volumio volumio[986]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 17 18:31:37 volumio volumio[986]: Error: Unable to resolve or reject the same promise twice Aug 17 18:31:37 volumio volumio[986]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Aug 17 18:31:37 volumio volumio[986]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32367) Aug 17 18:31:37 volumio volumio[986]: at Socket.emit (events.js:315:20) Aug 17 18:31:37 volumio volumio[986]: at addChunk (internal/streams/readable.js:309:12) Aug 17 18:31:37 volumio volumio[986]: at readableAddChunk (internal/streams/readable.js:284:9) Aug 17 18:31:37 volumio volumio[986]: at Socket.Readable.push (internal/streams/readable.js:223:10) Aug 17 18:31:37 volumio volumio[986]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Aug 17 18:31:37 volumio volumio[986]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 17 18:31:38 volumio systemd[1]: apt-daily.service: Succeeded. Aug 17 18:31:38 volumio systemd[1]: Started Daily apt download activities. Aug 17 18:31:38 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Aug 17 18:31:38 volumio sudo[1426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-17 18:30 Aug 17 18:31:38 volumio sudo[1426]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"