-- Logs begin at Thu 2019-02-14 13:12:00 MSK, end at Fri 2026-04-10 14:25:59 MSK. -- Apr 10 14:24:00 volumio volumio[885]: info: MyVolumio token set successfully Apr 10 14:24:00 volumio volumio[885]: info: MYVOLUMIO: Adding device Apr 10 14:24:00 volumio volumio[885]: info: MYVOLUMIO: Evaluating Server Apr 10 14:24:01 volumio volumio[885]: STREAMING PROXY: Starting server on port 3245 Apr 10 14:24:01 volumio volumio[885]: Node JS runtime: 14 Apr 10 14:24:01 volumio volumio[885]: info: MyVolumio status changed Apr 10 14:24:01 volumio volumio[885]: info: Streaming services startup Apr 10 14:24:01 volumio volumio[885]: info: Starting Streaming Daemon Apr 10 14:24:01 volumio volumio[885]: info: Removing browser output: myVolumio user plan is not superstar Apr 10 14:24:01 volumio volumio[885]: info: Removing audio output: Apr 10 14:24:01 volumio volumio[885]: info: Stoppping Tunnel 1 Apr 10 14:24:01 volumio sudo[1503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 10 14:24:01 volumio sudo[1503]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 14:24:01 volumio sudo[1505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 10 14:24:01 volumio sudo[1505]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 14:24:01 volumio sudo[1503]: pam_unix(sudo:session): session closed for user root Apr 10 14:24:01 volumio volumio[885]: error: Cannot start Volumio Streaming Daemon Apr 10 14:24:01 volumio volumio[885]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 10 14:24:01 volumio volumio[885]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 10 14:24:01 volumio sudo[1505]: pam_unix(sudo:session): session closed for user root Apr 10 14:24:01 volumio volumio[885]: info: Remote SSH Stopped Apr 10 14:24:01 volumio volumio[885]: info: Setting Geolocation for MyVolumio to eu9 Apr 10 14:24:01 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 14:24:01 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 14:24:01 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 14:24:02 volumio volumio[885]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 10 14:24:02 volumio volumio[885]: info: [now-playing] Fetching API key... Apr 10 14:24:02 volumio volumio[885]: info: Updating MyVolumio device info Apr 10 14:24:02 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 14:24:02 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 14:24:02 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 14:24:02 volumio volumio[885]: verbose: New Socket.io Connection to localhost: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: 12 Apr 10 14:24:03 volumio sudo[1524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=vvl,password=FuximoRik@2020,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.249/Music2 /mnt/NAS/Music Apr 10 14:24:03 volumio sudo[1524]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 14:24:03 volumio volumio[885]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not fetch weather: Could not obtain API key Apr 10 14:24:03 volumio volumio[885]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:103:19) Apr 10 14:24:03 volumio volumio[885]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 10 14:24:03 volumio volumio[885]: at async Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:115:28) Apr 10 14:24:03 volumio volumio[885]: (node:885) UnhandledPromiseRejectionWarning: Error: Could not obtain API key Apr 10 14:24:03 volumio volumio[885]: at doGet (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:125:19) Apr 10 14:24:03 volumio volumio[885]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 10 14:24:03 volumio volumio[885]: (node:885) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 6) Apr 10 14:24:03 volumio volumio[885]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 10 14:24:04 volumio kernel: CIFS: Attempting to mount //192.168.1.249/Music2 Apr 10 14:24:04 volumio volumio[885]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Apr 10 14:24:04 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Apr 10 14:24:05 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 10 14:24:05 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 14:24:05 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 10 14:24:05 volumio volumio-remote-updater[603]: No test mode Apr 10 14:24:05 volumio volumio-remote-updater[603]: No alpha test mode Apr 10 14:24:05 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 10 14:24:05 volumio volumio[885]: info: Listing playlists Apr 10 14:24:05 volumio volumio[885]: info: CoreCommandRouter::volumioGetQueue Apr 10 14:24:05 volumio volumio[885]: info: CoreStateMachine::getQueue Apr 10 14:24:05 volumio volumio[885]: info: CorePlayQueue::getQueue Apr 10 14:24:05 volumio volumio[885]: info: CoreCommandRouter::volumioGetVisibleSources Apr 10 14:24:05 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 10 14:24:05 volumio volumio[885]: info: CoreCommandRouter::volumioGetState Apr 10 14:24:05 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:24:06 volumio volumio[885]: info: MYVOLUMIO: Adding device Apr 10 14:24:06 volumio volumio[885]: info: MYVOLUMIO: Evaluating Server Apr 10 14:24:06 volumio volumio[885]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 10 14:24:06 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 10 14:24:07 volumio volumio[885]: verbose: New Socket.io Connection to localhost: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: 7 Apr 10 14:24:07 volumio volumio[885]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Apr 10 14:24:07 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Apr 10 14:24:07 volumio volumio[885]: info: Setting Geolocation for MyVolumio to eu9 Apr 10 14:24:07 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 14:24:07 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 14:24:07 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 14:24:07 volumio volumio[885]: info: Listing playlists Apr 10 14:24:07 volumio volumio[885]: info: CoreCommandRouter::volumioGetQueue Apr 10 14:24:07 volumio volumio[885]: info: CoreStateMachine::getQueue Apr 10 14:24:07 volumio volumio[885]: info: CorePlayQueue::getQueue Apr 10 14:24:07 volumio volumio[885]: info: CoreCommandRouter::volumioGetVisibleSources Apr 10 14:24:07 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 10 14:24:07 volumio volumio[885]: info: CoreCommandRouter::volumioGetState Apr 10 14:24:07 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:24:07 volumio volumio[885]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Apr 10 14:24:07 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Apr 10 14:24:07 volumio volumio[885]: info: Listing playlists Apr 10 14:24:07 volumio volumio[885]: info: CoreCommandRouter::volumioGetQueue Apr 10 14:24:07 volumio volumio[885]: info: CoreStateMachine::getQueue Apr 10 14:24:07 volumio volumio[885]: info: CorePlayQueue::getQueue Apr 10 14:24:07 volumio volumio[885]: info: CoreCommandRouter::volumioGetVisibleSources Apr 10 14:24:07 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 10 14:24:07 volumio volumio[885]: info: CoreCommandRouter::volumioGetState Apr 10 14:24:07 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:24:08 volumio volumio[885]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 10 14:24:08 volumio volumio[885]: info: Updating MyVolumio device info Apr 10 14:24:08 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 14:24:09 volumio volumio[885]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 10 14:24:09 volumio volumio[885]: verbose: New Socket.io Connection to localhost: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: 8 Apr 10 14:24:09 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 10 14:24:09 volumio volumio[885]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Apr 10 14:24:09 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Apr 10 14:24:09 volumio volumio[885]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Apr 10 14:24:09 volumio volumio[885]: info: Listing playlists Apr 10 14:24:09 volumio volumio[885]: info: CoreCommandRouter::volumioGetQueue Apr 10 14:24:09 volumio volumio[885]: info: CoreStateMachine::getQueue Apr 10 14:24:09 volumio volumio[885]: info: CorePlayQueue::getQueue Apr 10 14:24:09 volumio volumio[885]: info: CoreCommandRouter::volumioGetVisibleSources Apr 10 14:24:09 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 10 14:24:09 volumio volumio[885]: info: CoreCommandRouter::volumioGetState Apr 10 14:24:09 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:24:09 volumio volumio[885]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Apr 10 14:24:09 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Apr 10 14:24:09 volumio volumio[885]: info: Listing playlists Apr 10 14:24:09 volumio volumio[885]: info: CoreCommandRouter::volumioGetQueue Apr 10 14:24:09 volumio volumio[885]: info: CoreStateMachine::getQueue Apr 10 14:24:09 volumio volumio[885]: info: CorePlayQueue::getQueue Apr 10 14:24:09 volumio volumio[885]: info: CoreCommandRouter::volumioGetVisibleSources Apr 10 14:24:09 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 10 14:24:09 volumio volumio[885]: info: CoreCommandRouter::volumioGetState Apr 10 14:24:09 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:24:09 volumio volumio[885]: info: CoreCommandRouter::volumioGetState Apr 10 14:24:09 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:24:10 volumio sudo[1524]: pam_unix(sudo:session): session closed for user root Apr 10 14:24:10 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Apr 10 14:24:10 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Apr 10 14:24:10 volumio volumio[885]: info: Cannot mount NAS Music at system boot, trial number 4 ,retrying in 5 seconds Apr 10 14:24:14 volumio ntpd[816]: Soliciting pool server 192.36.143.130 Apr 10 14:24:14 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 14:24:14 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 14:24:14 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 10 14:24:14 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 10 14:24:14 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 10 14:24:14 volumio volumio[885]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 14:24:14 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 10 14:24:15 volumio ntpd[816]: Soliciting pool server 89.109.251.23 Apr 10 14:24:15 volumio sudo[1783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=vvl,password=FuximoRik@2020,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.249/Music2 /mnt/NAS/Music Apr 10 14:24:15 volumio sudo[1783]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 14:24:15 volumio kernel: CIFS: Attempting to mount //192.168.1.249/Music2 Apr 10 14:24:15 volumio ntpd[816]: Soliciting pool server 188.225.9.167 Apr 10 14:24:15 volumio ntpd[816]: Soliciting pool server 91.188.214.68 Apr 10 14:24:16 volumio ntpd[816]: Soliciting pool server 93.77.190.179 Apr 10 14:24:16 volumio ntpd[816]: Soliciting pool server 85.142.100.8 Apr 10 14:24:16 volumio ntpd[816]: Soliciting pool server 91.224.234.189 Apr 10 14:24:17 volumio ntpd[816]: Soliciting pool server 109.195.84.246 Apr 10 14:24:17 volumio volumio[885]: error: MyVolumio Plugin failed to authenticate in a timely fashion Apr 10 14:24:17 volumio volumio[885]: info: Completed starting MyVolumio Plugin Apr 10 14:24:17 volumio volumio[885]: [Metrics] CommandRouter: 61s 651.92ms Apr 10 14:24:17 volumio volumio[885]: info: CoreCommandRouter::volumiosetStartupVolume Apr 10 14:24:17 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 14:24:17 volumio volumio[885]: info: VolumeController:: Setting startup Volume 100 Apr 10 14:24:17 volumio volumio[885]: info: VolumeController::SetAlsaVolume100 Apr 10 14:24:17 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 14:24:17 volumio volumio[885]: info: CoreCommandRouter::Close All Modals sent Apr 10 14:24:17 volumio volumio[885]: info: CoreCommandRouter::Close All Modals sent Apr 10 14:24:17 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:24:17 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:24:17 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:24:17 volumio ntpd[816]: Soliciting pool server 79.120.8.135 Apr 10 14:24:17 volumio ntpd[816]: Soliciting pool server 87.103.245.205 Apr 10 14:24:18 volumio ntpd[816]: Soliciting pool server 51.250.53.172 Apr 10 14:24:18 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 10 14:24:18 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 10 14:24:18 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 10 14:24:19 volumio ntpd[816]: Soliciting pool server 93.95.100.104 Apr 10 14:24:19 volumio ntpd[816]: Soliciting pool server 2a00:b700:3::288 Apr 10 14:24:21 volumio sudo[1783]: pam_unix(sudo:session): session closed for user root Apr 10 14:24:21 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Apr 10 14:24:21 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Apr 10 14:24:21 volumio volumio[885]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Apr 10 14:24:23 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 14:24:23 volumio volumio[885]: info: CURURI: music-library Apr 10 14:24:23 volumio volumio[885]: error: Failed LSINFO: null Apr 10 14:24:26 volumio volumio[885]: info: BOOT COMPLETED Apr 10 14:24:31 volumio volumio[885]: info: CoreCommandRouter::volumioToggle Apr 10 14:24:31 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:24:31 volumio volumio[885]: info: CoreStateMachine::play index undefined Apr 10 14:24:31 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 14:24:31 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:24:37 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 14:24:37 volumio volumio[885]: info: CURURI: artists:// Apr 10 14:25:07 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 14:25:07 volumio volumio[885]: info: CURURI: music-library Apr 10 14:25:07 volumio volumio[885]: error: Failed LSINFO: null Apr 10 14:25:07 volumio volumio[885]: info: Preload queue cleared Apr 10 14:25:10 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 14:25:10 volumio volumio[885]: info: CURURI: artists:// Apr 10 14:25:10 volumio volumio[885]: info: Preload queue cleared Apr 10 14:25:16 volumio volumio[885]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 14:25:16 volumio volumio[885]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 14:25:16 volumio volumio[885]: info: Retrieving Cloud Streaming UI Apr 10 14:25:16 volumio volumio[885]: info: Getting Tidal Cloud Configuration Apr 10 14:25:16 volumio volumio[885]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 14:25:16 volumio volumio[885]: info: Getting Qobuz Cloud Configuration Apr 10 14:25:16 volumio volumio[885]: info: Asking plugin for UI Config Apr 10 14:25:16 volumio volumio[885]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 14:25:16 volumio volumio[885]: info: Getting Spotify Cloud Configuration Apr 10 14:25:16 volumio volumio[885]: info: Asking plugin for UI Config Apr 10 14:25:16 volumio volumio[885]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 14:25:16 volumio volumio[885]: info: Saving Spotify Acccount Apr 10 14:25:16 volumio volumio[885]: info: Got Tidal Cloud Configuration Apr 10 14:25:16 volumio volumio[885]: info: Got it Apr 10 14:25:16 volumio volumio[885]: info: Got it Apr 10 14:25:16 volumio volumio[885]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 14:25:17 volumio volumio[885]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 14:25:17 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 10 14:25:21 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 14:25:25 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 14:25:29 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Apr 10 14:25:30 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand rescan Apr 10 14:25:30 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:30 volumio volumio[885]: info: Apr 10 14:25:30 volumio volumio[885]: ---------------------------- MPD announces state update: update Apr 10 14:25:30 volumio volumio[885]: info: sendMpdCommand rescan took 17 milliseconds Apr 10 14:25:30 volumio volumio[885]: info: ControllerMpd::getState Apr 10 14:25:30 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:30 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:30 volumio volumio[885]: info: Apr 10 14:25:30 volumio volumio[885]: ---------------------------- MPD announces state update: update Apr 10 14:25:30 volumio volumio[885]: info: ControllerMpd::getState Apr 10 14:25:30 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:30 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:30 volumio volumio[885]: info: Apr 10 14:25:30 volumio volumio[885]: ---------------------------- MPD announces state update: update Apr 10 14:25:30 volumio volumio[885]: info: ControllerMpd::getState Apr 10 14:25:30 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:30 volumio volumio[885]: info: sendMpdCommand status took 52 milliseconds Apr 10 14:25:30 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:30 volumio volumio[885]: info: Command Router : Notfying DB Updatetrue Apr 10 14:25:30 volumio volumio[885]: info: sendMpdCommand status took 252 milliseconds Apr 10 14:25:30 volumio volumio[885]: info: sendMpdCommand status took 249 milliseconds Apr 10 14:25:30 volumio volumio[885]: info: sendMpdCommand status took 245 milliseconds Apr 10 14:25:30 volumio volumio[885]: info: sendMpdCommand status took 242 milliseconds Apr 10 14:25:30 volumio volumio[885]: info: sendMpdCommand status took 238 milliseconds Apr 10 14:25:30 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:30 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:30 volumio volumio[885]: info: Command Router : Notfying DB Updatetrue Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::Close All Modals sent Apr 10 14:25:30 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:30 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:30 volumio volumio[885]: info: Command Router : Notfying DB Updatetrue Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::Close All Modals sent Apr 10 14:25:30 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:30 volumio volumio[885]: info: ControllerMpd::pushState Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::servicePushState Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:30 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:30 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:30 volumio volumio[885]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 10 14:25:30 volumio volumio[885]: verbose: CURRENT POSITION 0 Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:30 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:30 volumio volumio[885]: info: No code Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:30 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:30 volumio volumio[885]: info: ControllerMpd::pushState Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::servicePushState Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:30 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:30 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:30 volumio volumio[885]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 10 14:25:30 volumio volumio[885]: verbose: CURRENT POSITION 0 Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:30 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:30 volumio volumio[885]: info: No code Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:30 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:30 volumio volumio[885]: info: ControllerMpd::pushState Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::servicePushState Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:30 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:30 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:30 volumio volumio[885]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 10 14:25:30 volumio volumio[885]: verbose: CURRENT POSITION 0 Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:30 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:30 volumio volumio[885]: info: No code Apr 10 14:25:30 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:30 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:30 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:30 volumio volumio[885]: info: ------------------------------ 628ms Apr 10 14:25:30 volumio volumio[885]: info: ------------------------------ 810ms Apr 10 14:25:30 volumio volumio[885]: info: ------------------------------ 806ms Apr 10 14:25:33 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 14:25:37 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 14:25:41 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 14:25:45 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 14:25:49 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 14:25:49 volumio volumio[885]: info: MPD Database updated - AlbumList cache refreshed Apr 10 14:25:49 volumio volumio[885]: info: Apr 10 14:25:49 volumio volumio[885]: ---------------------------- MPD announces state update: database Apr 10 14:25:49 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:49 volumio volumio[885]: info: Apr 10 14:25:49 volumio volumio[885]: ---------------------------- MPD announces state update: update Apr 10 14:25:49 volumio volumio[885]: info: ControllerMpd::getState Apr 10 14:25:49 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:49 volumio volumio[885]: info: ControllerMpd::getState Apr 10 14:25:49 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:49 volumio volumio[885]: info: MPD Database updated - AlbumList cache refreshed Apr 10 14:25:49 volumio volumio[885]: info: Apr 10 14:25:49 volumio volumio[885]: ---------------------------- MPD announces state update: database Apr 10 14:25:49 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:49 volumio volumio[885]: info: Apr 10 14:25:49 volumio volumio[885]: ---------------------------- MPD announces state update: update Apr 10 14:25:49 volumio volumio[885]: info: ControllerMpd::getState Apr 10 14:25:49 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:49 volumio volumio[885]: info: ControllerMpd::getState Apr 10 14:25:49 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:49 volumio volumio[885]: info: MPD Database updated - AlbumList cache refreshed Apr 10 14:25:49 volumio volumio[885]: info: Apr 10 14:25:49 volumio volumio[885]: ---------------------------- MPD announces state update: database Apr 10 14:25:49 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:49 volumio volumio[885]: info: Apr 10 14:25:49 volumio volumio[885]: ---------------------------- MPD announces state update: update Apr 10 14:25:49 volumio volumio[885]: info: ControllerMpd::getState Apr 10 14:25:49 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:49 volumio volumio[885]: info: ControllerMpd::getState Apr 10 14:25:49 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status Apr 10 14:25:50 volumio volumio[885]: info: sendMpdCommand status took 193 milliseconds Apr 10 14:25:50 volumio volumio[885]: info: sendMpdCommand status took 190 milliseconds Apr 10 14:25:50 volumio volumio[885]: info: sendMpdCommand status took 189 milliseconds Apr 10 14:25:50 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:50 volumio volumio[885]: info: Command Router : Notfying DB Updatefalse Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::Close All Modals sent Apr 10 14:25:50 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:50 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:50 volumio volumio[885]: info: ControllerMpd::pushState Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::servicePushState Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 10 14:25:50 volumio volumio[885]: verbose: CURRENT POSITION 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:50 volumio volumio[885]: info: No code Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:50 volumio volumio[885]: info: ControllerMpd::pushState Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::servicePushState Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 10 14:25:50 volumio volumio[885]: verbose: CURRENT POSITION 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:50 volumio volumio[885]: info: No code Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:50 volumio volumio[885]: info: ------------------------------ 506ms Apr 10 14:25:50 volumio volumio[885]: info: ------------------------------ 508ms Apr 10 14:25:50 volumio volumio[885]: info: sendMpdCommand status took 605 milliseconds Apr 10 14:25:50 volumio volumio[885]: info: sendMpdCommand status took 603 milliseconds Apr 10 14:25:50 volumio volumio[885]: info: sendMpdCommand status took 601 milliseconds Apr 10 14:25:50 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:50 volumio volumio[885]: info: Command Router : Notfying DB Updatefalse Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::Close All Modals sent Apr 10 14:25:50 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:50 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:50 volumio volumio[885]: info: ControllerMpd::pushState Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::servicePushState Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 10 14:25:50 volumio volumio[885]: verbose: CURRENT POSITION 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:50 volumio volumio[885]: info: No code Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:50 volumio volumio[885]: info: ControllerMpd::pushState Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::servicePushState Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 10 14:25:50 volumio volumio[885]: verbose: CURRENT POSITION 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:50 volumio volumio[885]: info: No code Apr 10 14:25:50 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:50 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:50 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:50 volumio volumio[885]: info: ------------------------------ 877ms Apr 10 14:25:50 volumio volumio[885]: info: ------------------------------ 881ms Apr 10 14:25:50 volumio volumio[885]: info: sendMpdCommand status took 971 milliseconds Apr 10 14:25:50 volumio volumio[885]: info: sendMpdCommand status took 968 milliseconds Apr 10 14:25:50 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:51 volumio volumio[885]: info: Command Router : Notfying DB Updatefalse Apr 10 14:25:51 volumio volumio[885]: info: CoreCommandRouter::Close All Modals sent Apr 10 14:25:51 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:51 volumio volumio[885]: verbose: ControllerMpd::parseState Apr 10 14:25:52 volumio volumio[885]: info: ControllerMpd::pushState Apr 10 14:25:52 volumio volumio[885]: info: CoreCommandRouter::servicePushState Apr 10 14:25:52 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:52 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:52 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:52 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:52 volumio volumio[885]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 10 14:25:52 volumio volumio[885]: verbose: CURRENT POSITION 0 Apr 10 14:25:52 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop Apr 10 14:25:52 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop Apr 10 14:25:52 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:52 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:52 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:52 volumio volumio[885]: info: No code Apr 10 14:25:52 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:52 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:52 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:52 volumio volumio[885]: info: ControllerMpd::pushState Apr 10 14:25:52 volumio volumio[885]: info: CoreCommandRouter::servicePushState Apr 10 14:25:52 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:52 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:52 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:52 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:52 volumio volumio[885]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 10 14:25:52 volumio volumio[885]: verbose: CURRENT POSITION 0 Apr 10 14:25:52 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop Apr 10 14:25:52 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop Apr 10 14:25:52 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:52 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:52 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:52 volumio volumio[885]: info: No code Apr 10 14:25:52 volumio volumio[885]: info: CoreStateMachine::pushState Apr 10 14:25:52 volumio volumio[885]: info: CorePlayQueue::getTrack 0 Apr 10 14:25:52 volumio volumio[885]: info: CoreCommandRouter::volumioPushState Apr 10 14:25:52 volumio volumio[885]: info: ------------------------------ 2249ms Apr 10 14:25:52 volumio volumio[885]: info: ------------------------------ 2260ms Apr 10 14:25:55 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 14:25:55 volumio volumio[885]: info: CURURI: artists:// Apr 10 14:25:55 volumio volumio[885]: info: Preload queue cleared Apr 10 14:25:57 volumio volumio[885]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 14:25:57 volumio volumio[885]: Error: connect ECONNREFUSED 158.69.210.98:443 Apr 10 14:25:57 volumio volumio[885]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Apr 10 14:25:57 volumio volumio[885]: errno: -111, Apr 10 14:25:57 volumio volumio[885]: code: 'ECONNREFUSED', Apr 10 14:25:57 volumio volumio[885]: syscall: 'connect', Apr 10 14:25:57 volumio volumio[885]: address: '158.69.210.98', Apr 10 14:25:57 volumio volumio[885]: port: 443 Apr 10 14:25:57 volumio volumio[885]: } Apr 10 14:25:57 volumio volumio[885]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 14:25:59 volumio sudo[2002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-10 14:24 Apr 10 14:25:59 volumio sudo[2002]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"