-- Logs begin at Sun 2024-04-21 23:28:53 CST, end at Mon 2024-04-22 07:39:27 CST. -- Apr 22 07:38:39 volumio-rockpro64 sshd[2079]: Accepted publickey for root from 192.168.31.227 port 59858 ssh2: RSA SHA256:wGjqeL+hAj00xNv1XLRXtD0vUZE2vL30q0ViRUaNoXk Apr 22 07:38:39 volumio-rockpro64 sshd[2079]: pam_unix(sshd:session): session opened for user root by (uid=0) Apr 22 07:38:39 volumio-rockpro64 systemd[1]: Created slice User Slice of UID 0. Apr 22 07:38:39 volumio-rockpro64 systemd[1]: Starting User Runtime Directory /run/user/0... Apr 22 07:38:39 volumio-rockpro64 systemd-logind[1401]: New session 14 of user root. Apr 22 07:38:39 volumio-rockpro64 systemd[1]: Started User Runtime Directory /run/user/0. Apr 22 07:38:39 volumio-rockpro64 systemd[1]: Starting User Manager for UID 0... Apr 22 07:38:39 volumio-rockpro64 systemd[2084]: pam_unix(systemd-user:session): session opened for user root by (uid=0) Apr 22 07:38:39 volumio-rockpro64 systemd[2084]: Condition check resulted in Sound System being skipped. Apr 22 07:38:39 volumio-rockpro64 systemd[2084]: Starting D-Bus User Message Bus Socket. Apr 22 07:38:39 volumio-rockpro64 systemd[2084]: Reached target Paths. Apr 22 07:38:39 volumio-rockpro64 systemd[2084]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Apr 22 07:38:39 volumio-rockpro64 systemd[2084]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Apr 22 07:38:39 volumio-rockpro64 systemd[2084]: Listening on GnuPG cryptographic agent and passphrase cache. Apr 22 07:38:39 volumio-rockpro64 systemd[2084]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Apr 22 07:38:40 volumio-rockpro64 systemd[2084]: Reached target Timers. Apr 22 07:38:40 volumio-rockpro64 systemd[2084]: Listening on GnuPG network certificate management daemon. Apr 22 07:38:40 volumio-rockpro64 systemd[2084]: Listening on D-Bus User Message Bus Socket. Apr 22 07:38:40 volumio-rockpro64 systemd[2084]: Reached target Sockets. Apr 22 07:38:40 volumio-rockpro64 systemd[2084]: Reached target Basic System. Apr 22 07:38:40 volumio-rockpro64 systemd[1]: Started User Manager for UID 0. Apr 22 07:38:40 volumio-rockpro64 systemd[2084]: Starting Music Player Daemon... Apr 22 07:38:40 volumio-rockpro64 systemd[1]: Started Session 14 of user root. Apr 22 07:38:40 volumio-rockpro64 nmbd[1675]: [2024/04/22 07:38:40.481534, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 22 07:38:40 volumio-rockpro64 nmbd[1675]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.31.203 for name WORKGROUP<1d>. Apr 22 07:38:40 volumio-rockpro64 nmbd[1675]: This response was from IP 192.168.31.19, reporting an IP address of 192.168.31.19. Apr 22 07:38:41 volumio-rockpro64 mpd[2101]: Apr 22 07:38 : exception: Failed to bind to '[::]:6600'; Failed to bind socket: Address already in use Apr 22 07:38:41 volumio-rockpro64 systemd[2084]: mpd.service: Main process exited, code=exited, status=1/FAILURE Apr 22 07:38:41 volumio-rockpro64 systemd[2084]: mpd.service: Failed with result 'exit-code'. Apr 22 07:38:41 volumio-rockpro64 systemd[2084]: Failed to start Music Player Daemon. Apr 22 07:38:41 volumio-rockpro64 systemd[2084]: Reached target Default. Apr 22 07:38:41 volumio-rockpro64 systemd[2084]: Startup finished in 1.782s. Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::volumioPause Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::pause Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::stPlaybackTimer Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::servicePause Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CorePlayQueue::getTrack 0 Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::servicePause Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: ControllerMpd::pause Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: ControllerMpd::sendMpdCommand pause Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: sendMpdCommand pause took 30 milliseconds Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: ---------------------------- MPD announces state update: player Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: ControllerMpd::getState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: ControllerMpd::sendMpdCommand status Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: ---------------------------- MPD announces state update: player Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: ControllerMpd::getState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: ControllerMpd::sendMpdCommand status Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: ---------------------------- MPD announces state update: player Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: ControllerMpd::getState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: ControllerMpd::sendMpdCommand status Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: sendMpdCommand status took 4 milliseconds Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: sendMpdCommand status took 2 milliseconds Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: sendMpdCommand status took 2 milliseconds Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: ControllerMpd::parseState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: ControllerMpd::parseState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: ControllerMpd::parseState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: ControllerMpd::parseTrackInfo Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: ControllerMpd::parseTrackInfo Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: ControllerMpd::parseTrackInfo Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: ControllerMpd::pushState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::servicePushState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CorePlayQueue::getTrack 0 Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":86771,"duration":366,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 - さよならの向う側.dsf","artist":null,"album":null,"uri":"USB/NVMe120G/Music/山口百惠/Complete Momoe Kaiki 百恵回帰 山口百惠 1 sacd/01 - さよならの向う側.dsf","trackType":"dsf"} Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: CURRENT POSITION 0 Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::syncState stateService pause Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::syncState currentStatus pause Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::pushState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CorePlayQueue::getTrack 0 Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::volumioPushState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::stPlaybackTimer Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: ControllerMpd::pushState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::servicePushState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CorePlayQueue::getTrack 0 Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":86771,"duration":366,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 - さよならの向う側.dsf","artist":null,"album":null,"uri":"USB/NVMe120G/Music/山口百惠/Complete Momoe Kaiki 百恵回帰 山口百惠 1 sacd/01 - さよならの向う側.dsf","trackType":"dsf"} Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: CURRENT POSITION 0 Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::syncState stateService pause Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::syncState currentStatus pause Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::pushState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CorePlayQueue::getTrack 0 Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::volumioPushState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::stPlaybackTimer Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: ControllerMpd::pushState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::servicePushState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CorePlayQueue::getTrack 0 Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":86771,"duration":366,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 - さよならの向う側.dsf","artist":null,"album":null,"uri":"USB/NVMe120G/Music/山口百惠/Complete Momoe Kaiki 百恵回帰 山口百惠 1 sacd/01 - さよならの向う側.dsf","trackType":"dsf"} Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: verbose: CURRENT POSITION 0 Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::syncState stateService pause Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::syncState currentStatus pause Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::pushState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CorePlayQueue::getTrack 0 Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::volumioPushState Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: CoreStateMachine::stPlaybackTimer Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: ------------------------------ 31ms Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: ------------------------------ 30ms Apr 22 07:39:08 volumio-rockpro64 volumio[1875]: info: ------------------------------ 30ms Apr 22 07:39:16 volumio-rockpro64 volumio[1875]: error: Cannot refresh My Volumio Token: undefined Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: Error: connect ETIMEDOUT 69.63.176.143:80 Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: errno: -110, Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: code: 'ETIMEDOUT', Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: syscall: 'connect', Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: address: '69.63.176.143', Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: port: 80 Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: } Apr 22 07:39:26 volumio-rockpro64 volumio[1875]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 07:39:27 volumio-rockpro64 sudo[2336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-22 07:38 Apr 22 07:39:27 volumio-rockpro64 sudo[2336]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 24 Feb 2024 06:04:58 PM CET" VOLUMIO_VERSION="3.629" VOLUMIO_HARDWARE="rockpi-4b" VOLUMIO_DEVICENAME="RockPi 4B" VOLUMIO_HASH="f719547f7be1ecbace387de2c01f42bc"