-- Logs begin at Mon 2026-03-30 20:18:43 CST, end at Fri 2026-04-10 22:02:53 CST. -- Apr 10 22:01:00 volumio volumio[938]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 10 22:01:00 volumio volumio[938]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 10 22:01:00 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:01:00 volumio volumio[938]: info: Starting MyVolumio Remote Streaming Endpoints Apr 10 22:01:00 volumio volumio[938]: info: MyVolumio not started Apr 10 22:01:00 volumio volumio[938]: info: Initializing device activation check Apr 10 22:01:00 volumio volumio[938]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 10 22:01:00 volumio volumio[938]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 10 22:01:06 volumio ntpd[560]: Soliciting pool server 210.28.130.4 Apr 10 22:01:06 volumio ntpd[560]: Soliciting pool server 193.182.111.142 Apr 10 22:01:06 volumio volumio[938]: info: Starting Streaming Service Transparent Proxy Apr 10 22:01:07 volumio volumio[938]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 10 22:01:07 volumio volumio[938]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 10 22:01:07 volumio volumio[938]: info: Streaming services startup Apr 10 22:01:07 volumio volumio[938]: info: Starting Streaming Daemon Apr 10 22:01:07 volumio ntpd[560]: Soliciting pool server 119.28.206.193 Apr 10 22:01:07 volumio volumio[938]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 10 22:01:07 volumio sudo[1451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 10 22:01:07 volumio sudo[1451]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 22:01:07 volumio sudo[1451]: pam_unix(sudo:session): session closed for user root Apr 10 22:01:07 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 10 22:01:07 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:01:07 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 10 22:01:08 volumio volumio5-onboarding[1283]: time=2026-04-10T22:01:08.122+08:00 level=ERROR msg="failed reading message" error="websocket: close 1000 (normal)" Apr 10 22:01:08 volumio ntpd[560]: Soliciting pool server 84.16.73.33 Apr 10 22:01:08 volumio volumio[938]: error: Cannot start Volumio Streaming Daemon Apr 10 22:01:08 volumio volumio[938]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 10 22:01:08 volumio volumio[938]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 10 22:01:09 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Apr 10 22:01:09 volumio volumio[938]: verbose: New Socket.io Connection to 192.168.1.2 from 192.168.1.163 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 3 Apr 10 22:01:09 volumio volumio[938]: Upnp client error: Error: This socket has been ended by the other party Apr 10 22:01:09 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Apr 10 22:01:10 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Apr 10 22:01:10 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Apr 10 22:01:10 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Apr 10 22:01:10 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Apr 10 22:01:10 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Apr 10 22:01:10 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Apr 10 22:01:11 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Apr 10 22:01:11 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Apr 10 22:01:11 volumio volumio[938]: verbose: New Socket.io Connection to 192.168.1.2 from 192.168.1.163 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 5 Apr 10 22:01:11 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:11 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 10 22:01:12 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:12 volumio volumio[938]: info: CoreCommandRouter::volumioGetVisibleSources Apr 10 22:01:12 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 10 22:01:12 volumio volumio[938]: info: CoreCommandRouter::volumioGetState Apr 10 22:01:12 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:01:12 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 10 22:01:12 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 10 22:01:12 volumio volumio[938]: info: Received Get System Info Apr 10 22:01:12 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 10 22:01:12 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 10 22:01:12 volumio volumio[938]: info: Discovery: Getting this device information Apr 10 22:01:12 volumio volumio[938]: info: CoreCommandRouter::volumioGetState Apr 10 22:01:12 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:01:12 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 10 22:01:12 volumio volumio[938]: info: CoreCommandRouter::volumioGetState Apr 10 22:01:12 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:01:12 volumio volumio[938]: info: Listing playlists Apr 10 22:01:12 volumio volumio[938]: info: CoreCommandRouter::volumioGetQueue Apr 10 22:01:12 volumio volumio[938]: info: CoreStateMachine::getQueue Apr 10 22:01:12 volumio volumio[938]: info: CorePlayQueue::getQueue Apr 10 22:01:13 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 10 22:01:13 volumio volumio-remote-updater[533]: No test mode Apr 10 22:01:13 volumio volumio-remote-updater[533]: No alpha test mode Apr 10 22:01:13 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 10 22:01:13 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:13 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:14 volumio volumio[938]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 10 22:01:14 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 10 22:01:14 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:14 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:14 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:14 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:14 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:15 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:15 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:15 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 10 22:01:15 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:15 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 10 22:01:15 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:15 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:15 volumio volumio[938]: info: CoreCommandRouter::volumioGetState Apr 10 22:01:15 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:01:15 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:16 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:16 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:16 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:16 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:16 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:17 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:17 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:17 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:17 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:17 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:17 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:17 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:17 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:18 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:18 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:18 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:18 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:18 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:18 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:18 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:18 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:18 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:19 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:19 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:19 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:19 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:19 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:19 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:19 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:19 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:19 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:19 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:19 volumio volumio[938]: STREAMING PROXY: Starting server on port 3245 Apr 10 22:01:20 volumio volumio[938]: Node JS runtime: 14 Apr 10 22:01:20 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:20 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:20 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:01:20 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:01:20 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 10 22:01:20 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 10 22:01:20 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 10 22:01:20 volumio volumio[938]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 22:01:20 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 10 22:01:20 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:20 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:20 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:20 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:20 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:20 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:20 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:20 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:20 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:21 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:22 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:23 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:24 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:24 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:24 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:25 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:26 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:27 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:27 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:27 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:27 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:27 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:27 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:27 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:27 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:27 volumio volumio[938]: error: MyVolumio Plugin failed to authenticate in a timely fashion Apr 10 22:01:27 volumio volumio[938]: info: Completed starting MyVolumio Plugin Apr 10 22:01:27 volumio volumio[938]: [Metrics] CommandRouter: 102s 628.99ms Apr 10 22:01:27 volumio volumio[938]: info: CoreCommandRouter::volumiosetStartupVolume Apr 10 22:01:27 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 10 22:01:27 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 10 22:01:27 volumio volumio[938]: info: CoreCommandRouter::Close All Modals sent Apr 10 22:01:27 volumio volumio[938]: info: CoreCommandRouter::Close All Modals sent Apr 10 22:01:27 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:27 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:27 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:28 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:28 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:28 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:28 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:28 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:28 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 10 22:01:28 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 10 22:01:28 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 10 22:01:28 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:28 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:28 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:29 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:29 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:29 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:29 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:29 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:29 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:29 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:29 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:29 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:29 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:30 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:30 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:30 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:30 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:30 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:30 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:30 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:30 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:31 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:31 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:31 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:31 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:31 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:31 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:31 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:31 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:31 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:31 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:32 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:32 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:32 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:32 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:32 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:32 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:32 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:32 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:32 volumio volumio[1262]: Generating RSA private key, 4096 bit long modulus (2 primes) Apr 10 22:01:32 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:32 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:32 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:32 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:32 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:33 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:33 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:33 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:33 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:33 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:33 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:33 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:33 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:33 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:33 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:34 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:34 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:34 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:34 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:34 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:34 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:34 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:34 volumio volumio[938]: info: BOOT COMPLETED Apr 10 22:01:34 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:34 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:34 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:35 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:35 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:35 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:35 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:35 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:35 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:35 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:35 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:35 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:35 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:36 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:36 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:36 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:36 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:36 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:36 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:36 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:36 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:36 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:36 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:37 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:37 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:37 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:37 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:37 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:37 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:37 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:37 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:37 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:37 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:38 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:38 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:38 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:38 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:38 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:38 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:38 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:38 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:38 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:38 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:39 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Apr 10 22:01:39 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:39 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:39 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:39 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:39 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:39 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:39 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:39 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:39 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:40 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:40 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:40 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:40 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:40 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:40 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:40 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:41 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:41 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:41 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:41 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:41 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:41 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:41 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:42 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:42 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:42 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:42 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:42 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:42 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:42 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:43 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:43 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:43 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:43 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:43 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:43 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:43 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:43 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:44 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:44 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:44 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:44 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:44 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:44 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:45 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:45 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:45 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:45 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:45 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:45 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:45 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:45 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:45 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:45 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:46 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:46 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:46 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:46 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:46 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:46 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:46 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:46 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:46 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:46 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:47 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:47 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:47 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:47 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:47 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:47 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:47 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:47 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:47 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:47 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:47 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:48 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:48 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:48 volumio volumio[938]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Apr 10 22:01:57 volumio volumio[1262]: .........................................................++++ Apr 10 22:01:57 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 10 22:01:57 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 10 22:01:57 volumio volumio[938]: info: Discovery: Getting this device information Apr 10 22:01:57 volumio volumio[938]: info: CoreCommandRouter::volumioGetState Apr 10 22:01:57 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:01:57 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 10 22:02:02 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 22:02:02 volumio volumio[938]: info: CURURI: music-library Apr 10 22:02:02 volumio volumio[938]: error: Failed LSINFO: null Apr 10 22:02:02 volumio volumio[938]: info: Preload queue cleared Apr 10 22:02:11 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 10 22:02:11 volumio volumio[938]: info: Preload queue cleared Apr 10 22:02:13 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 10 22:02:18 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 10 22:02:21 volumio volumio[938]: info: Preload queue cleared Apr 10 22:02:21 volumio volumio[938]: info: Preload queue cleared Apr 10 22:02:25 volumio volumio[938]: info: Preload queue cleared Apr 10 22:02:25 volumio volumio[938]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 10 22:02:25 volumio volumio[938]: info: CoreStateMachine::ClearQueue Apr 10 22:02:25 volumio volumio[938]: info: CoreStateMachine::stop Apr 10 22:02:25 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:25 volumio volumio[938]: info: CorePlayQueue::clearPlayQueue Apr 10 22:02:25 volumio volumio[938]: info: CorePlayQueue::saveQueue Apr 10 22:02:25 volumio volumio[938]: info: CoreCommandRouter::volumioPushQueue Apr 10 22:02:25 volumio volumio[938]: info: CoreStateMachine::addQueueItems Apr 10 22:02:25 volumio volumio[938]: info: CorePlayQueue::addQueueItems Apr 10 22:02:25 volumio volumio[938]: info: Preload queue cleared Apr 10 22:02:25 volumio volumio[938]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996 Apr 10 22:02:25 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 10 22:02:25 volumio volumio[938]: info: CoreCommandRouter::volumioPushQueue Apr 10 22:02:25 volumio volumio[938]: info: CorePlayQueue::saveQueue Apr 10 22:02:25 volumio volumio[938]: info: CoreStateMachine::updateTrackBlock Apr 10 22:02:25 volumio volumio[938]: info: CorePlayQueue::getTrackBlock Apr 10 22:02:25 volumio volumio[938]: info: CoreCommandRouter::volumioPlay Apr 10 22:02:25 volumio volumio[938]: info: CoreStateMachine::play index 0 Apr 10 22:02:25 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:25 volumio volumio[938]: info: CoreStateMachine::stop Apr 10 22:02:25 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:25 volumio volumio[938]: info: CoreStateMachine::play index undefined Apr 10 22:02:25 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:25 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:25 volumio volumio[938]: info: CoreStateMachine::startPlaybackTimer Apr 10 22:02:25 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:25 volumio volumio[938]: info: [1775829745423] ControllerWebradio::clearAddPlayTrack Apr 10 22:02:25 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 22:02:25 volumio volumio[938]: info: sendMpdCommand stop took 80 milliseconds Apr 10 22:02:25 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand clear Apr 10 22:02:25 volumio volumio[938]: info: Apr 10 22:02:25 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:25 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:25 volumio volumio[938]: info: sendMpdCommand clear took 28 milliseconds Apr 10 22:02:25 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Apr 10 22:02:25 volumio volumio[938]: info: Apr 10 22:02:25 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:25 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:25 volumio volumio[938]: info: Apr 10 22:02:25 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:25 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:26 volumio volumio[938]: info: Preload queue cleared Apr 10 22:02:26 volumio volumio[938]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 10 22:02:26 volumio volumio[938]: info: CoreStateMachine::ClearQueue Apr 10 22:02:26 volumio volumio[938]: info: CoreStateMachine::stop Apr 10 22:02:26 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:26 volumio volumio[938]: info: CorePlayQueue::clearPlayQueue Apr 10 22:02:26 volumio volumio[938]: info: CorePlayQueue::saveQueue Apr 10 22:02:26 volumio volumio[938]: info: CoreCommandRouter::volumioPushQueue Apr 10 22:02:26 volumio volumio[938]: info: CoreStateMachine::addQueueItems Apr 10 22:02:26 volumio volumio[938]: info: CorePlayQueue::addQueueItems Apr 10 22:02:26 volumio volumio[938]: info: Preload queue cleared Apr 10 22:02:26 volumio volumio[938]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996 Apr 10 22:02:26 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 10 22:02:26 volumio volumio[938]: info: CoreCommandRouter::volumioPushQueue Apr 10 22:02:26 volumio volumio[938]: info: CorePlayQueue::saveQueue Apr 10 22:02:26 volumio volumio[938]: info: CoreStateMachine::updateTrackBlock Apr 10 22:02:26 volumio volumio[938]: info: CorePlayQueue::getTrackBlock Apr 10 22:02:26 volumio volumio[938]: info: CoreCommandRouter::volumioPlay Apr 10 22:02:26 volumio volumio[938]: info: CoreStateMachine::play index 0 Apr 10 22:02:26 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:26 volumio volumio[938]: info: CoreStateMachine::stop Apr 10 22:02:26 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:26 volumio volumio[938]: info: CoreStateMachine::play index undefined Apr 10 22:02:26 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:26 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:26 volumio volumio[938]: info: CoreStateMachine::startPlaybackTimer Apr 10 22:02:26 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:26 volumio volumio[938]: info: [1775829746268] ControllerWebradio::clearAddPlayTrack Apr 10 22:02:26 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 22:02:27 volumio volumio[938]: error: updateQueue error: null Apr 10 22:02:27 volumio volumio[938]: info: Apr 10 22:02:27 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:27 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:27 volumio volumio[938]: info: ------------------------------ 1691ms Apr 10 22:02:27 volumio volumio[938]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 1676 milliseconds Apr 10 22:02:27 volumio volumio[938]: info: ------------------------------ 1642ms Apr 10 22:02:27 volumio volumio[938]: info: ------------------------------ 1637ms Apr 10 22:02:27 volumio volumio[938]: info: sendMpdCommand stop took 965 milliseconds Apr 10 22:02:27 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 10 22:02:27 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand play Apr 10 22:02:27 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand clear Apr 10 22:02:27 volumio volumio[938]: info: Apr 10 22:02:27 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:27 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:27 volumio volumio[938]: info: Apr 10 22:02:27 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:27 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:27 volumio volumio[938]: info: ------------------------------ 116ms Apr 10 22:02:27 volumio volumio[938]: info: Apr 10 22:02:27 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:27 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:27 volumio volumio[938]: info: Apr 10 22:02:27 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:27 volumio volumio[938]: error: updateQueue error: null Apr 10 22:02:27 volumio volumio[938]: info: sendMpdCommand play took 556 milliseconds Apr 10 22:02:27 volumio volumio[938]: info: sendMpdCommand clear took 534 milliseconds Apr 10 22:02:27 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:27 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:27 volumio volumio[938]: info: ------------------------------ 533ms Apr 10 22:02:27 volumio volumio[938]: info: ------------------------------ 529ms Apr 10 22:02:27 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Apr 10 22:02:27 volumio volumio[938]: info: Apr 10 22:02:27 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:27 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:27 volumio volumio[938]: info: Apr 10 22:02:27 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:27 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:27 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:27 volumio volumio[938]: info: Apr 10 22:02:27 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:27 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:27 volumio volumio[938]: info: Apr 10 22:02:27 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:27 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:27 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:28 volumio volumio[938]: error: updateQueue error: null Apr 10 22:02:28 volumio volumio[938]: info: Apr 10 22:02:28 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:28 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:28 volumio volumio[938]: info: ------------------------------ 450ms Apr 10 22:02:28 volumio volumio[938]: info: sendMpdCommand status took 427 milliseconds Apr 10 22:02:28 volumio volumio[938]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 436 milliseconds Apr 10 22:02:28 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 10 22:02:28 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand play Apr 10 22:02:28 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:28 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:28 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:28 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:28 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:28 volumio volumio[938]: 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 22:02:28 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::syncState stateService stop Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus stop Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:28 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:28 volumio volumio[938]: info: No code Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:28 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:28 volumio volumio5-onboarding[1283]: time=2026-04-10T22:02:28.682+08:00 level=WARN msg="received unknown player status" component=volumio status="" Apr 10 22:02:28 volumio volumio5-onboarding[1283]: time=2026-04-10T22:02:28.690+08:00 level=WARN msg="received unknown player status" component=volumio status="" Apr 10 22:02:28 volumio volumio5-onboarding[1283]: time=2026-04-10T22:02:28.712+08:00 level=WARN msg="received unknown player status" component=volumio status="" Apr 10 22:02:28 volumio volumio[938]: info: ------------------------------ 927ms Apr 10 22:02:28 volumio volumio[938]: info: ------------------------------ 917ms Apr 10 22:02:28 volumio volumio[938]: info: sendMpdCommand status took 899 milliseconds Apr 10 22:02:28 volumio volumio[938]: info: ------------------------------ 898ms Apr 10 22:02:28 volumio volumio[938]: info: sendMpdCommand status took 875 milliseconds Apr 10 22:02:28 volumio volumio[938]: info: ------------------------------ 532ms Apr 10 22:02:28 volumio volumio[938]: info: sendMpdCommand play took 485 milliseconds Apr 10 22:02:28 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:28 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:28 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:28 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:28 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:28 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:28 volumio volumio[938]: 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 22:02:28 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::syncState stateService stop Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus stop Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:28 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:28 volumio volumio[938]: info: No code Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:28 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:28 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:28 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:28 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:28 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:28 volumio volumio[938]: 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 22:02:28 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::syncState stateService stop Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus stop Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:28 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:28 volumio volumio[938]: info: No code Apr 10 22:02:28 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:29 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:29 volumio volumio5-onboarding[1283]: time=2026-04-10T22:02:29.441+08:00 level=WARN msg="received unknown player status" component=volumio status="" Apr 10 22:02:29 volumio volumio5-onboarding[1283]: time=2026-04-10T22:02:29.456+08:00 level=WARN msg="received unknown player status" component=volumio status="" Apr 10 22:02:29 volumio volumio5-onboarding[1283]: time=2026-04-10T22:02:29.482+08:00 level=WARN msg="received unknown player status" component=volumio status="" Apr 10 22:02:29 volumio volumio5-onboarding[1283]: time=2026-04-10T22:02:29.492+08:00 level=WARN msg="received unknown player status" component=volumio status="" Apr 10 22:02:29 volumio volumio5-onboarding[1283]: time=2026-04-10T22:02:29.505+08:00 level=WARN msg="received unknown player status" component=volumio status="" Apr 10 22:02:29 volumio volumio5-onboarding[1283]: time=2026-04-10T22:02:29.532+08:00 level=WARN msg="received unknown player status" component=volumio status="" Apr 10 22:02:29 volumio volumio[938]: info: ------------------------------ 1696ms Apr 10 22:02:29 volumio volumio[938]: info: ------------------------------ 1680ms Apr 10 22:02:29 volumio volumio[938]: info: Apr 10 22:02:29 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:29 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:29 volumio volumio[938]: info: Apr 10 22:02:29 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:29 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:29 volumio volumio[938]: info: ------------------------------ 206ms Apr 10 22:02:29 volumio volumio[938]: info: ------------------------------ 194ms Apr 10 22:02:29 volumio volumio[938]: info: Preload queue cleared Apr 10 22:02:29 volumio volumio[938]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 10 22:02:29 volumio volumio[938]: info: CoreStateMachine::ClearQueue Apr 10 22:02:29 volumio volumio[938]: info: CoreStateMachine::stop Apr 10 22:02:29 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:29 volumio volumio[938]: info: CorePlayQueue::clearPlayQueue Apr 10 22:02:29 volumio volumio[938]: info: CorePlayQueue::saveQueue Apr 10 22:02:29 volumio volumio[938]: info: CoreCommandRouter::volumioPushQueue Apr 10 22:02:29 volumio volumio[938]: info: CoreStateMachine::addQueueItems Apr 10 22:02:29 volumio volumio[938]: info: CorePlayQueue::addQueueItems Apr 10 22:02:29 volumio volumio[938]: info: Preload queue cleared Apr 10 22:02:29 volumio volumio[938]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996 Apr 10 22:02:29 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 10 22:02:29 volumio volumio[938]: info: CoreCommandRouter::volumioPushQueue Apr 10 22:02:29 volumio volumio[938]: info: CorePlayQueue::saveQueue Apr 10 22:02:29 volumio volumio[938]: info: CoreStateMachine::updateTrackBlock Apr 10 22:02:29 volumio volumio[938]: info: CorePlayQueue::getTrackBlock Apr 10 22:02:29 volumio volumio[938]: info: CoreCommandRouter::volumioPlay Apr 10 22:02:29 volumio volumio[938]: info: CoreStateMachine::play index 0 Apr 10 22:02:29 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:30 volumio volumio[938]: info: CoreStateMachine::stop Apr 10 22:02:30 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:30 volumio volumio[938]: info: CoreStateMachine::play index undefined Apr 10 22:02:30 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:30 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:30 volumio volumio[938]: info: CoreStateMachine::startPlaybackTimer Apr 10 22:02:30 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:30 volumio volumio[938]: info: [1775829750000] ControllerWebradio::clearAddPlayTrack Apr 10 22:02:30 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 22:02:30 volumio volumio[938]: info: Apr 10 22:02:30 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:30 volumio volumio[938]: info: sendMpdCommand stop took 336 milliseconds Apr 10 22:02:30 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:30 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:30 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand clear Apr 10 22:02:30 volumio volumio[938]: info: Apr 10 22:02:30 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:30 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:30 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:30 volumio volumio[938]: info: Apr 10 22:02:30 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:30 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:30 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:30 volumio volumio[938]: info: Apr 10 22:02:30 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:30 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:30 volumio volumio[938]: info: sendMpdCommand status took 53 milliseconds Apr 10 22:02:30 volumio volumio[938]: info: sendMpdCommand clear took 53 milliseconds Apr 10 22:02:30 volumio volumio[938]: info: sendMpdCommand status took 34 milliseconds Apr 10 22:02:30 volumio volumio[938]: info: sendMpdCommand status took 29 milliseconds Apr 10 22:02:30 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:30 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:30 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Apr 10 22:02:30 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:30 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:30 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:30 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:30 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:30 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:30 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:30 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:30 volumio volumio[938]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 10 22:02:30 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:30 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:30 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:30 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:30 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:30 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:30 volumio volumio[938]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 10 22:02:30 volumio volumio[938]: info: ------------------------------ 404ms Apr 10 22:02:30 volumio volumio[938]: info: ------------------------------ 390ms Apr 10 22:02:30 volumio volumio[938]: info: Apr 10 22:02:30 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:30 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:30 volumio volumio[938]: info: Apr 10 22:02:30 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:30 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:30 volumio volumio[938]: error: updateQueue error: null Apr 10 22:02:30 volumio volumio[938]: info: Apr 10 22:02:30 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:30 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:30 volumio volumio[938]: info: ------------------------------ 431ms Apr 10 22:02:30 volumio volumio[938]: info: sendMpdCommand playlistinfo took 397 milliseconds Apr 10 22:02:30 volumio volumio[938]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 396 milliseconds Apr 10 22:02:30 volumio volumio[938]: info: ------------------------------ 72ms Apr 10 22:02:30 volumio volumio[938]: info: ------------------------------ 58ms Apr 10 22:02:30 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:30 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 10 22:02:30 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand play Apr 10 22:02:30 volumio volumio[938]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 10 22:02:30 volumio volumio[938]: info: ------------------------------ 558ms Apr 10 22:02:30 volumio volumio[938]: info: Apr 10 22:02:30 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:30 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:30 volumio volumio[938]: info: Apr 10 22:02:30 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:30 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:31 volumio volumio[938]: info: ------------------------------ 180ms Apr 10 22:02:31 volumio volumio[938]: info: sendMpdCommand play took 139 milliseconds Apr 10 22:02:31 volumio volumio[938]: info: ------------------------------ 111ms Apr 10 22:02:31 volumio volumio[938]: info: ------------------------------ 108ms Apr 10 22:02:31 volumio volumio[1262]: ......................................................................................................++++ Apr 10 22:02:31 volumio volumio[1262]: e is 65537 (0x010001) Apr 10 22:02:31 volumio volumio[1262]: writing RSA key Apr 10 22:02:33 volumio volumio[938]: info: Apr 10 22:02:33 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:33 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:33 volumio volumio[938]: info: Apr 10 22:02:33 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:33 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:33 volumio volumio[938]: info: Apr 10 22:02:33 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:33 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:33 volumio volumio[938]: info: Apr 10 22:02:33 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:33 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:33 volumio volumio[938]: info: sendMpdCommand status took 60 milliseconds Apr 10 22:02:33 volumio volumio[938]: info: sendMpdCommand status took 47 milliseconds Apr 10 22:02:33 volumio volumio[938]: info: sendMpdCommand status took 34 milliseconds Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:33 volumio volumio[938]: info: Apr 10 22:02:33 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:33 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:33 volumio volumio[938]: info: Apr 10 22:02:33 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:33 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:33 volumio volumio[938]: info: sendMpdCommand status took 69 milliseconds Apr 10 22:02:33 volumio volumio[938]: info: sendMpdCommand playlistinfo took 55 milliseconds Apr 10 22:02:33 volumio volumio[938]: info: sendMpdCommand playlistinfo took 62 milliseconds Apr 10 22:02:33 volumio volumio[938]: info: sendMpdCommand playlistinfo took 57 milliseconds Apr 10 22:02:33 volumio volumio[938]: info: sendMpdCommand status took 47 milliseconds Apr 10 22:02:33 volumio volumio[938]: info: sendMpdCommand status took 39 milliseconds Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:33 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:33 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:33 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:33 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:33 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 4875/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 22:02:33 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:33 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:33 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus stop Apr 10 22:02:33 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:33 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:33 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:33 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 4875/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 22:02:33 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:33 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:33 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:33 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:33 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:33 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:33 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:33 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:33 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:34 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:34 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:34 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 4875/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 22:02:34 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:34 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:34 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:34 volumio volumio[938]: info: ------------------------------ 551ms Apr 10 22:02:34 volumio volumio[938]: info: ------------------------------ 932ms Apr 10 22:02:34 volumio volumio[938]: info: ------------------------------ 929ms Apr 10 22:02:34 volumio volumio[938]: info: Apr 10 22:02:34 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:34 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:34 volumio volumio[938]: info: Apr 10 22:02:34 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:34 volumio volumio[938]: info: Apr 10 22:02:34 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:34 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:34 volumio volumio[938]: info: Apr 10 22:02:34 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:34 volumio volumio[938]: info: sendMpdCommand playlistinfo took 822 milliseconds Apr 10 22:02:34 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:34 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:34 volumio volumio[938]: info: sendMpdCommand playlistinfo took 787 milliseconds Apr 10 22:02:34 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:34 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:34 volumio volumio[938]: info: sendMpdCommand playlistinfo took 810 milliseconds Apr 10 22:02:34 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:34 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:34 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:34 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:34 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:34 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 4875/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 22:02:34 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:34 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:34 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:34 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:34 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:34 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 22:02:34 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:34 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:34 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:34 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:34 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 22:02:34 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:34 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:34 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:34 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:35 volumio volumio[938]: info: ------------------------------ 1630ms Apr 10 22:02:35 volumio volumio[938]: info: ------------------------------ 1585ms Apr 10 22:02:35 volumio volumio[938]: info: ------------------------------ 1578ms Apr 10 22:02:35 volumio volumio[938]: info: Apr 10 22:02:35 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:35 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:35 volumio volumio[938]: info: Apr 10 22:02:35 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:35 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:35 volumio volumio[938]: info: Apr 10 22:02:35 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:35 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:35 volumio volumio[938]: info: Apr 10 22:02:35 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:35 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:35 volumio volumio[938]: info: Apr 10 22:02:35 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:35 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:35 volumio volumio[938]: info: Apr 10 22:02:35 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:35 volumio volumio[938]: info: ------------------------------ 859ms Apr 10 22:02:35 volumio volumio[938]: info: sendMpdCommand status took 840 milliseconds Apr 10 22:02:35 volumio volumio[938]: info: ------------------------------ 848ms Apr 10 22:02:35 volumio volumio[938]: info: sendMpdCommand status took 818 milliseconds Apr 10 22:02:35 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:35 volumio volumio[938]: info: ------------------------------ 155ms Apr 10 22:02:35 volumio volumio[938]: info: sendMpdCommand status took 147 milliseconds Apr 10 22:02:35 volumio volumio[938]: info: ------------------------------ 146ms Apr 10 22:02:35 volumio volumio[938]: info: sendMpdCommand status took 134 milliseconds Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:35 volumio volumio[938]: info: Apr 10 22:02:35 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:35 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:35 volumio volumio[938]: info: Apr 10 22:02:35 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:35 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:35 volumio volumio[938]: info: Apr 10 22:02:35 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:35 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:35 volumio volumio[938]: info: Apr 10 22:02:35 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:35 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:35 volumio volumio[938]: info: ------------------------------ 201ms Apr 10 22:02:35 volumio volumio[938]: info: sendMpdCommand status took 179 milliseconds Apr 10 22:02:35 volumio volumio[938]: info: sendMpdCommand playlistinfo took 172 milliseconds Apr 10 22:02:35 volumio volumio[938]: info: sendMpdCommand playlistinfo took 171 milliseconds Apr 10 22:02:35 volumio volumio[938]: info: sendMpdCommand playlistinfo took 166 milliseconds Apr 10 22:02:35 volumio volumio[938]: info: sendMpdCommand playlistinfo took 168 milliseconds Apr 10 22:02:35 volumio volumio[938]: info: ------------------------------ 158ms Apr 10 22:02:35 volumio volumio[938]: info: sendMpdCommand status took 149 milliseconds Apr 10 22:02:35 volumio volumio[938]: info: ------------------------------ 143ms Apr 10 22:02:35 volumio volumio[938]: info: sendMpdCommand status took 138 milliseconds Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:35 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:35 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:35 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:35 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1585,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 22:02:35 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:35 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:35 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:35 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:35 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1585,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 22:02:35 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:35 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:35 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:35 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:35 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2282,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 22:02:35 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:35 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:35 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:35 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:35 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2282,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 22:02:35 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:35 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:35 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:35 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:36 volumio volumio[938]: info: ------------------------------ 1757ms Apr 10 22:02:36 volumio volumio[938]: info: ------------------------------ 1760ms Apr 10 22:02:36 volumio volumio[938]: info: ------------------------------ 1053ms Apr 10 22:02:36 volumio volumio[938]: info: ------------------------------ 1058ms Apr 10 22:02:36 volumio volumio[938]: info: sendMpdCommand playlistinfo took 1000 milliseconds Apr 10 22:02:36 volumio volumio[938]: info: sendMpdCommand playlistinfo took 981 milliseconds Apr 10 22:02:36 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:36 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:36 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:36 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:36 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2385,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 22:02:36 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:36 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:36 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:36 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:36 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:36 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:36 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:36 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:36 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:36 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:36 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:36 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:36 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:36 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2385,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 22:02:36 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:36 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:36 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:36 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:36 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:36 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:36 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:36 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:36 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:36 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:36 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:36 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:36 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2481,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 22:02:36 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:36 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:36 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:36 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:36 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:36 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:36 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:36 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:36 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:37 volumio volumio[938]: info: ------------------------------ 1786ms Apr 10 22:02:37 volumio volumio[938]: info: ------------------------------ 1721ms Apr 10 22:02:37 volumio volumio[938]: info: ------------------------------ 1708ms Apr 10 22:02:37 volumio volumio[938]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/ANTENNE%20BAYERN/be0bc999-ee55-42a5-9841-3f9b7ec0749e.jpg' Apr 10 22:02:37 volumio volumio[938]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/ANTENNE%20BAYERN/be0bc999-ee55-42a5-9841-3f9b7ec0749e.jpg' Apr 10 22:02:37 volumio volumio[938]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/ANTENNE%20BAYERN/be0bc999-ee55-42a5-9841-3f9b7ec0749e.jpg' Apr 10 22:02:37 volumio volumio[938]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/ANTENNE%20BAYERN/be0bc999-ee55-42a5-9841-3f9b7ec0749e.jpg' Apr 10 22:02:38 volumio volumio[938]: info: Preload queue cleared Apr 10 22:02:38 volumio volumio[938]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 10 22:02:38 volumio volumio[938]: info: CoreStateMachine::ClearQueue Apr 10 22:02:38 volumio volumio[938]: info: CoreStateMachine::stop Apr 10 22:02:38 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:38 volumio volumio[938]: info: CoreStateMachine::stPlaybackTimer Apr 10 22:02:38 volumio volumio[938]: info: CoreStateMachine::updateTrackBlock Apr 10 22:02:38 volumio volumio[938]: info: CorePlayQueue::getTrackBlock Apr 10 22:02:38 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:38 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:38 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:38 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:39 volumio volumio[938]: info: CoreStateMachine::serviceStop Apr 10 22:02:39 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:39 volumio volumio[938]: info: CoreCommandRouter::serviceStop Apr 10 22:02:39 volumio volumio[938]: info: [1775829759033] ControllerWebradio::stop Apr 10 22:02:39 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 22:02:39 volumio volumio[938]: info: CorePlayQueue::clearPlayQueue Apr 10 22:02:39 volumio volumio[938]: info: CorePlayQueue::saveQueue Apr 10 22:02:39 volumio volumio[938]: info: CoreCommandRouter::volumioPushQueue Apr 10 22:02:39 volumio volumio[938]: info: CoreStateMachine::addQueueItems Apr 10 22:02:39 volumio volumio[938]: info: CorePlayQueue::addQueueItems Apr 10 22:02:39 volumio volumio[938]: info: Preload queue cleared Apr 10 22:02:39 volumio volumio[938]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Apr 10 22:02:39 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 10 22:02:39 volumio volumio[938]: info: CoreCommandRouter::volumioPushQueue Apr 10 22:02:39 volumio volumio[938]: info: CorePlayQueue::saveQueue Apr 10 22:02:39 volumio volumio[938]: info: CoreStateMachine::updateTrackBlock Apr 10 22:02:39 volumio volumio[938]: info: CorePlayQueue::getTrackBlock Apr 10 22:02:39 volumio volumio[938]: info: CoreCommandRouter::volumioPlay Apr 10 22:02:39 volumio volumio[938]: info: CoreStateMachine::play index 0 Apr 10 22:02:39 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:39 volumio volumio[938]: info: CoreStateMachine::stop Apr 10 22:02:39 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:39 volumio volumio[938]: info: CoreStateMachine::play index undefined Apr 10 22:02:39 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 22:02:39 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:39 volumio volumio[938]: info: CoreStateMachine::startPlaybackTimer Apr 10 22:02:39 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:39 volumio volumio[938]: info: [1775829759266] ControllerWebradio::clearAddPlayTrack Apr 10 22:02:39 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 22:02:39 volumio volumio[938]: info: Apr 10 22:02:39 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:39 volumio volumio[938]: info: sendMpdCommand stop took 356 milliseconds Apr 10 22:02:39 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:39 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:39 volumio volumio[938]: info: sendMpdCommand stop took 125 milliseconds Apr 10 22:02:39 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand clear Apr 10 22:02:39 volumio volumio[938]: info: Apr 10 22:02:39 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:39 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:39 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:39 volumio volumio[938]: info: Apr 10 22:02:39 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:39 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:39 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:39 volumio volumio[938]: info: Apr 10 22:02:39 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:39 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:39 volumio volumio[938]: info: sendMpdCommand status took 119 milliseconds Apr 10 22:02:39 volumio volumio[938]: info: sendMpdCommand clear took 113 milliseconds Apr 10 22:02:39 volumio volumio[938]: info: sendMpdCommand status took 108 milliseconds Apr 10 22:02:39 volumio volumio[938]: info: sendMpdCommand status took 97 milliseconds Apr 10 22:02:39 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:39 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:39 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Apr 10 22:02:39 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:39 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:39 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:39 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:39 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:39 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:39 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:39 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:39 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:39 volumio volumio[938]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 10 22:02:39 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:39 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:39 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:39 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:39 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:39 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:39 volumio volumio[938]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 10 22:02:39 volumio volumio[938]: info: ------------------------------ 291ms Apr 10 22:02:39 volumio volumio[938]: info: ------------------------------ 284ms Apr 10 22:02:39 volumio volumio[938]: info: Apr 10 22:02:39 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:39 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:39 volumio volumio[938]: info: Apr 10 22:02:39 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:39 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:39 volumio volumio[938]: error: updateQueue error: null Apr 10 22:02:39 volumio volumio[938]: info: ------------------------------ 289ms Apr 10 22:02:39 volumio volumio[938]: info: sendMpdCommand playlistinfo took 397 milliseconds Apr 10 22:02:39 volumio volumio[938]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 399 milliseconds Apr 10 22:02:39 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:39 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 10 22:02:39 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand play Apr 10 22:02:39 volumio volumio[938]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 10 22:02:39 volumio volumio[938]: info: ------------------------------ 558ms Apr 10 22:02:39 volumio volumio[938]: info: Apr 10 22:02:39 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:39 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:39 volumio volumio[938]: info: ------------------------------ 255ms Apr 10 22:02:39 volumio volumio[938]: info: ------------------------------ 253ms Apr 10 22:02:39 volumio volumio[938]: info: sendMpdCommand play took 25 milliseconds Apr 10 22:02:39 volumio volumio[938]: info: Apr 10 22:02:39 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:39 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:39 volumio volumio[938]: info: Apr 10 22:02:39 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:39 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:40 volumio volumio[938]: info: ------------------------------ 60ms Apr 10 22:02:40 volumio volumio[938]: info: ------------------------------ 42ms Apr 10 22:02:40 volumio volumio[938]: info: ------------------------------ 33ms Apr 10 22:02:45 volumio volumio[938]: info: Apr 10 22:02:45 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:45 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:45 volumio volumio[938]: info: Apr 10 22:02:45 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:45 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:45 volumio volumio[938]: info: Apr 10 22:02:45 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:45 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:45 volumio volumio[938]: info: Apr 10 22:02:45 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:45 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:45 volumio volumio[938]: info: sendMpdCommand status took 103 milliseconds Apr 10 22:02:45 volumio volumio[938]: info: sendMpdCommand status took 86 milliseconds Apr 10 22:02:45 volumio volumio[938]: info: sendMpdCommand status took 77 milliseconds Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:45 volumio volumio[938]: info: Apr 10 22:02:45 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:45 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:45 volumio volumio[938]: info: Apr 10 22:02:45 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:45 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:45 volumio volumio[938]: info: sendMpdCommand status took 145 milliseconds Apr 10 22:02:45 volumio volumio[938]: info: sendMpdCommand playlistinfo took 97 milliseconds Apr 10 22:02:45 volumio volumio[938]: info: sendMpdCommand playlistinfo took 99 milliseconds Apr 10 22:02:45 volumio volumio[938]: info: sendMpdCommand playlistinfo took 97 milliseconds Apr 10 22:02:45 volumio volumio[938]: info: sendMpdCommand status took 58 milliseconds Apr 10 22:02:45 volumio volumio[938]: info: sendMpdCommand status took 33 milliseconds Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:45 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:45 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:45 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:45 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:45 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 22:02:45 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:45 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:45 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus stop Apr 10 22:02:45 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:45 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:45 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:45 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 22:02:45 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:45 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:45 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:45 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:45 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:45 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:45 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:45 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:45 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:45 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:45 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:45 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:45 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:45 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:45 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 22:02:45 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:45 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:45 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:45 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:45 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:45 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:45 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:45 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:45 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:45 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:45 volumio volumio[938]: info: ------------------------------ 637ms Apr 10 22:02:46 volumio volumio[938]: info: ------------------------------ 1040ms Apr 10 22:02:46 volumio volumio[938]: info: ------------------------------ 1031ms Apr 10 22:02:46 volumio volumio[938]: info: Apr 10 22:02:46 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:46 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:46 volumio volumio[938]: info: Apr 10 22:02:46 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:46 volumio volumio[938]: info: sendMpdCommand playlistinfo took 841 milliseconds Apr 10 22:02:46 volumio volumio[938]: info: sendMpdCommand playlistinfo took 810 milliseconds Apr 10 22:02:46 volumio volumio[938]: info: sendMpdCommand playlistinfo took 809 milliseconds Apr 10 22:02:46 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:46 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:46 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:46 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:46 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:46 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:46 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:46 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 22:02:46 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:46 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:46 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:46 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:46 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:46 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:46 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:46 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:46 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:46 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:46 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:46 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:46 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:46 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:46 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 22:02:46 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:46 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:46 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:46 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:46 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:46 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:46 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:46 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:46 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:46 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:46 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:46 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:46 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:46 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 22:02:46 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:46 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:46 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:46 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:46 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:46 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:46 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:46 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:46 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:46 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:46 volumio volumio[938]: info: ------------------------------ 1682ms Apr 10 22:02:46 volumio volumio[938]: info: ------------------------------ 1539ms Apr 10 22:02:46 volumio volumio[938]: info: ------------------------------ 1525ms Apr 10 22:02:46 volumio volumio[938]: info: Apr 10 22:02:46 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:46 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:46 volumio volumio[938]: info: Apr 10 22:02:46 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:46 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:46 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:47 volumio volumio[938]: info: Apr 10 22:02:47 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:47 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:47 volumio volumio[938]: info: Apr 10 22:02:47 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:47 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:47 volumio volumio[938]: info: Apr 10 22:02:47 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:47 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:47 volumio volumio[938]: info: Apr 10 22:02:47 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:47 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:47 volumio volumio[938]: info: ------------------------------ 823ms Apr 10 22:02:47 volumio volumio[938]: info: sendMpdCommand status took 781 milliseconds Apr 10 22:02:47 volumio volumio[938]: info: ------------------------------ 95ms Apr 10 22:02:47 volumio volumio[938]: info: sendMpdCommand status took 89 milliseconds Apr 10 22:02:47 volumio volumio[938]: info: ------------------------------ 79ms Apr 10 22:02:47 volumio volumio[938]: info: sendMpdCommand status took 71 milliseconds Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:47 volumio volumio[938]: info: Apr 10 22:02:47 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:47 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:47 volumio volumio[938]: info: Apr 10 22:02:47 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:47 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:47 volumio volumio[938]: info: Apr 10 22:02:47 volumio volumio[938]: ---------------------------- MPD announces system playlist update Apr 10 22:02:47 volumio volumio[938]: info: Ignoring MPD Status Update Apr 10 22:02:47 volumio volumio[938]: info: Apr 10 22:02:47 volumio volumio[938]: ---------------------------- MPD announces state update: player Apr 10 22:02:47 volumio volumio[938]: info: ControllerMpd::getState Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status Apr 10 22:02:47 volumio volumio[938]: info: ------------------------------ 134ms Apr 10 22:02:47 volumio volumio[938]: info: sendMpdCommand status took 115 milliseconds Apr 10 22:02:47 volumio volumio[938]: info: sendMpdCommand playlistinfo took 95 milliseconds Apr 10 22:02:47 volumio volumio[938]: info: sendMpdCommand playlistinfo took 97 milliseconds Apr 10 22:02:47 volumio volumio[938]: info: sendMpdCommand playlistinfo took 96 milliseconds Apr 10 22:02:47 volumio volumio[938]: info: ------------------------------ 85ms Apr 10 22:02:47 volumio volumio[938]: info: sendMpdCommand status took 77 milliseconds Apr 10 22:02:47 volumio volumio[938]: info: ------------------------------ 72ms Apr 10 22:02:47 volumio volumio[938]: info: sendMpdCommand status took 68 milliseconds Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::parseState Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 22:02:47 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:47 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:47 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1284,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 22:02:47 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:47 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:47 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:47 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:47 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 22:02:47 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:47 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:47 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:47 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:47 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 22:02:47 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:47 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:47 volumio volumio[938]: info: ------------------------------ 1480ms Apr 10 22:02:47 volumio volumio[938]: info: ------------------------------ 758ms Apr 10 22:02:47 volumio volumio[938]: info: ------------------------------ 742ms Apr 10 22:02:47 volumio volumio[938]: info: sendMpdCommand playlistinfo took 616 milliseconds Apr 10 22:02:47 volumio volumio[938]: info: sendMpdCommand playlistinfo took 612 milliseconds Apr 10 22:02:47 volumio volumio[938]: info: sendMpdCommand playlistinfo took 605 milliseconds Apr 10 22:02:47 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo Apr 10 22:02:47 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:47 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:47 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2084,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 22:02:47 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:47 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:47 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:47 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:47 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2084,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 22:02:47 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:47 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:47 volumio volumio[938]: info: ControllerMpd::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::servicePushState Apr 10 22:02:47 volumio volumio[938]: info: CorePlayQueue::getTrack 0 Apr 10 22:02:47 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2084,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 22:02:47 volumio volumio[938]: verbose: CURRENT POSITION 0 Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::syncState stateService play Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play Apr 10 22:02:47 volumio volumio[938]: info: Received an update from plugin. extracting info from payload Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:47 volumio volumio[938]: info: CoreStateMachine::pushState Apr 10 22:02:47 volumio volumio[938]: info: CoreCommandRouter::volumioPushState Apr 10 22:02:48 volumio volumio[938]: info: ------------------------------ 1262ms Apr 10 22:02:48 volumio volumio[938]: info: ------------------------------ 1222ms Apr 10 22:02:48 volumio volumio[938]: info: ------------------------------ 1210ms Apr 10 22:02:50 volumio volumio[938]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 22:02:50 volumio volumio[938]: TypeError: Cannot read property 'slice' of null Apr 10 22:02:50 volumio volumio[938]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Apr 10 22:02:50 volumio volumio[938]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Apr 10 22:02:50 volumio volumio[938]: at Object.onceWrapper (events.js:422:26) Apr 10 22:02:50 volumio volumio[938]: at ClientRequest.emit (events.js:315:20) Apr 10 22:02:50 volumio volumio[938]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Apr 10 22:02:50 volumio volumio[938]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Apr 10 22:02:50 volumio volumio[938]: at TLSSocket.socketOnData (_http_client.js:509:22) Apr 10 22:02:50 volumio volumio[938]: at TLSSocket.emit (events.js:315:20) Apr 10 22:02:50 volumio volumio[938]: at addChunk (internal/streams/readable.js:309:12) Apr 10 22:02:50 volumio volumio[938]: at readableAddChunk (internal/streams/readable.js:284:9) Apr 10 22:02:50 volumio volumio[938]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Apr 10 22:02:50 volumio volumio[938]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Apr 10 22:02:50 volumio volumio[938]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 22:02:53 volumio sudo[1768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-10 22:01 Apr 10 22:02:53 volumio sudo[1768]: 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"