-- Logs begin at Tue 2024-10-01 04:54:20 UTC, end at Wed 2024-10-02 00:00:08 UTC. -- Oct 01 23:59:03 musical-fidelity volumio[1305]: info: CALLMETHOD: music_service raat saveRaatPlaybackOptions [object Object] Oct 01 23:59:03 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: raat , saveRaatPlaybackOptions Oct 01 23:59:03 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 23:59:03 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 23:59:03 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 23:59:03 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 23:59:03 musical-fidelity volumio[1305]: info: Not Reporting Auto name since its the default one Oct 01 23:59:03 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 01 23:59:03 musical-fidelity volumio[1305]: No protocol specified Oct 01 23:59:03 musical-fidelity volumio[1305]: xcb_connection_has_error() returned true Oct 01 23:59:03 musical-fidelity sudo[2564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 01 23:59:03 musical-fidelity sudo[2564]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 23:59:03 musical-fidelity systemd[1]: Stopping RAAT DAEMON... Oct 01 23:59:03 musical-fidelity volumio[1305]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 01 23:59:03 musical-fidelity systemd[1]: Starting RAAT DAEMON... Oct 01 23:59:03 musical-fidelity systemd[1]: Started RAAT DAEMON. Oct 01 23:59:03 musical-fidelity sudo[2564]: pam_unix(sudo:session): session closed for user root Oct 01 23:59:03 musical-fidelity volumio[1305]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 01 23:59:03 musical-fidelity volumio[1305]: info: Raat Daemon started successfully Oct 01 23:59:03 musical-fidelity volumio[1305]: Error in parsing play status: TypeError: Cannot read property '0' of undefined Oct 01 23:59:03 musical-fidelity volumio[1305]: info: Executing endpoint restartRAATSocket Oct 01 23:59:03 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 01 23:59:03 musical-fidelity volumio[1305]: info: CorePlayQueue::getTrack 0 Oct 01 23:59:17 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 01 23:59:17 musical-fidelity volumio[1305]: info: CURURI: artists://- Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::ClearQueue Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::stop Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: UNSET VOLATILE Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CorePlayQueue::clearPlayQueue Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CorePlayQueue::saveQueue Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::volumioPushState Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::volumioPushQueue Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::addQueueItems Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CorePlayQueue::addQueueItems Oct 01 23:59:21 musical-fidelity volumio[1305]: info: Adding Item to queue: artists://- Oct 01 23:59:21 musical-fidelity volumio[1305]: info: Exploding uri artists://- in service mpd Oct 01 23:59:21 musical-fidelity volumio[1305]: info: Updating RAAT Signal Path Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CorePlayQueue::saveQueue Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::volumioPushQueue Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::updateTrackBlock Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CorePlayQueue::getTrackBlock Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::volumioPlay Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: UNSET VOLATILE Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::play index 0 Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::stop Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: UNSET VOLATILE Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::play index undefined Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CorePlayQueue::getTrack 0 Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::startPlaybackTimer Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CorePlayQueue::getTrack 0 Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: ControllerMpd::clearAddPlayTracks USB/Seagate Basic/新建文件夹/小提琴名家专区.古典/Nathan.Milstein/Nathan.Milstein.-.[The.Last.Recital].专辑.(Ape)/CDImage.ape Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: ControllerMpd::sendMpdCommand stop Oct 01 23:59:21 musical-fidelity volumio[1305]: info: sendMpdCommand stop took 15 milliseconds Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: ControllerMpd::sendMpdCommand clear Oct 01 23:59:21 musical-fidelity volumio[1305]: info: Oct 01 23:59:21 musical-fidelity volumio[1305]: ---------------------------- MPD announces system playlist update Oct 01 23:59:21 musical-fidelity volumio[1305]: info: Ignoring MPD Status Update Oct 01 23:59:21 musical-fidelity volumio[1305]: info: sendMpdCommand clear took 7 milliseconds Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: ControllerMpd::sendMpdCommand add "USB/Seagate Basic/新建文件夹/小提琴名家专区.古典/Nathan.Milstein/Nathan.Milstein.-.[The.Last.Recital].专辑.(Ape)/CDImage.ape" Oct 01 23:59:21 musical-fidelity volumio[1305]: error: updateQueue error: null Oct 01 23:59:21 musical-fidelity volumio[1305]: info: Oct 01 23:59:21 musical-fidelity volumio[1305]: ---------------------------- MPD announces system playlist update Oct 01 23:59:21 musical-fidelity volumio[1305]: info: Ignoring MPD Status Update Oct 01 23:59:21 musical-fidelity volumio[1305]: info: ------------------------------ 16ms Oct 01 23:59:21 musical-fidelity volumio[1305]: info: sendMpdCommand add "USB/Seagate Basic/新建文件夹/小提琴名家专区.古典/Nathan.Milstein/Nathan.Milstein.-.[The.Last.Recital].专辑.(Ape)/CDImage.ape" took 14 milliseconds Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: ControllerMpd::sendMpdCommand play Oct 01 23:59:21 musical-fidelity volumio[1305]: info: ------------------------------ 10ms Oct 01 23:59:21 musical-fidelity volumio[1305]: info: sendMpdCommand play took 6 milliseconds Oct 01 23:59:21 musical-fidelity volumio[1305]: info: Oct 01 23:59:21 musical-fidelity volumio[1305]: ---------------------------- MPD announces state update: player Oct 01 23:59:21 musical-fidelity volumio[1305]: info: ControllerMpd::getState Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: ControllerMpd::sendMpdCommand status Oct 01 23:59:21 musical-fidelity volumio[1305]: info: Oct 01 23:59:21 musical-fidelity volumio[1305]: ---------------------------- MPD announces state update: player Oct 01 23:59:21 musical-fidelity volumio[1305]: info: sendMpdCommand status took 4 milliseconds Oct 01 23:59:21 musical-fidelity volumio[1305]: info: ControllerMpd::getState Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: ControllerMpd::sendMpdCommand status Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: ControllerMpd::parseState Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 23:59:21 musical-fidelity volumio[1305]: info: sendMpdCommand status took 6 milliseconds Oct 01 23:59:21 musical-fidelity volumio[1305]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: ControllerMpd::parseState Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: ControllerMpd::parseTrackInfo Oct 01 23:59:21 musical-fidelity volumio[1305]: info: ControllerMpd::pushState Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::servicePushState Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CorePlayQueue::getTrack 0 Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: STATE SERVICE {"status":"play","position":0,"seek":232,"duration":4140,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"-","artist":"-","album":"-","uri":"USB/Seagate Basic/新建文件夹/小提琴名家专区.古典/Nathan.Milstein/Nathan.Milstein.-.[The.Last.Recital].专辑.(Ape)/CDImage.ape","trackType":"ape"} Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: CURRENT POSITION 0 Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::syncState stateService play Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::syncState currentStatus stop Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::pushState Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CorePlayQueue::getTrack 0 Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::volumioPushState Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 23:59:21 musical-fidelity volumio[1305]: info: ------------------------------ 45ms Oct 01 23:59:21 musical-fidelity volumio[1305]: info: sendMpdCommand playlistinfo took 25 milliseconds Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: ControllerMpd::parseTrackInfo Oct 01 23:59:21 musical-fidelity volumio[1305]: info: ControllerMpd::pushState Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::servicePushState Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CorePlayQueue::getTrack 0 Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":4140,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"-","artist":"-","album":"-","uri":"USB/Seagate Basic/新建文件夹/小提琴名家专区.古典/Nathan.Milstein/Nathan.Milstein.-.[The.Last.Recital].专辑.(Ape)/CDImage.ape","trackType":"ape"} Oct 01 23:59:21 musical-fidelity volumio[1305]: verbose: CURRENT POSITION 0 Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::syncState stateService play Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::syncState currentStatus play Oct 01 23:59:21 musical-fidelity volumio[1305]: info: Received an update from plugin. extracting info from payload Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::pushState Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CorePlayQueue::getTrack 0 Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::volumioPushState Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreStateMachine::pushState Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CorePlayQueue::getTrack 0 Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::volumioPushState Oct 01 23:59:21 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 23:59:21 musical-fidelity volumio[1305]: info: ------------------------------ 75ms Oct 01 23:59:21 musical-fidelity volumio[1305]: info: Updating RAAT Signal Path Oct 01 23:59:21 musical-fidelity volumio[1305]: info: Updating RAAT Signal Path Oct 01 23:59:21 musical-fidelity volumio[1305]: info: Updating RAAT Signal Path Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 01 23:59:29 musical-fidelity volumio[1305]: No protocol specified Oct 01 23:59:29 musical-fidelity volumio[1305]: xcb_connection_has_error() returned true Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 01 23:59:29 musical-fidelity volumio[1305]: No protocol specified Oct 01 23:59:29 musical-fidelity volumio[1305]: xcb_connection_has_error() returned true Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 23:59:29 musical-fidelity volumio[1305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 00:00:01 musical-fidelity volumio[1305]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Antigoni%20Goni/7a9d74e6-18ea-4173-a9c5-a7d6a2a00cf1.jpg' Oct 02 00:00:07 musical-fidelity volumio[1305]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 00:00:07 musical-fidelity volumio[1305]: { Error: connect ETIMEDOUT 108.160.166.42:80 Oct 02 00:00:07 musical-fidelity volumio[1305]: at Object._errnoException (util.js:1022:11) Oct 02 00:00:07 musical-fidelity volumio[1305]: at _exceptionWithHostPort (util.js:1044:20) Oct 02 00:00:07 musical-fidelity volumio[1305]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 02 00:00:07 musical-fidelity volumio[1305]: code: 'ETIMEDOUT', Oct 02 00:00:07 musical-fidelity volumio[1305]: errno: 'ETIMEDOUT', Oct 02 00:00:07 musical-fidelity volumio[1305]: syscall: 'connect', Oct 02 00:00:07 musical-fidelity volumio[1305]: address: '108.160.166.42', Oct 02 00:00:07 musical-fidelity volumio[1305]: port: 80 } Oct 02 00:00:07 musical-fidelity volumio[1305]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 00:00:08 musical-fidelity sudo[3014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-01 23:59 Oct 02 00:00:08 musical-fidelity sudo[3014]: 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="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="mf" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jul 13 16:55:24 CEST 2022" VOLUMIO_VERSION="1.079" VOLUMIO_HARDWARE="pi" VOLUMIO_VENDOR="Musical Fidelity" VOLUMIO_MODEL="MX-Stream" VOLUMIO_VENDOR_MODEL="Musical Fidelity MX-Stream" VOLUMIO_HASH="feef4003d1cbcf074f611a1d9cb9a86e"