-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2025-12-07 11:26:05 CET. -- Dec 07 11:25:13 volumio volumio[994]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. Dec 07 11:25:33 volumio volumio-remote-updater[632]: [2025-12-07 11:25:33] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Dec 07 11:25:33 volumio volumio[994]: info: [ytmusic] InnertubeLoader: going to refresh po_token in 43100 seconds Dec 07 11:25:34 volumio volumio[994]: Upnp client error: Error: This socket has been ended by the other party Dec 07 11:25:34 volumio volumio[994]: verbose: New Socket.io Connection to 192.168.0.24:3000 from 192.168.0.22 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3 Dec 07 11:25:34 volumio volumio[994]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 07 11:25:34 volumio volumio[994]: Upnp client error: Error: This socket has been ended by the other party Dec 07 11:25:34 volumio volumio[994]: Upnp client error: Error: This socket has been ended by the other party Dec 07 11:25:34 volumio volumio[994]: Upnp client error: Error: This socket has been ended by the other party Dec 07 11:25:34 volumio volumio[994]: Upnp client error: Error: This socket has been ended by the other party Dec 07 11:25:34 volumio volumio[994]: Upnp client error: Error: This socket has been ended by the other party Dec 07 11:25:34 volumio volumio[994]: Upnp client error: Error: This socket has been ended by the other party Dec 07 11:25:34 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 07 11:25:34 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 07 11:25:34 volumio volumio[994]: info: Discovery: Getting this device information Dec 07 11:25:34 volumio volumio[994]: info: CoreCommandRouter::volumioGetState Dec 07 11:25:34 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 07 11:25:34 volumio volumio[994]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Dec 07 11:25:35 volumio volumio[994]: error: Failed search in plugin ytmusic: Error: Unable to resolve or reject the same promise twice Dec 07 11:25:35 volumio volumio[994]: error: Failed search in plugin ytmusic: Error: Unable to resolve or reject the same promise twice Dec 07 11:25:35 volumio volumio[994]: error: Failed search in plugin ytmusic: Error: Unable to resolve or reject the same promise twice Dec 07 11:25:35 volumio volumio[994]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Dec 07 11:25:35 volumio volumio[994]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 07 11:25:35 volumio volumio[994]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Dec 07 11:25:35 volumio volumio[994]: info: CoreCommandRouter::volumioGetState Dec 07 11:25:35 volumio volumio[994]: info: CoreCommandRouter::volumioGetState Dec 07 11:25:35 volumio volumio[994]: SPOTIFY: RECEIVED VOLUMIO VOLUME 88 Dec 07 11:25:35 volumio volumio[994]: error: Failed search in plugin ytmusic: Error: Unable to resolve or reject the same promise twice Dec 07 11:25:36 volumio volumio[994]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Dec 07 11:25:36 volumio volumio[994]: error: Failed search in plugin ytmusic: Error: Unable to resolve or reject the same promise twice Dec 07 11:25:36 volumio volumio[994]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::volumioGetVisibleSources Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::volumioGetState Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::volumioGetState Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 07 11:25:36 volumio volumio[994]: info: Received Get System Info Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 07 11:25:36 volumio volumio[994]: info: Discovery: Getting this device information Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::volumioGetState Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::volumioGetState Dec 07 11:25:36 volumio volumio[994]: info: Listing playlists Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 11:25:36 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 11:25:38 volumio volumio-remote-updater[632]: [2025-12-07 11:25:38] [connect] Successful connection Dec 07 11:25:38 volumio volumio-remote-updater[632]: [2025-12-07 11:25:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1765103138 101 Dec 07 11:25:38 volumio volumio[994]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 11 Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 11:25:43 volumio volumio[994]: info: Retrieving Cloud Streaming UI Dec 07 11:25:43 volumio volumio[994]: info: Getting Tidal Cloud Configuration Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 11:25:43 volumio volumio[994]: info: Getting Qobuz Cloud Configuration Dec 07 11:25:43 volumio volumio[994]: info: Asking plugin for UI Config Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 11:25:43 volumio volumio[994]: info: Getting Spotify Cloud Configuration Dec 07 11:25:43 volumio volumio[994]: info: Asking plugin for UI Config Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 11:25:43 volumio volumio[994]: info: Saving Spotify Acccount Dec 07 11:25:43 volumio volumio[994]: info: Got Tidal Cloud Configuration Dec 07 11:25:43 volumio volumio[994]: info: Got it Dec 07 11:25:43 volumio volumio[994]: info: Got it Dec 07 11:25:43 volumio volumio[994]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 11:25:43 volumio volumio[994]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::volumioGetBrowseSources Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::volumioGetBrowseSources Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::volumioGetBrowseSources Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 11:25:43 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 07 11:25:47 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Dec 07 11:25:47 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand update Dec 07 11:25:47 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Dec 07 11:25:47 volumio volumio[994]: info: Dec 07 11:25:47 volumio volumio[994]: ---------------------------- MPD announces state update: update Dec 07 11:25:47 volumio volumio[994]: info: sendMpdCommand update took 12 milliseconds Dec 07 11:25:47 volumio volumio[994]: info: ControllerMpd::getState Dec 07 11:25:47 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Dec 07 11:25:47 volumio volumio[994]: info: sendMpdCommand status took 10 milliseconds Dec 07 11:25:47 volumio volumio[994]: info: sendMpdCommand status took 4 milliseconds Dec 07 11:25:47 volumio volumio[994]: verbose: ControllerMpd::parseState Dec 07 11:25:47 volumio volumio[994]: info: Command Router : Notfying DB Updatetrue Dec 07 11:25:47 volumio volumio[994]: verbose: ControllerMpd::parseState Dec 07 11:25:47 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 11:25:47 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 11:25:47 volumio volumio[994]: info: sendMpdCommand playlistinfo took 41 milliseconds Dec 07 11:25:47 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Dec 07 11:25:47 volumio volumio[994]: info: ControllerMpd::pushState Dec 07 11:25:47 volumio volumio[994]: info: CoreCommandRouter::servicePushState Dec 07 11:25:47 volumio volumio[994]: info: CorePlayQueue::getTrack 36 Dec 07 11:25:47 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":135839,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"rtl-1-44-128?listen=webCwsBCggNCQgLDQUGBAcGBg","artist":null,"album":null,"uri":"http://icecast.rtl.fr/rtl-1-44-128?listen=webCwsBCggNCQgLDQUGBAcGBg","trackType":""} Dec 07 11:25:47 volumio volumio[994]: verbose: CURRENT POSITION 36 Dec 07 11:25:47 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Dec 07 11:25:47 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Dec 07 11:25:47 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Dec 07 11:25:47 volumio volumio[994]: info: CoreStateMachine::pushState Dec 07 11:25:47 volumio volumio[994]: info: CorePlayQueue::getTrack 36 Dec 07 11:25:47 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 11:25:47 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Dec 07 11:25:47 volumio volumio[994]: info: CoreStateMachine::pushState Dec 07 11:25:47 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Dec 07 11:25:47 volumio volumio[994]: info: ------------------------------ 344ms Dec 07 11:25:47 volumio volumio[994]: SPOTIFY: RECEIVED VOLUMIO VOLUME 88 Dec 07 11:25:47 volumio volumio[994]: SPOTIFY: RECEIVED VOLUMIO VOLUME 88 Dec 07 11:25:51 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 11:25:53 volumio volumio[994]: error: An error occurred while searching Error: connect ETIMEDOUT 35.186.224.24:443 Dec 07 11:25:53 volumio volumio[994]: error: Failed search in plugin spop: Dec 07 11:25:55 volumio volumio[994]: info: CoreCommandRouter::Close All Modals sent Dec 07 11:25:55 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 11:25:57 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Dec 07 11:25:57 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand update Dec 07 11:25:57 volumio volumio[994]: info: sendMpdCommand update took 6 milliseconds Dec 07 11:25:59 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 11:26:04 volumio volumio[994]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 11:26:04 volumio volumio[994]: Error: connect ETIMEDOUT 151.101.122.79:443 Dec 07 11:26:04 volumio volumio[994]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Dec 07 11:26:04 volumio volumio[994]: errno: -110, Dec 07 11:26:04 volumio volumio[994]: code: 'ETIMEDOUT', Dec 07 11:26:04 volumio volumio[994]: syscall: 'connect', Dec 07 11:26:04 volumio volumio[994]: address: '151.101.122.79', Dec 07 11:26:04 volumio volumio[994]: port: 443 Dec 07 11:26:04 volumio volumio[994]: } Dec 07 11:26:04 volumio volumio[994]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 11:26:05 volumio sudo[31030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-07 11:25 Dec 07 11:26:05 volumio sudo[31030]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"