-- Logs begin at Thu 2019-02-14 05:11:58 EST, end at Sun 2025-05-04 11:13:55 EDT. -- May 04 11:13:21 volumio volumio[1166]: info: Shairport-Sync Started May 04 11:13:21 volumio volumio[1166]: Error adding Membership: Error: addMembership EINVAL May 04 11:13:21 volumio systemd-timedated[1432]: Changed local time to Sun May 4 11:13:21 2025 May 04 11:13:21 volumio volumio[1166]: info: Shairport-Sync Started May 04 11:13:21 volumio volumio[1166]: info: touch_display: X display number found: May 04 11:13:21 volumio volumio[1166]: info: Shairport-Sync Started May 04 11:13:21 volumio sudo[1415]: pam_unix(sudo:session): session closed for user root May 04 11:13:21 volumio volumio-time-update[836]: volumio-time-update-util: System time updated successfully. May 04 11:13:21 volumio systemd[1]: Started Volumio Time Update Utility. May 04 11:13:21 volumio sudo[1449]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 04 11:13:21 volumio sudo[1449]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 11:13:21 volumio sudo[1449]: pam_unix(sudo:session): session closed for user root May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 04 11:13:21 volumio startx[1430]: X.Org X Server 1.20.4 May 04 11:13:21 volumio startx[1430]: X Protocol Version 11, Revision 0 May 04 11:13:21 volumio startx[1430]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian May 04 11:13:21 volumio startx[1430]: Current Operating System: Linux volumio 6.6.62-v8+ #1816 SMP PREEMPT Mon Nov 18 15:35:52 GMT 2024 aarch64 May 04 11:13:21 volumio startx[1430]: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe cgroup_disable=memory numa_policy=interleave smsc95xx.macaddr=2C:CF:67:72:B3:E9 vc_mem.mem_base=0x3fc00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyAMA10,115200 console=tty1 imgpart=UUID=35e4e60f-5b83-4298-b8fb-dded911033bb imgfile=/volumio_current.sqsh bootpart=UUID=9744-01A5 datapart=UUID=671f4730-2491-45d9-ba08-57ee2c6a1695 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no cfg80211.ieee80211_regdom=GB May 04 11:13:21 volumio startx[1430]: Build Date: 04 April 2023 07:50:56AM May 04 11:13:21 volumio startx[1430]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) May 04 11:13:21 volumio startx[1430]: Current version of pixman: 0.36.0 May 04 11:13:21 volumio startx[1430]: Before reporting problems, check http://wiki.x.org May 04 11:13:21 volumio startx[1430]: to make sure that you have the latest version. May 04 11:13:21 volumio startx[1430]: Markers: (--) probed, (**) from config file, (==) default setting, May 04 11:13:21 volumio startx[1430]: (++) from command line, (!!) notice, (II) informational, May 04 11:13:21 volumio startx[1430]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. May 04 11:13:21 volumio startx[1430]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun May 4 11:13:21 2025 May 04 11:13:21 volumio startx[1430]: (==) Using config directory: "/etc/X11/xorg.conf.d" May 04 11:13:21 volumio startx[1430]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" May 04 11:13:21 volumio nmbd[906]: [2025/05/04 11:13:21.066143, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 04 11:13:21 volumio systemd[1]: Started Samba NMB Daemon. May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::volumioGetVisibleSources May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState May 04 11:13:21 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 04 11:13:21 volumio volumio[1166]: info: Received Get System Info May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 11:13:21 volumio volumio[1166]: info: Discovery: Getting this device information May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState May 04 11:13:21 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState May 04 11:13:21 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 May 04 11:13:21 volumio volumio[1166]: info: Listing playlists May 04 11:13:21 volumio nmbd[906]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 04 11:13:21 volumio systemd[1]: Starting Samba Winbind Daemon... May 04 11:13:21 volumio volumio[1166]: info: touch_display: X display number found: 0 May 04 11:13:21 volumio volumio[1166]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 04 11:13:21 volumio winbindd[1462]: [2025/05/04 11:13:21.200324, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 04 11:13:21 volumio winbindd[1462]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 04 11:13:21 volumio volumio[1166]: info: touch_display: X display number found: 0 May 04 11:13:21 volumio winbindd[1462]: [2025/05/04 11:13:21.225436, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 04 11:13:21 volumio systemd[1]: Started Samba Winbind Daemon. May 04 11:13:21 volumio winbindd[1462]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 04 11:13:21 volumio mpd[1461]: May 04 11:13 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 04 11:13:21 volumio systemd[1]: Starting Samba SMB Daemon... May 04 11:13:21 volumio systemd[1]: Started Music Player Daemon. May 04 11:13:21 volumio sudo[1376]: pam_unix(sudo:session): session closed for user root May 04 11:13:21 volumio sudo[1391]: pam_unix(sudo:session): session closed for user root May 04 11:13:21 volumio volumio[1166]: error: MPD error: The expression evaluated to a falsy value: May 04 11:13:21 volumio volumio[1166]: assert.ok(self.idling) May 04 11:13:21 volumio volumio[1166]: error: The expression evaluated to a falsy value: May 04 11:13:21 volumio volumio[1166]: assert.ok(self.idling) May 04 11:13:21 volumio volumio[1166]: error: updateQueue error: null May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 11:13:21 volumio volumio[1166]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 11:13:21 volumio volumio[1166]: info: FusionDsp - May 04 11:13:21 volumio volumio[1166]: info: FusionDsp - May 04 11:13:21 volumio volumio[1166]: info: FusionDsp - undefined May 04 11:13:21 volumio volumio[1166]: info: FusionDsp - May 04 11:13:21 volumio smbd[1476]: [2025/05/04 11:13:21.511349, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 04 11:13:21 volumio smbd[1476]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 04 11:13:21 volumio systemd[1]: Started Samba SMB Daemon. May 04 11:13:21 volumio systemd[1]: Reached target Multi-User System. May 04 11:13:21 volumio systemd[1]: Reached target Graphical Interface. May 04 11:13:21 volumio volumio[1166]: info: FusionDsp - undefined May 04 11:13:21 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... May 04 11:13:21 volumio volumio[1166]: info: FusionDsp - May 04 11:13:21 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 04 11:13:21 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. May 04 11:13:21 volumio systemd[1]: Startup finished in 11.108s (kernel) + 28.928s (userspace) = 40.036s. May 04 11:13:21 volumio volumio[1166]: info: FusionDsp - May 04 11:13:21 volumio volumio[1166]: info: FusionDsp - undefined May 04 11:13:21 volumio volumio[1166]: info: FusionDsp - undefined May 04 11:13:21 volumio volumio[1166]: info: FusionDsp - undefined May 04 11:13:22 volumio startx[1430]: V3D 7.1 not supported by this version of Mesa. May 04 11:13:22 volumio kernel: broken atomic modeset userspace detected, disabling atomic May 04 11:13:22 volumio volumio[1166]: info: camilladsp service started and running in background, instance 1 May 04 11:13:22 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 11:13:22 volumio volumio[1166]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA May 04 11:13:22 volumio volumio[1166]: info: FusionDsp loaded May 04 11:13:22 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 11:13:22 volumio sudo[1503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service May 04 11:13:22 volumio sudo[1503]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 11:13:22 volumio volumio[1166]: info: FusionDsp - Reporting Fusion DSP Enabled May 04 11:13:22 volumio volumio[1166]: info: Adding Signal Path Element [object Object] May 04 11:13:22 volumio volumio[1166]: info: Adding fusiondspeq DSP Signal Path Element May 04 11:13:22 volumio volumio[1166]: info: FusionDsp - ---- installed callbackRead May 04 11:13:22 volumio volumio[1166]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 04 11:13:22 volumio volumio[1166]: error: FusionDsp - WebSocket error: [object Object] May 04 11:13:22 volumio volumio[1166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 May 04 11:13:22 volumio systemd[1]: Started FusionDsp Daemon. May 04 11:13:22 volumio sudo[1503]: pam_unix(sudo:session): session closed for user root May 04 11:13:22 volumio startx[1430]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. May 04 11:13:22 volumio sudo[1211]: pam_unix(sudo:session): session closed for user root May 04 11:13:22 volumio volumio[1166]: info: touch_display: Setting screensaver timeout to 120 seconds. May 04 11:13:23 volumio volumio[1166]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.54 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 May 04 11:13:24 volumio systemd[1]: systemd-fsckd.service: Succeeded. May 04 11:13:24 volumio sh[696]: timed out May 04 11:13:24 volumio dhcpcd[755]: timed out May 04 11:13:24 volumio sh[696]: dhcpcd exited May 04 11:13:24 volumio dhcpcd[755]: dhcpcd exited May 04 11:13:24 volumio sh[696]: ifup: failed to bring up eth0 May 04 11:13:24 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE May 04 11:13:24 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. May 04 11:13:25 volumio volumio[1166]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory May 04 11:13:25 volumio systemd[1]: systemd-hostnamed.service: Succeeded. May 04 11:13:27 volumio volumio-remote-updater[831]: [2025-05-04 11:13:27] [connect] Successful connection May 04 11:13:27 volumio volumio-remote-updater[831]: [2025-05-04 11:13:27] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1746371607 101 May 04 11:13:27 volumio volumio[1166]: 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: 8 May 04 11:13:28 volumio sudo[1721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 04 11:13:28 volumio sudo[1721]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 11:13:28 volumio sudo[1721]: pam_unix(sudo:session): session closed for user root May 04 11:13:28 volumio sudo[1723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 04 11:13:28 volumio sudo[1723]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 11:13:28 volumio sudo[1723]: pam_unix(sudo:session): session closed for user root May 04 11:13:28 volumio sudo[1727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 04 11:13:28 volumio sudo[1727]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 11:13:28 volumio sudo[1727]: pam_unix(sudo:session): session closed for user root May 04 11:13:28 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 04 11:13:28 volumio volumio[1166]: info: Upmpdcli Daemon Started May 04 11:13:28 volumio volumio[1729]: Generating RSA private key, 4096 bit long modulus (2 primes) May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 04 11:13:29 volumio volumio[1166]: info: Adding plugin bluetooth to MyMusic Plugins May 04 11:13:29 volumio volumio[1166]: info: Adding plugin multiroom to MyMusic Plugins May 04 11:13:29 volumio volumio[1166]: info: Adding plugin metavolumio to MyMusic Plugins May 04 11:13:29 volumio volumio[1166]: info: Adding plugin cd_controller to MyMusic Plugins May 04 11:13:29 volumio volumio[1166]: info: Adding plugin smart_inputs to MyMusic Plugins May 04 11:13:29 volumio volumio[1166]: info: Adding plugin tidalconnect to MyMusic Plugins May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 04 11:13:29 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 04 11:13:29 volumio volumio[1166]: info: Starting MyVolumio Remote Streaming Endpoints May 04 11:13:29 volumio volumio[1166]: info: MyVolumio login type: Token May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 04 11:13:29 volumio volumio[1166]: info: Starting Streaming Service Transparent Proxy May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 04 11:13:29 volumio volumio[1166]: info: Streaming services startup May 04 11:13:29 volumio volumio[1166]: info: Starting Streaming Daemon May 04 11:13:29 volumio sudo[1758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 04 11:13:29 volumio sudo[1758]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 11:13:29 volumio sudo[1758]: pam_unix(sudo:session): session closed for user root May 04 11:13:29 volumio volumio[1166]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started May 04 11:13:30 volumio volumio[1166]: error: Cannot start Volumio Streaming Daemon May 04 11:13:30 volumio volumio[1166]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 04 11:13:30 volumio volumio[1166]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 04 11:13:30 volumio volumio[1166]: 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: 9 May 04 11:13:30 volumio volumio[1166]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN May 04 11:13:30 volumio volumio[1166]: STREAMING PROXY: Starting server on port 3245 May 04 11:13:30 volumio volumio[1166]: Node JS runtime: 14 May 04 11:13:30 volumio volumio[1166]: 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: 10 May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::volumioGetVisibleSources May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState May 04 11:13:30 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 04 11:13:30 volumio volumio[1166]: info: Received Get System Info May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 11:13:30 volumio volumio[1166]: info: Discovery: Getting this device information May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState May 04 11:13:30 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState May 04 11:13:30 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 May 04 11:13:30 volumio volumio[1166]: info: Listing playlists May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 04 11:13:30 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 04 11:13:31 volumio volumio[1166]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 11:13:31 volumio volumio[1166]: info: FusionDsp - May 04 11:13:31 volumio volumio[1166]: info: FusionDsp - undefined May 04 11:13:31 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState May 04 11:13:31 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 May 04 11:13:32 volumio volumio[1729]: ........................................................................++++ May 04 11:13:32 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 04 11:13:32 volumio volumio[1166]: info: Received Get System Info May 04 11:13:32 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 11:13:32 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 11:13:32 volumio volumio[1166]: info: Discovery: Getting this device information May 04 11:13:32 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState May 04 11:13:32 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 May 04 11:13:32 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 11:13:32 volumio volumio[1729]: ....++++ May 04 11:13:32 volumio volumio[1729]: e is 65537 (0x010001) May 04 11:13:32 volumio volumio[1729]: writing RSA key May 04 11:13:32 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 04 11:13:33 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 04 11:13:33 volumio volumio[1166]: info: Received Get System Info May 04 11:13:33 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 11:13:33 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 11:13:33 volumio volumio[1166]: info: Discovery: Getting this device information May 04 11:13:33 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState May 04 11:13:33 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 May 04 11:13:33 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 11:13:40 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 04 11:13:44 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 04 11:13:44 volumio volumio[1166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 May 04 11:13:44 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState May 04 11:13:44 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 May 04 11:13:47 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: system , installToDisk May 04 11:13:47 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: networkfs , disableDeviceActions May 04 11:13:47 volumio volumio[1166]: info: Mount handler: device actions disabled May 04 11:13:51 volumio systemd[1]: systemd-timedated.service: Succeeded. May 04 11:13:55 volumio kernel: nvme nvme0: controller is down; will reset: CSTS=0xffffffff, PCI_STATUS=0x10 May 04 11:13:55 volumio kernel: nvme nvme0: Does your device have a faulty power saving mode enabled? May 04 11:13:55 volumio kernel: nvme nvme0: Try "nvme_core.default_ps_max_latency_us=0 pcie_aspm=off pcie_port_pm=off" and report a bug May 04 11:13:55 volumio kernel: nvme0n1: I/O Cmd(0x2) @ LBA 2920, 1 blocks, I/O Error (sct 0x3 / sc 0x71) May 04 11:13:55 volumio kernel: I/O error, dev nvme0n1, sector 2920 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 May 04 11:13:55 volumio kernel: nvme 0000:01:00.0: enabling device (0000 -> 0002) May 04 11:13:55 volumio kernel: nvme nvme0: Disabling device after reset failure: -19 May 04 11:13:55 volumio volumio[1166]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 11:13:55 volumio kernel: I/O error, dev nvme0n1, sector 108293 op 0x1:(WRITE) flags 0x100000 phys_seg 1 prio class 2 May 04 11:13:55 volumio kernel: I/O error, dev nvme0n1, sector 856 op 0x1:(WRITE) flags 0x100000 phys_seg 1 prio class 2 May 04 11:13:55 volumio kernel: Buffer I/O error on dev nvme0n1p1, logical block 855, lost async page write May 04 11:13:55 volumio kernel: I/O error, dev nvme0n1, sector 1035 op 0x1:(WRITE) flags 0x100000 phys_seg 1 prio class 2 May 04 11:13:55 volumio kernel: Buffer I/O error on dev nvme0n1p1, logical block 1034, lost async page write May 04 11:13:55 volumio kernel: I/O error, dev nvme0n1, sector 2299 op 0x1:(WRITE) flags 0x100000 phys_seg 1 prio class 2 May 04 11:13:55 volumio kernel: Buffer I/O error on dev nvme0n1p1, logical block 2298, lost async page write May 04 11:13:55 volumio kernel: I/O error, dev nvme0n1, sector 2478 op 0x1:(WRITE) flags 0x100000 phys_seg 1 prio class 2 May 04 11:13:55 volumio kernel: Buffer I/O error on dev nvme0n1p1, logical block 2477, lost async page write May 04 11:13:55 volumio kernel: I/O error, dev nvme0n1, sector 2919 op 0x1:(WRITE) flags 0x100000 phys_seg 1 prio class 2 May 04 11:13:55 volumio kernel: Buffer I/O error on dev nvme0n1p1, logical block 2918, lost async page write May 04 11:13:55 volumio kernel: I/O error, dev nvme0n1, sector 2 op 0x1:(WRITE) flags 0x100000 phys_seg 1 prio class 2 May 04 11:13:55 volumio kernel: Buffer I/O error on dev nvme0n1p1, logical block 1, lost async page write May 04 11:13:55 volumio volumio[1166]: Error: EIO: i/o error, read May 04 11:13:55 volumio volumio[1166]: at Object.readSync (fs.js:592:3) May 04 11:13:55 volumio volumio[1166]: at tryReadSync (fs.js:366:20) May 04 11:13:55 volumio volumio[1166]: at Object.readFileSync (fs.js:395:19) May 04 11:13:55 volumio volumio[1166]: at ControllerSystem.installToDisk (/volumio/app/plugins/system_controller/system/index.js:1098:22) May 04 11:13:55 volumio volumio[1166]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) May 04 11:13:55 volumio volumio[1166]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1816:44) May 04 11:13:55 volumio volumio[1166]: at Socket.emit (events.js:315:20) May 04 11:13:55 volumio volumio[1166]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 May 04 11:13:55 volumio volumio[1166]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { May 04 11:13:55 volumio volumio[1166]: errno: -5, May 04 11:13:55 volumio volumio[1166]: syscall: 'read', May 04 11:13:55 volumio volumio[1166]: code: 'EIO' May 04 11:13:55 volumio volumio[1166]: } May 04 11:13:55 volumio volumio[1166]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 11:13:55 volumio sudo[2053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-04 11:12 May 04 11:13:55 volumio sudo[2053]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"