-- Logs begin at Thu 2019-02-14 13:11:58 MSK, end at Sat 2025-03-15 09:12:01 MSK. -- Mar 15 09:11:29 volumio volumio[1304]: info: Discovery: A device disappeared from network Mar 15 09:11:29 volumio volumio[1304]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Mar 15 09:11:29 volumio systemd-timedated[1589]: Changed local time to Sat Mar 15 09:11:29 2025 Mar 15 09:11:29 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Mar 15 09:11:29 volumio sudo[1578]: pam_unix(sudo:session): session closed for user root Mar 15 09:11:29 volumio volumio-time-update[823]: volumio-time-update-util: System time updated successfully. Mar 15 09:11:29 volumio systemd[1]: Starting Daily man-db regeneration... Mar 15 09:11:29 volumio systemd[1]: Started Volumio Time Update Utility. Mar 15 09:11:29 volumio volumio[1304]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Mar 15 09:11:29 volumio systemd[1]: Reached target Multi-User System. Mar 15 09:11:29 volumio systemd[1]: Reached target Graphical Interface. Mar 15 09:11:29 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 15 09:11:29 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 15 09:11:29 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 15 09:11:29 volumio volumio[1304]: info: touch_display: X display number found: 0 Mar 15 09:11:29 volumio systemd[1]: man-db.service: Succeeded. Mar 15 09:11:29 volumio systemd[1]: Started Daily man-db regeneration. Mar 15 09:11:29 volumio kernel: broken atomic modeset userspace detected, disabling atomic Mar 15 09:11:29 volumio startx[1564]: MESA-LOADER: failed to open drm-rp1-dsi (search paths /usr/lib/arm-linux-gnueabihf/dri:\$${ORIGIN}/dri:/usr/lib/dri) Mar 15 09:11:29 volumio startx[1564]: failed to load driver: drm-rp1-dsi Mar 15 09:11:29 volumio kernel: broken atomic modeset userspace detected, disabling atomic Mar 15 09:11:29 volumio startx[1564]: V3D 7.1 not supported by this version of Mesa. Mar 15 09:11:29 volumio kernel: broken atomic modeset userspace detected, disabling atomic Mar 15 09:11:29 volumio startx[1564]: (II) modeset(G0): Initializing kms color map for depth 24, 8 bpc. Mar 15 09:11:29 volumio startx[1564]: (II) modeset(G1): Initializing kms color map for depth 24, 8 bpc. Mar 15 09:11:29 volumio startx[1564]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Mar 15 09:11:29 volumio kernel: panel-simple 100000001.panel_disp: [drm:drm_panel_disable [drm]] failed to disable backlight: -121 Mar 15 09:11:29 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Mar 15 09:11:29 volumio systemd[1]: Started Daily apt upgrade and clean activities. Mar 15 09:11:29 volumio systemd[1]: Startup finished in 10.502s (kernel) + 22.750s (userspace) = 33.252s. Mar 15 09:11:29 volumio volumio[1304]: info: touch_display: Setting screensaver timeout to 1200 seconds. Mar 15 09:11:30 volumio volumio-remote-updater[817]: [2025-03-15 09:11:30] [connect] Successful connection Mar 15 09:11:30 volumio volumio-remote-updater[817]: [2025-03-15 09:11:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1742019090 101 Mar 15 09:11:30 volumio volumio[1304]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3 Mar 15 09:11:31 volumio sudo[1346]: pam_unix(sudo:session): session closed for user root Mar 15 09:11:31 volumio volumio[1304]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Mar 15 09:11:31 volumio volumio[1304]: info: CoreCommandRouter::volumioGetVisibleSources Mar 15 09:11:31 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 15 09:11:31 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 15 09:11:31 volumio volumio[1304]: info: CoreCommandRouter::volumioGetState Mar 15 09:11:31 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:31 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 15 09:11:31 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 15 09:11:31 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 15 09:11:31 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 15 09:11:32 volumio volumio[1304]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Mar 15 09:11:32 volumio volumio[1304]: info: CoreCommandRouter::volumioGetState Mar 15 09:11:32 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:32 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 15 09:11:32 volumio volumio[1304]: info: CoreCommandRouter::volumioGetVisibleSources Mar 15 09:11:32 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 15 09:11:32 volumio volumio[1304]: info: Listing playlists Mar 15 09:11:32 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 15 09:11:32 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 15 09:11:32 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 15 09:11:32 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 15 09:11:33 volumio volumio[1304]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 15 09:11:34 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 15 09:11:34 volumio volumio[1304]: info: Received Get System Info Mar 15 09:11:34 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 15 09:11:34 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 15 09:11:34 volumio volumio[1304]: info: Discovery: Getting this device information Mar 15 09:11:34 volumio volumio[1304]: info: CoreCommandRouter::volumioGetState Mar 15 09:11:34 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:34 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 15 09:11:35 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 15 09:11:35 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 15 09:11:35 volumio volumio[1304]: info: Received Get System Info Mar 15 09:11:35 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 15 09:11:35 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 15 09:11:35 volumio volumio[1304]: info: Discovery: Getting this device information Mar 15 09:11:35 volumio volumio[1304]: info: CoreCommandRouter::volumioGetState Mar 15 09:11:35 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:35 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 15 09:11:36 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 15 09:11:37 volumio sudo[1905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 15 09:11:37 volumio sudo[1905]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 15 09:11:37 volumio sudo[1905]: pam_unix(sudo:session): session closed for user root Mar 15 09:11:37 volumio sudo[1907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 15 09:11:37 volumio sudo[1907]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 15 09:11:37 volumio sudo[1907]: pam_unix(sudo:session): session closed for user root Mar 15 09:11:37 volumio sudo[1911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 15 09:11:37 volumio sudo[1911]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 15 09:11:37 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Mar 15 09:11:37 volumio sudo[1911]: pam_unix(sudo:session): session closed for user root Mar 15 09:11:37 volumio volumio[1304]: info: Upmpdcli Daemon Started Mar 15 09:11:37 volumio volumio[1913]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 15 09:11:37 volumio volumio[1913]: ...++++ Mar 15 09:11:37 volumio systemd[1]: systemd-fsckd.service: Succeeded. Mar 15 09:11:37 volumio volumio[1913]: ...........++++ Mar 15 09:11:37 volumio volumio[1913]: e is 65537 (0x010001) Mar 15 09:11:37 volumio volumio[1913]: writing RSA key Mar 15 09:11:38 volumio sh[757]: timed out Mar 15 09:11:38 volumio dhcpcd[792]: timed out Mar 15 09:11:38 volumio sh[757]: dhcpcd exited Mar 15 09:11:38 volumio dhcpcd[792]: dhcpcd exited Mar 15 09:11:38 volumio sh[757]: ifup: failed to bring up eth0 Mar 15 09:11:38 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Mar 15 09:11:38 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Mar 15 09:11:38 volumio volumio[1304]: info: Discovery: adding 31218363-247f-4e68-ae70-f11e65ff8c45 Mar 15 09:11:38 volumio volumio[1304]: info: Discovery: Found device Volumio Mar 15 09:11:38 volumio volumio[1304]: info: CoreCommandRouter::volumioGetState Mar 15 09:11:38 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:39 volumio volumio[1304]: info: Discovery: this is already registered, 31218363-247f-4e68-ae70-f11e65ff8c45 Mar 15 09:11:39 volumio volumio[1304]: info: Discovery: Found device Volumio Mar 15 09:11:39 volumio volumio[1304]: info: CoreCommandRouter::volumioGetState Mar 15 09:11:39 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 15 09:11:39 volumio volumio[1304]: info: Adding plugin bluetooth to MyMusic Plugins Mar 15 09:11:39 volumio volumio[1304]: info: Adding plugin multiroom to MyMusic Plugins Mar 15 09:11:39 volumio volumio[1304]: info: Adding plugin metavolumio to MyMusic Plugins Mar 15 09:11:39 volumio volumio[1304]: info: Adding plugin cd_controller to MyMusic Plugins Mar 15 09:11:39 volumio volumio[1304]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 15 09:11:39 volumio volumio[1304]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 15 09:11:39 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 15 09:11:39 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:39 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:39 volumio volumio[1304]: info: Starting MyVolumio Remote Streaming Endpoints Mar 15 09:11:39 volumio volumio[1304]: info: MyVolumio login type: Token Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 15 09:11:39 volumio volumio[1304]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 15 09:11:40 volumio volumio[1304]: info: Starting Streaming Service Transparent Proxy Mar 15 09:11:40 volumio volumio[1304]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 15 09:11:40 volumio volumio[1304]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 15 09:11:40 volumio volumio[1304]: info: Streaming services startup Mar 15 09:11:40 volumio volumio[1304]: info: Starting Streaming Daemon Mar 15 09:11:40 volumio sudo[2134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 15 09:11:40 volumio sudo[2134]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 15 09:11:40 volumio volumio[1304]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 15 09:11:40 volumio sudo[2134]: pam_unix(sudo:session): session closed for user root Mar 15 09:11:40 volumio volumio[1304]: error: Cannot start Volumio Streaming Daemon Mar 15 09:11:40 volumio volumio[1304]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 15 09:11:40 volumio volumio[1304]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 15 09:11:40 volumio volumio[1304]: STREAMING PROXY: Starting server on port 3245 Mar 15 09:11:40 volumio volumio[1304]: Node JS runtime: 14 Mar 15 09:11:40 volumio volumio[1304]: error: MyVolumio Custom Token format not valid, refreshing it Mar 15 09:11:41 volumio volumio[1304]: info: MyVolumio login type: Token Mar 15 09:11:42 volumio volumio[1304]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 15 09:11:42 volumio volumio[1304]: info: MyVolumio token set successfully Mar 15 09:11:42 volumio volumio[1304]: info: MYVOLUMIO: Adding device Mar 15 09:11:42 volumio volumio[1304]: info: MYVOLUMIO: Evaluating Server Mar 15 09:11:43 volumio volumio[1304]: info: MyVolumio status changed Mar 15 09:11:43 volumio volumio[1304]: info: Streaming services startup Mar 15 09:11:43 volumio volumio[1304]: info: Starting Streaming Daemon Mar 15 09:11:43 volumio volumio[1304]: info: Removing browser output: myVolumio user plan is not superstar Mar 15 09:11:43 volumio volumio[1304]: info: Removing audio output: Mar 15 09:11:43 volumio volumio[1304]: info: Stoppping Tunnel 1 Mar 15 09:11:43 volumio sudo[2159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 15 09:11:43 volumio sudo[2159]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 15 09:11:43 volumio sudo[2162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Mar 15 09:11:43 volumio sudo[2162]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 15 09:11:43 volumio sudo[2159]: pam_unix(sudo:session): session closed for user root Mar 15 09:11:43 volumio volumio[1304]: error: Cannot start Volumio Streaming Daemon Mar 15 09:11:43 volumio volumio[1304]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 15 09:11:43 volumio volumio[1304]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 15 09:11:43 volumio sudo[2162]: pam_unix(sudo:session): session closed for user root Mar 15 09:11:43 volumio volumio[1304]: info: Remote SSH Stopped Mar 15 09:11:43 volumio volumio[1304]: info: Setting Geolocation for MyVolumio to eu6 Mar 15 09:11:43 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:43 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:43 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:44 volumio volumio[1304]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 15 09:11:44 volumio volumio[1304]: info: Updating MyVolumio device info Mar 15 09:11:44 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:44 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:44 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:45 volumio volumio[1304]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 15 09:11:48 volumio volumio[1304]: info: MYVOLUMIO: Adding device Mar 15 09:11:48 volumio volumio[1304]: info: MYVOLUMIO: Evaluating Server Mar 15 09:11:48 volumio volumio[1304]: info: AutoStart - Plugin is starting Mar 15 09:11:48 volumio volumio[1304]: info: CoreCommandRouter::volumioGetQueue Mar 15 09:11:48 volumio volumio[1304]: info: CoreStateMachine::getQueue Mar 15 09:11:48 volumio volumio[1304]: info: CorePlayQueue::getQueue Mar 15 09:11:48 volumio volumio[1304]: info: AutoStart - start playing Mar 15 09:11:48 volumio volumio[1304]: info: AutoStart - start playing with no specific position Mar 15 09:11:48 volumio volumio[1304]: info: CoreCommandRouter::volumioPlay Mar 15 09:11:48 volumio volumio[1304]: info: CoreStateMachine::play index 0 Mar 15 09:11:48 volumio volumio[1304]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 15 09:11:48 volumio volumio[1304]: info: CoreStateMachine::stop Mar 15 09:11:48 volumio volumio[1304]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 15 09:11:48 volumio volumio[1304]: info: CoreStateMachine::play index undefined Mar 15 09:11:48 volumio volumio[1304]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 15 09:11:48 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:48 volumio volumio[1304]: info: CoreStateMachine::startPlaybackTimer Mar 15 09:11:48 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:48 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand stop Mar 15 09:11:48 volumio volumio[1304]: info: sendMpdCommand stop took 0 milliseconds Mar 15 09:11:48 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand clear Mar 15 09:11:48 volumio volumio[1304]: info: sendMpdCommand clear took 0 milliseconds Mar 15 09:11:48 volumio volumio[1304]: info: Mar 15 09:11:48 volumio volumio[1304]: ---------------------------- MPD announces system playlist update Mar 15 09:11:48 volumio volumio[1304]: info: Ignoring MPD Status Update Mar 15 09:11:48 volumio volumio[1304]: info: Mar 15 09:11:48 volumio volumio[1304]: ---------------------------- MPD announces system playlist update Mar 15 09:11:48 volumio volumio[1304]: info: Ignoring MPD Status Update Mar 15 09:11:48 volumio volumio[1304]: info: Mar 15 09:11:48 volumio volumio[1304]: ---------------------------- MPD announces system playlist update Mar 15 09:11:48 volumio volumio[1304]: info: Ignoring MPD Status Update Mar 15 09:11:48 volumio volumio[1304]: error: updateQueue error: null Mar 15 09:11:48 volumio volumio[1304]: error: updateQueue error: null Mar 15 09:11:48 volumio volumio[1304]: error: updateQueue error: null Mar 15 09:11:48 volumio volumio[1304]: info: ------------------------------ 1ms Mar 15 09:11:48 volumio volumio[1304]: info: ------------------------------ 1ms Mar 15 09:11:48 volumio volumio[1304]: info: ------------------------------ 1ms Mar 15 09:11:48 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-141.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6e5842289e366c1c0dfb53aec2e8022fa5c4f3a6265affe76451ea28d628365a%2Clid%3D1560%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e263a6%2F0%2F48938%2F7b06b3b0.80892785.16.51285594%2Fflac&ext=.flac" Mar 15 09:11:48 volumio volumio[1304]: info: Mar 15 09:11:48 volumio volumio[1304]: ---------------------------- MPD announces system playlist update Mar 15 09:11:48 volumio volumio[1304]: info: Ignoring MPD Status Update Mar 15 09:11:48 volumio volumio[1304]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-141.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6e5842289e366c1c0dfb53aec2e8022fa5c4f3a6265affe76451ea28d628365a%2Clid%3D1560%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e263a6%2F0%2F48938%2F7b06b3b0.80892785.16.51285594%2Fflac&ext=.flac" took 1 milliseconds Mar 15 09:11:48 volumio volumio[1304]: verbose: MPD COMMAND [object Object] Mar 15 09:11:48 volumio volumio[1304]: verbose: MPD COMMAND [object Object] Mar 15 09:11:48 volumio volumio[1304]: verbose: MPD COMMAND [object Object] Mar 15 09:11:48 volumio volumio[1304]: info: Mar 15 09:11:48 volumio volumio[1304]: ---------------------------- MPD announces system playlist update Mar 15 09:11:48 volumio volumio[1304]: info: Ignoring MPD Status Update Mar 15 09:11:48 volumio volumio[1304]: info: Mar 15 09:11:48 volumio volumio[1304]: ---------------------------- MPD announces system playlist update Mar 15 09:11:48 volumio volumio[1304]: info: Ignoring MPD Status Update Mar 15 09:11:48 volumio volumio[1304]: info: Mar 15 09:11:48 volumio volumio[1304]: ---------------------------- MPD announces system playlist update Mar 15 09:11:48 volumio volumio[1304]: info: Ignoring MPD Status Update Mar 15 09:11:48 volumio volumio[1304]: info: ------------------------------ 2ms Mar 15 09:11:48 volumio volumio[1304]: info: ------------------------------ 0ms Mar 15 09:11:48 volumio volumio[1304]: info: ------------------------------ 0ms Mar 15 09:11:48 volumio volumio[1304]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 15 09:11:48 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand play Mar 15 09:11:48 volumio volumio[1304]: info: Mar 15 09:11:48 volumio volumio[1304]: ---------------------------- MPD announces system playlist update Mar 15 09:11:48 volumio volumio[1304]: info: Ignoring MPD Status Update Mar 15 09:11:48 volumio volumio[1304]: info: Mar 15 09:11:48 volumio volumio[1304]: ---------------------------- MPD announces system playlist update Mar 15 09:11:48 volumio volumio[1304]: info: Ignoring MPD Status Update Mar 15 09:11:48 volumio volumio[1304]: info: ------------------------------ 1ms Mar 15 09:11:48 volumio volumio[1304]: info: sendMpdCommand play took 1 milliseconds Mar 15 09:11:48 volumio volumio[1304]: info: ------------------------------ 0ms Mar 15 09:11:48 volumio volumio[1304]: info: Setting Geolocation for MyVolumio to eu7 Mar 15 09:11:48 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:48 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:48 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:49 volumio volumio[1304]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 15 09:11:49 volumio volumio[1304]: info: Mar 15 09:11:49 volumio volumio[1304]: ---------------------------- MPD announces state update: player Mar 15 09:11:49 volumio volumio[1304]: info: ControllerMpd::getState Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand status Mar 15 09:11:49 volumio volumio[1304]: info: Mar 15 09:11:49 volumio volumio[1304]: ---------------------------- MPD announces state update: player Mar 15 09:11:49 volumio volumio[1304]: info: ControllerMpd::getState Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand status Mar 15 09:11:49 volumio volumio[1304]: info: Mar 15 09:11:49 volumio volumio[1304]: ---------------------------- MPD announces state update: player Mar 15 09:11:49 volumio volumio[1304]: info: ControllerMpd::getState Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand status Mar 15 09:11:49 volumio volumio[1304]: info: sendMpdCommand status took 25 milliseconds Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::parseState Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 09:11:49 volumio volumio[1304]: info: Mar 15 09:11:49 volumio volumio[1304]: ---------------------------- MPD announces state update: player Mar 15 09:11:49 volumio volumio[1304]: info: ControllerMpd::getState Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand status Mar 15 09:11:49 volumio volumio[1304]: info: sendMpdCommand status took 26 milliseconds Mar 15 09:11:49 volumio volumio[1304]: info: sendMpdCommand status took 25 milliseconds Mar 15 09:11:49 volumio volumio[1304]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::parseState Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::parseState Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::parseTrackInfo Mar 15 09:11:49 volumio volumio[1304]: info: ControllerMpd::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::servicePushState Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:49 volumio volumio[1304]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sky","artist":"Harmonium","album":"Chillout Connection, Vol. 2","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-141.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6e5842289e366c1c0dfb53aec2e8022fa5c4f3a6265affe76451ea28d628365a%2Clid%3D1560%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e263a6%2F0%2F48938%2F7b06b3b0.80892785.16.51285594%2Fflac&ext=.flac","trackType":"flac"} Mar 15 09:11:49 volumio volumio[1304]: verbose: CURRENT POSITION 0 Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::syncState stateService play Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::syncState currentStatus stop Mar 15 09:11:49 volumio volumio[1304]: info: ------------------------------ 28ms Mar 15 09:11:49 volumio volumio[1304]: info: Mar 15 09:11:49 volumio volumio[1304]: ---------------------------- MPD announces state update: player Mar 15 09:11:49 volumio volumio[1304]: info: ControllerMpd::getState Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand status Mar 15 09:11:49 volumio volumio[1304]: info: Mar 15 09:11:49 volumio volumio[1304]: ---------------------------- MPD announces state update: player Mar 15 09:11:49 volumio volumio[1304]: info: ControllerMpd::getState Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand status Mar 15 09:11:49 volumio volumio[1304]: info: sendMpdCommand status took 2 milliseconds Mar 15 09:11:49 volumio volumio[1304]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 15 09:11:49 volumio volumio[1304]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 15 09:11:49 volumio volumio[1304]: info: sendMpdCommand status took 0 milliseconds Mar 15 09:11:49 volumio volumio[1304]: info: sendMpdCommand status took 0 milliseconds Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::parseState Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::parseTrackInfo Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::parseTrackInfo Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::parseState Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::parseState Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 09:11:49 volumio volumio[1304]: info: ControllerMpd::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::servicePushState Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:49 volumio volumio[1304]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sky","artist":"Harmonium","album":"Chillout Connection, Vol. 2","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-141.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6e5842289e366c1c0dfb53aec2e8022fa5c4f3a6265affe76451ea28d628365a%2Clid%3D1560%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e263a6%2F0%2F48938%2F7b06b3b0.80892785.16.51285594%2Fflac&ext=.flac","trackType":"flac"} Mar 15 09:11:49 volumio volumio[1304]: verbose: CURRENT POSITION 0 Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::syncState stateService play Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::syncState currentStatus play Mar 15 09:11:49 volumio volumio[1304]: info: Received an update from plugin. extracting info from payload Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioPushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioPushState Mar 15 09:11:49 volumio volumio[1304]: info: ControllerMpd::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::servicePushState Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:49 volumio volumio[1304]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sky","artist":"Harmonium","album":"Chillout Connection, Vol. 2","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-141.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6e5842289e366c1c0dfb53aec2e8022fa5c4f3a6265affe76451ea28d628365a%2Clid%3D1560%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e263a6%2F0%2F48938%2F7b06b3b0.80892785.16.51285594%2Fflac&ext=.flac","trackType":"flac"} Mar 15 09:11:49 volumio volumio[1304]: verbose: CURRENT POSITION 0 Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::syncState stateService play Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::syncState currentStatus play Mar 15 09:11:49 volumio volumio[1304]: info: Received an update from plugin. extracting info from payload Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioPushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioPushState Mar 15 09:11:49 volumio volumio[1304]: info: ------------------------------ 36ms Mar 15 09:11:49 volumio volumio[1304]: info: ------------------------------ 35ms Mar 15 09:11:49 volumio volumio[1304]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 15 09:11:49 volumio volumio[1304]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 15 09:11:49 volumio volumio[1304]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::parseTrackInfo Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::parseTrackInfo Mar 15 09:11:49 volumio volumio[1304]: verbose: ControllerMpd::parseTrackInfo Mar 15 09:11:49 volumio volumio[1304]: info: ControllerMpd::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::servicePushState Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:49 volumio volumio[1304]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sky","artist":"Harmonium","album":"Chillout Connection, Vol. 2","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-141.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6e5842289e366c1c0dfb53aec2e8022fa5c4f3a6265affe76451ea28d628365a%2Clid%3D1560%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e263a6%2F0%2F48938%2F7b06b3b0.80892785.16.51285594%2Fflac&ext=.flac","trackType":"flac"} Mar 15 09:11:49 volumio volumio[1304]: verbose: CURRENT POSITION 0 Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::syncState stateService play Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::syncState currentStatus play Mar 15 09:11:49 volumio volumio[1304]: info: Received an update from plugin. extracting info from payload Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioPushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioPushState Mar 15 09:11:49 volumio volumio[1304]: info: ControllerMpd::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::servicePushState Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:49 volumio volumio[1304]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sky","artist":"Harmonium","album":"Chillout Connection, Vol. 2","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-141.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6e5842289e366c1c0dfb53aec2e8022fa5c4f3a6265affe76451ea28d628365a%2Clid%3D1560%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e263a6%2F0%2F48938%2F7b06b3b0.80892785.16.51285594%2Fflac&ext=.flac","trackType":"flac"} Mar 15 09:11:49 volumio volumio[1304]: verbose: CURRENT POSITION 0 Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::syncState stateService play Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::syncState currentStatus play Mar 15 09:11:49 volumio volumio[1304]: info: Received an update from plugin. extracting info from payload Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioPushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioPushState Mar 15 09:11:49 volumio volumio[1304]: info: ControllerMpd::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::servicePushState Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getTrack 0 Mar 15 09:11:49 volumio volumio[1304]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sky","artist":"Harmonium","album":"Chillout Connection, Vol. 2","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-141.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6e5842289e366c1c0dfb53aec2e8022fa5c4f3a6265affe76451ea28d628365a%2Clid%3D1560%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e263a6%2F0%2F48938%2F7b06b3b0.80892785.16.51285594%2Fflac&ext=.flac","trackType":"flac"} Mar 15 09:11:49 volumio volumio[1304]: verbose: CURRENT POSITION 0 Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::syncState stateService play Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::syncState currentStatus play Mar 15 09:11:49 volumio volumio[1304]: info: Received an update from plugin. extracting info from payload Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioPushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::pushState Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioPushState Mar 15 09:11:49 volumio volumio[1304]: info: ------------------------------ 23ms Mar 15 09:11:49 volumio volumio[1304]: info: ------------------------------ 20ms Mar 15 09:11:49 volumio volumio[1304]: info: ------------------------------ 21ms Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioGetQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioGetQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioGetQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioGetQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioGetQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioGetQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioGetQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioGetQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioGetQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::volumioGetQueue Mar 15 09:11:49 volumio volumio[1304]: info: CoreStateMachine::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: CorePlayQueue::getQueue Mar 15 09:11:49 volumio volumio[1304]: info: Updating MyVolumio device info Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:49 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:50 volumio wpa_supplicant[1194]: wlan0: Associated with 52:ff:20:8c:00:c5 Mar 15 09:11:50 volumio dhcpcd[1206]: wlan0: carrier lost Mar 15 09:11:50 volumio wpa_supplicant[1194]: wlan0: CTRL-EVENT-CONNECTED - Connection to 52:ff:20:8c:00:c5 completed [id=0 id_str=] Mar 15 09:11:50 volumio wpa_supplicant[1194]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 15 09:11:50 volumio avahi-daemon[824]: Withdrawing address record for 192.168.1.41 on wlan0. Mar 15 09:11:50 volumio avahi-daemon[824]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.41. Mar 15 09:11:50 volumio dhcpcd[1206]: wlan0: deleting route to 192.168.1.0/24 Mar 15 09:11:50 volumio dhcpcd[1206]: wlan0: deleting default route via 192.168.1.1 Mar 15 09:11:50 volumio avahi-daemon[824]: Interface wlan0.IPv4 no longer relevant for mDNS. Mar 15 09:11:50 volumio volumio[1304]: info: Discovery: A device disappeared from network Mar 15 09:11:50 volumio volumio[1304]: info: Discovery: Device volumio disappeared from network Mar 15 09:11:50 volumio dhcpcd[1206]: wlan0: carrier acquired Mar 15 09:11:50 volumio dhcpcd[1206]: wlan0: IAID 67:66:5f:20 Mar 15 09:11:50 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 15 09:11:50 volumio volumio[1304]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 15 09:11:50 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 15 09:11:50 volumio volumio[1304]: info: Received Get System Version Mar 15 09:11:50 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 15 09:11:50 volumio volumio[1304]: info: Received Get System Info Mar 15 09:11:50 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 15 09:11:50 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 15 09:11:50 volumio volumio[1304]: info: Discovery: Getting this device information Mar 15 09:11:50 volumio volumio[1304]: info: CoreCommandRouter::volumioGetState Mar 15 09:11:50 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 15 09:11:51 volumio dhcpcd[1206]: wlan0: soliciting an IPv6 router Mar 15 09:11:51 volumio dhcpcd[1206]: wlan0: soliciting a DHCP lease Mar 15 09:11:51 volumio dhcpcd[1206]: wlan0: offered 192.168.1.41 from 192.168.1.1 Mar 15 09:11:51 volumio ntpd[1010]: Deleting interface #3 wlan0, 192.168.1.41#123, interface stats: received=0, sent=0, dropped=0, active_time=25 secs Mar 15 09:11:51 volumio dhcpcd[1206]: wlan0: probing address 192.168.1.41/24 Mar 15 09:11:54 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 15 09:11:54 volumio volumio[1304]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 15 09:11:54 volumio volumio[1304]: info: CoreCommandRouter::volumioGetState Mar 15 09:11:56 volumio dhcpcd[1206]: wlan0: leased 192.168.1.41 for 25200 seconds Mar 15 09:11:56 volumio avahi-daemon[824]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.41. Mar 15 09:11:56 volumio dhcpcd[1206]: wlan0: adding route to 192.168.1.0/24 Mar 15 09:11:56 volumio dhcpcd[1206]: wlan0: adding default route via 192.168.1.1 Mar 15 09:11:56 volumio avahi-daemon[824]: New relevant interface wlan0.IPv4 for mDNS. Mar 15 09:11:56 volumio avahi-daemon[824]: Registering new address record for 192.168.1.41 on wlan0.IPv4. Mar 15 09:11:57 volumio ntpd[1010]: Listen normally on 4 wlan0 192.168.1.41:123 Mar 15 09:11:57 volumio ntpd[1010]: new interface(s) found: waking up resolver Mar 15 09:11:58 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 15 09:11:58 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:11:58 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 15 09:11:58 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 15 09:11:58 volumio volumio-remote-updater[817]: No test mode Mar 15 09:11:58 volumio volumio-remote-updater[817]: No alpha test mode Mar 15 09:11:58 volumio volumio[1304]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

 

NEW ADDITIONS

 

","title":"Update v3.795","updateavailable":true} Mar 15 09:11:58 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 15 09:11:59 volumio systemd[1]: systemd-timedated.service: Succeeded. Mar 15 09:11:59 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 15 09:11:59 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 15 09:11:59 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 15 09:11:59 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 15 09:11:59 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 15 09:11:59 volumio volumio[1304]: info: CoreCommandRouter::volumioGetBrowseSources Mar 15 09:11:59 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 15 09:12:00 volumio volumio[1304]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 15 09:12:00 volumio volumio[1304]: info: Completed starting MyVolumio Plugin Mar 15 09:12:00 volumio volumio[1304]: [Metrics] CommandRouter: 33s 700.34ms Mar 15 09:12:00 volumio volumio[1304]: info: CoreCommandRouter::volumiosetStartupVolume Mar 15 09:12:00 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 15 09:12:00 volumio volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 09:12:00 volumio volumio[1304]: info: CoreCommandRouter::Close All Modals sent Mar 15 09:12:00 volumio volumio[1304]: info: CoreCommandRouter::Close All Modals sent Mar 15 09:12:00 volumio volumio[1304]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Mar 15 09:12:00 volumio volumio[1304]: aplay: main:828: audio open error: Device or resource busy Mar 15 09:12:00 volumio volumio[1304]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 15 09:12:00 volumio volumio[1304]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 15 09:12:00 volumio volumio[1304]: Error: read ECONNRESET Mar 15 09:12:00 volumio volumio[1304]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) { Mar 15 09:12:00 volumio volumio[1304]: errno: -104, Mar 15 09:12:00 volumio volumio[1304]: code: 'ECONNRESET', Mar 15 09:12:00 volumio volumio[1304]: syscall: 'read' Mar 15 09:12:00 volumio volumio[1304]: } Mar 15 09:12:00 volumio volumio[1304]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 15 09:12:01 volumio sudo[2331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-15 09:11 Mar 15 09:12:01 volumio sudo[2331]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"