-- Logs begin at Thu 2025-05-15 21:51:44 +07, end at Fri 2025-05-16 18:11:46 +07. -- May 16 18:10:02 volumio volumio[1057]: info: CoreCommandRouter::volumioPause May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::pause May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::stPlaybackTimer May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::servicePause May 16 18:10:02 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:02 volumio volumio[1057]: info: CoreCommandRouter::servicePause May 16 18:10:02 volumio volumio[1057]: info: ControllerMpd::pause May 16 18:10:02 volumio volumio[1057]: verbose: ControllerMpd::sendMpdCommand pause May 16 18:10:02 volumio volumio[1057]: info: sendMpdCommand pause took 1 milliseconds May 16 18:10:02 volumio volumio[1057]: info: May 16 18:10:02 volumio volumio[1057]: ---------------------------- MPD announces state update: player May 16 18:10:02 volumio volumio[1057]: info: ControllerMpd::getState May 16 18:10:02 volumio volumio[1057]: verbose: ControllerMpd::sendMpdCommand status May 16 18:10:02 volumio volumio[1057]: info: May 16 18:10:02 volumio volumio[1057]: ---------------------------- MPD announces state update: player May 16 18:10:02 volumio volumio[1057]: info: ControllerMpd::getState May 16 18:10:02 volumio volumio[1057]: verbose: ControllerMpd::sendMpdCommand status May 16 18:10:02 volumio volumio[1057]: info: May 16 18:10:02 volumio volumio[1057]: ---------------------------- MPD announces state update: player May 16 18:10:02 volumio volumio[1057]: info: ControllerMpd::getState May 16 18:10:02 volumio volumio[1057]: verbose: ControllerMpd::sendMpdCommand status May 16 18:10:02 volumio volumio[1057]: info: sendMpdCommand status took 3 milliseconds May 16 18:10:02 volumio volumio[1057]: info: sendMpdCommand status took 2 milliseconds May 16 18:10:02 volumio volumio[1057]: info: sendMpdCommand status took 2 milliseconds May 16 18:10:02 volumio volumio[1057]: verbose: ControllerMpd::parseState May 16 18:10:02 volumio volumio[1057]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 16 18:10:02 volumio volumio[1057]: verbose: ControllerMpd::parseState May 16 18:10:02 volumio volumio[1057]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 16 18:10:02 volumio volumio[1057]: verbose: ControllerMpd::parseState May 16 18:10:02 volumio volumio[1057]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 16 18:10:02 volumio volumio[1057]: info: sendMpdCommand playlistinfo took 1 milliseconds May 16 18:10:02 volumio volumio[1057]: info: sendMpdCommand playlistinfo took 1 milliseconds May 16 18:10:02 volumio volumio[1057]: info: sendMpdCommand playlistinfo took 1 milliseconds May 16 18:10:02 volumio volumio[1057]: verbose: ControllerMpd::parseTrackInfo May 16 18:10:02 volumio volumio[1057]: verbose: ControllerMpd::parseTrackInfo May 16 18:10:02 volumio volumio[1057]: verbose: ControllerMpd::parseTrackInfo May 16 18:10:02 volumio volumio[1057]: info: ControllerMpd::pushState May 16 18:10:02 volumio volumio[1057]: info: CoreCommandRouter::servicePushState May 16 18:10:02 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:02 volumio volumio[1057]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":30155,"duration":261,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Swear","artist":"All-4-One","album":null,"uri":"NAS/ds215j/Thuan Collection QT/COLLECTION LOSS/I_Swear.ape","trackType":"ape"} May 16 18:10:02 volumio volumio[1057]: verbose: CURRENT POSITION 3 May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::syncState stateService pause May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::syncState currentStatus pause May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::pushState May 16 18:10:02 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:02 volumio volumio[1057]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 16 18:10:02 volumio volumio[1057]: info: CoreCommandRouter::volumioPushState May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::stPlaybackTimer May 16 18:10:02 volumio volumio[1057]: info: ControllerMpd::pushState May 16 18:10:02 volumio volumio[1057]: info: CoreCommandRouter::servicePushState May 16 18:10:02 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:02 volumio volumio[1057]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":30155,"duration":261,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Swear","artist":"All-4-One","album":null,"uri":"NAS/ds215j/Thuan Collection QT/COLLECTION LOSS/I_Swear.ape","trackType":"ape"} May 16 18:10:02 volumio volumio[1057]: verbose: CURRENT POSITION 3 May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::syncState stateService pause May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::syncState currentStatus pause May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::pushState May 16 18:10:02 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:02 volumio volumio[1057]: info: CoreCommandRouter::volumioPushState May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::stPlaybackTimer May 16 18:10:02 volumio volumio[1057]: info: ControllerMpd::pushState May 16 18:10:02 volumio volumio[1057]: info: CoreCommandRouter::servicePushState May 16 18:10:02 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:02 volumio volumio[1057]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":30155,"duration":261,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Swear","artist":"All-4-One","album":null,"uri":"NAS/ds215j/Thuan Collection QT/COLLECTION LOSS/I_Swear.ape","trackType":"ape"} May 16 18:10:02 volumio volumio[1057]: verbose: CURRENT POSITION 3 May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::syncState stateService pause May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::syncState currentStatus pause May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::pushState May 16 18:10:02 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:02 volumio volumio[1057]: info: CoreCommandRouter::volumioPushState May 16 18:10:02 volumio volumio[1057]: info: CoreStateMachine::stPlaybackTimer May 16 18:10:02 volumio volumio[1057]: info: ------------------------------ 18ms May 16 18:10:02 volumio volumio[1057]: info: ------------------------------ 17ms May 16 18:10:02 volumio volumio[1057]: info: ------------------------------ 16ms May 16 18:10:02 volumio volumio[1057]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 16 18:10:02 volumio volumio[1057]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 16 18:10:02 volumio volumio[1057]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 16 18:10:03 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:10:03 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:03 volumio volumio[1057]: info: Listing playlists May 16 18:10:03 volumio volumio[1057]: info: Listing playlists May 16 18:10:08 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:10:08 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:13 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:10:13 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:18 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:10:18 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:18 volumio volumio[1057]: info: Listing playlists May 16 18:10:18 volumio volumio[1057]: info: Listing playlists May 16 18:10:23 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:10:23 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:23 volumio volumio[1057]: info: Listing playlists May 16 18:10:23 volumio volumio[1057]: info: Listing playlists May 16 18:10:28 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:10:28 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:33 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:10:33 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:38 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:10:38 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:38 volumio volumio[1057]: info: Listing playlists May 16 18:10:38 volumio volumio[1057]: info: Listing playlists May 16 18:10:43 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:10:43 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:43 volumio volumio[1057]: info: Listing playlists May 16 18:10:43 volumio volumio[1057]: info: Listing playlists May 16 18:10:48 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:10:48 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:53 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:10:53 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:58 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:10:58 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:10:58 volumio volumio[1057]: info: Listing playlists May 16 18:10:58 volumio volumio[1057]: info: Listing playlists May 16 18:11:03 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:11:03 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:11:03 volumio volumio[1057]: info: Listing playlists May 16 18:11:03 volumio volumio[1057]: info: Listing playlists May 16 18:11:08 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:11:08 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:11:13 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:11:13 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:11:18 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:11:18 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:11:18 volumio volumio[1057]: info: Listing playlists May 16 18:11:18 volumio volumio[1057]: info: Listing playlists May 16 18:11:23 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:11:23 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:11:23 volumio volumio[1057]: info: Listing playlists May 16 18:11:23 volumio volumio[1057]: info: Listing playlists May 16 18:11:28 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:11:28 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:11:33 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:11:33 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:11:38 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:11:38 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:11:38 volumio volumio[1057]: info: Listing playlists May 16 18:11:38 volumio volumio[1057]: info: Listing playlists May 16 18:11:43 volumio volumio[1057]: info: CoreCommandRouter::volumioGetState May 16 18:11:43 volumio volumio[1057]: info: CorePlayQueue::getTrack 3 May 16 18:11:43 volumio volumio[1057]: info: Listing playlists May 16 18:11:43 volumio volumio[1057]: info: Listing playlists May 16 18:11:46 volumio volumio[1057]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 16 18:11:46 volumio volumio[1057]: Error: connect ETIMEDOUT 151.101.66.79:80 May 16 18:11:46 volumio volumio[1057]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 16 18:11:46 volumio volumio[1057]: errno: -110, May 16 18:11:46 volumio volumio[1057]: code: 'ETIMEDOUT', May 16 18:11:46 volumio volumio[1057]: syscall: 'connect', May 16 18:11:46 volumio volumio[1057]: address: '151.101.66.79', May 16 18:11:46 volumio volumio[1057]: port: 80 May 16 18:11:46 volumio volumio[1057]: } May 16 18:11:46 volumio volumio[1057]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 16 18:11:46 volumio sudo[7718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-16 18:10 May 16 18:11:46 volumio sudo[7718]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"