-- Logs begin at Sat 2024-07-27 07:21:00 CST, end at Sat 2024-07-27 08:26:20 CST. -- Jul 27 08:25:52 volumio volumio[670]: info: Jul 27 08:25:52 volumio volumio[670]: ---------------------------- MPD announces state update: player Jul 27 08:25:52 volumio volumio[670]: info: ControllerMpd::getState Jul 27 08:25:52 volumio volumio[670]: verbose: ControllerMpd::sendMpdCommand status Jul 27 08:25:52 volumio volumio[670]: info: Jul 27 08:25:52 volumio volumio[670]: ---------------------------- MPD announces state update: player Jul 27 08:25:52 volumio volumio[670]: info: ControllerMpd::getState Jul 27 08:25:52 volumio volumio[670]: verbose: ControllerMpd::sendMpdCommand status Jul 27 08:25:52 volumio volumio[670]: info: Jul 27 08:25:52 volumio volumio[670]: ---------------------------- MPD announces state update: player Jul 27 08:25:52 volumio volumio[670]: info: ControllerMpd::getState Jul 27 08:25:52 volumio volumio[670]: verbose: ControllerMpd::sendMpdCommand status Jul 27 08:25:52 volumio volumio[670]: info: sendMpdCommand status took 1 milliseconds Jul 27 08:25:52 volumio volumio[670]: info: sendMpdCommand status took 1 milliseconds Jul 27 08:25:52 volumio volumio[670]: info: sendMpdCommand status took 1 milliseconds Jul 27 08:25:52 volumio volumio[670]: verbose: ControllerMpd::parseState Jul 27 08:25:52 volumio volumio[670]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 27 08:25:52 volumio volumio[670]: verbose: ControllerMpd::parseState Jul 27 08:25:52 volumio volumio[670]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 27 08:25:52 volumio volumio[670]: verbose: ControllerMpd::parseState Jul 27 08:25:52 volumio volumio[670]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 27 08:25:52 volumio volumio[670]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 27 08:25:52 volumio volumio[670]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 27 08:25:52 volumio volumio[670]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 27 08:25:52 volumio volumio[670]: verbose: ControllerMpd::parseTrackInfo Jul 27 08:25:52 volumio volumio[670]: verbose: ControllerMpd::parseTrackInfo Jul 27 08:25:52 volumio volumio[670]: verbose: ControllerMpd::parseTrackInfo Jul 27 08:25:52 volumio volumio[670]: info: ControllerMpd::pushState Jul 27 08:25:52 volumio volumio[670]: info: CoreCommandRouter::servicePushState Jul 27 08:25:52 volumio volumio[670]: verbose: In UPNP mode Jul 27 08:25:52 volumio volumio[670]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":108082,"duration":276,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"謝謝你的愛","artist":"劉德華","album":"真我的風采","uri":"http://192.168.1.4:33871/bridge-6.flac","trackType":"flac"} Jul 27 08:25:52 volumio volumio[670]: verbose: CURRENT POSITION 0 Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::syncState stateService pause Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::syncState currentStatus play Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::pushState Jul 27 08:25:52 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 27 08:25:52 volumio volumio[670]: info: CoreCommandRouter::volumioPushState Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::stPlaybackTimer Jul 27 08:25:52 volumio volumio[670]: info: ControllerMpd::pushState Jul 27 08:25:52 volumio volumio[670]: info: CoreCommandRouter::servicePushState Jul 27 08:25:52 volumio volumio[670]: verbose: In UPNP mode Jul 27 08:25:52 volumio volumio[670]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":108082,"duration":276,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"謝謝你的愛","artist":"劉德華","album":"真我的風采","uri":"http://192.168.1.4:33871/bridge-6.flac","trackType":"flac"} Jul 27 08:25:52 volumio volumio[670]: verbose: CURRENT POSITION 0 Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::syncState stateService pause Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::syncState currentStatus play Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::pushState Jul 27 08:25:52 volumio volumio[670]: info: CoreCommandRouter::volumioPushState Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::stPlaybackTimer Jul 27 08:25:52 volumio volumio[670]: info: ControllerMpd::pushState Jul 27 08:25:52 volumio volumio[670]: info: CoreCommandRouter::servicePushState Jul 27 08:25:52 volumio volumio[670]: verbose: In UPNP mode Jul 27 08:25:52 volumio volumio[670]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":108082,"duration":276,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"謝謝你的愛","artist":"劉德華","album":"真我的風采","uri":"http://192.168.1.4:33871/bridge-6.flac","trackType":"flac"} Jul 27 08:25:52 volumio volumio[670]: verbose: CURRENT POSITION 0 Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::syncState stateService pause Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::syncState currentStatus play Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::pushState Jul 27 08:25:52 volumio volumio[670]: info: CoreCommandRouter::volumioPushState Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::stPlaybackTimer Jul 27 08:25:52 volumio volumio[670]: info: ------------------------------ 12ms Jul 27 08:25:52 volumio volumio[670]: info: ------------------------------ 12ms Jul 27 08:25:52 volumio volumio[670]: info: CoreCommandRouter::volumioGetQueue Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::getQueue Jul 27 08:25:52 volumio volumio[670]: info: CorePlayQueue::getQueue Jul 27 08:25:52 volumio volumio[670]: info: CoreCommandRouter::volumioGetQueue Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::getQueue Jul 27 08:25:52 volumio volumio[670]: info: CorePlayQueue::getQueue Jul 27 08:25:52 volumio volumio[670]: info: CoreCommandRouter::volumioGetQueue Jul 27 08:25:52 volumio volumio[670]: info: CoreStateMachine::getQueue Jul 27 08:25:52 volumio volumio[670]: info: CorePlayQueue::getQueue Jul 27 08:25:54 volumio volumio[670]: info: CoreCommandRouter::volumioGetQueue Jul 27 08:25:54 volumio volumio[670]: info: CoreStateMachine::getQueue Jul 27 08:25:54 volumio volumio[670]: info: CorePlayQueue::getQueue Jul 27 08:25:57 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 27 08:25:57 volumio volumio[670]: info: CURURI: music-library Jul 27 08:25:57 volumio volumio[670]: info: Preload queue cleared Jul 27 08:26:02 volumio volumio[670]: info: CoreCommandRouter::volumioGetState Jul 27 08:26:05 volumio volumio[670]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 27 08:26:05 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 27 08:26:05 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 27 08:26:05 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 27 08:26:05 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 27 08:26:05 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 27 08:26:05 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 27 08:26:05 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 27 08:26:05 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 27 08:26:05 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 27 08:26:05 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 27 08:26:05 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 27 08:26:05 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 27 08:26:08 volumio volumio[670]: info: CoreCommandRouter::volumioGetState Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 27 08:26:10 volumio volumio[670]: info: Retrieving Cloud Streaming UI Jul 27 08:26:10 volumio volumio[670]: info: Getting Tidal Cloud Configuration Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 27 08:26:10 volumio volumio[670]: info: Getting Qobuz Cloud Configuration Jul 27 08:26:10 volumio volumio[670]: info: Asking plugin for UI Config Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 27 08:26:10 volumio volumio[670]: info: Getting Spotify Cloud Configuration Jul 27 08:26:10 volumio volumio[670]: info: Asking plugin for UI Config Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 27 08:26:10 volumio volumio[670]: info: Saving Spotify Acccount Jul 27 08:26:10 volumio volumio[670]: info: Got Tidal Cloud Configuration Jul 27 08:26:10 volumio volumio[670]: info: Got it Jul 27 08:26:10 volumio volumio[670]: info: Got it Jul 27 08:26:10 volumio volumio[670]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 27 08:26:10 volumio volumio[670]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::volumioGetBrowseSources Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::volumioGetBrowseSources Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::volumioGetBrowseSources Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 27 08:26:10 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 27 08:26:14 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 27 08:26:18 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 27 08:26:19 volumio volumio[670]: info: CALLMETHOD: miscellanea my_music updateMusicLibrarySupersearchSources [object Object] Jul 27 08:26:19 volumio volumio[670]: info: CoreCommandRouter::executeOnPlugin: my_music , updateMusicLibrarySupersearchSources Jul 27 08:26:19 volumio volumio[670]: info: CoreCommandRouter::volumioGetBrowseSources Jul 27 08:26:19 volumio volumio[670]: info: CoreCommandRouter::updateGlobalSearchableBrowseSources Jul 27 08:26:20 volumio volumio[670]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 27 08:26:20 volumio volumio[670]: Error: connect ETIMEDOUT 69.162.134.178:443 Jul 27 08:26:20 volumio volumio[670]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 27 08:26:20 volumio volumio[670]: errno: -110, Jul 27 08:26:20 volumio volumio[670]: code: 'ETIMEDOUT', Jul 27 08:26:20 volumio volumio[670]: syscall: 'connect', Jul 27 08:26:20 volumio volumio[670]: address: '69.162.134.178', Jul 27 08:26:20 volumio volumio[670]: port: 443 Jul 27 08:26:20 volumio volumio[670]: } Jul 27 08:26:20 volumio volumio[670]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 27 08:26:20 volumio sudo[17358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-27 08:25 Jul 27 08:26:20 volumio sudo[17358]: 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="9552505bba4239c163ac9ee7b0b87a56e0dd0574" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="3d3fc502273a5c173ba19f72c1a952bdb2bdd3b0" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 Feb 2024 07:28:53 PM CET" VOLUMIO_VERSION="3.616" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="f11d51aa83fa91106999927181e8c0f7"