-- Logs begin at Mon 2024-09-30 12:02:52 CEST, end at Sat 2024-10-12 14:03:59 CEST. -- Oct 12 14:03:25 hifi volumio[958]: verbose: New Socket.io Connection to 192.168.0.50 from 192.168.0.107 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.0.1 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 4 Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::volumioGetVisibleSources Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::volumioGetState Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 12 14:03:25 hifi volumio[958]: info: Received Get System Info Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 14:03:25 hifi volumio[958]: info: Discovery: Getting this device information Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::volumioGetState Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::volumioGetState Oct 12 14:03:25 hifi volumio[958]: info: Listing playlists Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::volumioGetQueue Oct 12 14:03:25 hifi volumio[958]: info: CoreStateMachine::getQueue Oct 12 14:03:25 hifi volumio[958]: info: CorePlayQueue::getQueue Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::volumioStop Oct 12 14:03:25 hifi volumio[958]: info: CoreStateMachine::stop Oct 12 14:03:25 hifi volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 14:03:25 hifi volumio[958]: info: CoreStateMachine::stPlaybackTimer Oct 12 14:03:25 hifi volumio[958]: info: CoreStateMachine::updateTrackBlock Oct 12 14:03:25 hifi volumio[958]: info: CorePlayQueue::getTrackBlock Oct 12 14:03:25 hifi volumio[958]: info: CoreStateMachine::pushState Oct 12 14:03:25 hifi volumio[958]: info: CorePlayQueue::getTrack 0 Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::volumioPushState Oct 12 14:03:25 hifi volumio[958]: info: CoreStateMachine::serviceStop Oct 12 14:03:25 hifi volumio[958]: info: CorePlayQueue::getTrack 0 Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::serviceStop Oct 12 14:03:25 hifi volumio[958]: info: [1728734605961] ControllerWebradio::stop Oct 12 14:03:25 hifi volumio[958]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 14:03:25 hifi volumio[958]: info: Oct 12 14:03:25 hifi volumio[958]: ---------------------------- MPD announces state update: player Oct 12 14:03:25 hifi volumio[958]: info: sendMpdCommand stop took 14 milliseconds Oct 12 14:03:25 hifi volumio[958]: info: ControllerMpd::getState Oct 12 14:03:25 hifi volumio[958]: verbose: ControllerMpd::sendMpdCommand status Oct 12 14:03:25 hifi volumio[958]: info: sendMpdCommand status took 1 milliseconds Oct 12 14:03:25 hifi volumio[958]: verbose: ControllerMpd::parseState Oct 12 14:03:25 hifi volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 14:03:25 hifi volumio[958]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 12 14:03:25 hifi volumio[958]: verbose: ControllerMpd::parseTrackInfo Oct 12 14:03:25 hifi volumio[958]: info: ControllerMpd::pushState Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::servicePushState Oct 12 14:03:25 hifi volumio[958]: info: CoreStateMachine::pushState Oct 12 14:03:25 hifi volumio[958]: info: CorePlayQueue::getTrack 0 Oct 12 14:03:25 hifi volumio[958]: info: CoreCommandRouter::volumioPushState Oct 12 14:03:25 hifi volumio[958]: info: CorePlayQueue::getTrack 0 Oct 12 14:03:25 hifi volumio[958]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 12 14:03:25 hifi volumio[958]: info: ------------------------------ 7ms Oct 12 14:03:29 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 14:03:29 hifi volumio[958]: info: CURURI: music-library Oct 12 14:03:29 hifi volumio[958]: info: Preload queue cleared Oct 12 14:03:30 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 14:03:30 hifi volumio[958]: info: CURURI: music-library/USB Oct 12 14:03:30 hifi volumio[958]: info: Preload queue cleared Oct 12 14:03:31 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 14:03:31 hifi volumio[958]: info: CURURI: music-library/USB/USBDisk1 Oct 12 14:03:31 hifi volumio[958]: info: Preload queue cleared Oct 12 14:03:52 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 14:03:52 hifi volumio[958]: info: CURURI: music-library/USB/USBDisk1/Porcupine Tree Oct 12 14:03:52 hifi volumio[958]: info: Preload queue cleared Oct 12 14:03:58 hifi volumio[958]: info: Preload queue cleared Oct 12 14:03:58 hifi volumio[958]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 12 14:03:58 hifi volumio[958]: info: CoreStateMachine::ClearQueue Oct 12 14:03:58 hifi volumio[958]: info: CoreStateMachine::stop Oct 12 14:03:58 hifi volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 14:03:58 hifi volumio[958]: info: CorePlayQueue::clearPlayQueue Oct 12 14:03:58 hifi volumio[958]: info: CorePlayQueue::saveQueue Oct 12 14:03:58 hifi volumio[958]: info: CoreCommandRouter::volumioPushQueue Oct 12 14:03:58 hifi volumio[958]: info: CoreStateMachine::addQueueItems Oct 12 14:03:58 hifi volumio[958]: info: CorePlayQueue::addQueueItems Oct 12 14:03:58 hifi volumio[958]: info: Preload queue cleared Oct 12 14:03:58 hifi volumio[958]: info: Adding Item to queue: music-library/USB/USBDisk1/Porcupine Tree/1995 - The Sky Moves Sideways (Original US version) Oct 12 14:03:58 hifi volumio[958]: info: Exploding uri music-library/USB/USBDisk1/Porcupine Tree/1995 - The Sky Moves Sideways (Original US version) in service mpd Oct 12 14:03:58 hifi volumio[958]: info: ALBUMART /albumart?cacheid=298&web=Porcupine%20Tree/The%20Sky%20Moves%20Sideways/extralarge&path=%2Fmnt%2FUSB%2FUSBDisk1%2FPorcupine%20Tree%2F1995%20-%20The%20Sky%20Moves%20Sideways%20(Original%20US%20version)%2FPorcupine%20Tree%20-%20The%20Sky%20Moves%20Sideways.cue&metadata=false Oct 12 14:03:58 hifi volumio[958]: info: URI /mnt/USB/USBDisk1/Porcupine Tree/1995 - The Sky Moves Sideways (Original US version)/Porcupine Tree - The Sky Moves Sideways.cue Oct 12 14:03:58 hifi volumio[958]: info: ALBUMART /albumart?cacheid=298&web=Porcupine%20Tree/The%20Sky%20Moves%20Sideways/extralarge&path=%2Fmnt%2FUSB%2FUSBDisk1%2FPorcupine%20Tree%2F1995%20-%20The%20Sky%20Moves%20Sideways%20(Original%20US%20version)%2FPorcupine%20Tree%20-%20The%20Sky%20Moves%20Sideways.cue&metadata=false Oct 12 14:03:58 hifi volumio[958]: info: URI /mnt/USB/USBDisk1/Porcupine Tree/1995 - The Sky Moves Sideways (Original US version)/Porcupine Tree - The Sky Moves Sideways.cue Oct 12 14:03:58 hifi volumio[958]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 14:03:58 hifi volumio[958]: Error: Unable to resolve or reject the same promise twice Oct 12 14:03:58 hifi volumio[958]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 12 14:03:58 hifi volumio[958]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Oct 12 14:03:58 hifi volumio[958]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 12 14:03:58 hifi volumio[958]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 12 14:03:58 hifi volumio[958]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 12 14:03:58 hifi volumio[958]: at Socket.emit (events.js:315:20) Oct 12 14:03:58 hifi volumio[958]: at addChunk (internal/streams/readable.js:309:12) Oct 12 14:03:58 hifi volumio[958]: at readableAddChunk (internal/streams/readable.js:280:11) Oct 12 14:03:58 hifi volumio[958]: at Socket.Readable.push (internal/streams/readable.js:223:10) Oct 12 14:03:58 hifi volumio[958]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Oct 12 14:03:58 hifi volumio[958]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 14:03:59 hifi sudo[11870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-12 14:02 Oct 12 14:03:59 hifi sudo[11870]: 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"