-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2024-06-04 20:48:02 CEST. -- Jun 04 20:47:00 volumio firststart.sh[895]: Creating /var/log/samba/cores folder Jun 04 20:47:00 volumio winbindd[892]: [2024/06/04 18:47:00.168199, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 04 20:47:00 volumio winbindd[892]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jun 04 20:47:00 volumio systemd[1]: Started Samba Winbind Daemon. Jun 04 20:47:00 volumio firststart.sh[895]: Creating /boot/userconfig.txt Jun 04 20:47:00 volumio firststart.sh[895]: Removing default SSH host keys Jun 04 20:47:00 volumio firststart.sh[895]: removed '/etc/ssh/ssh_host_ecdsa_key' Jun 04 20:47:00 volumio firststart.sh[895]: removed '/etc/ssh/ssh_host_ecdsa_key.pub' Jun 04 20:47:00 volumio firststart.sh[895]: removed '/etc/ssh/ssh_host_ed25519_key' Jun 04 20:47:00 volumio firststart.sh[895]: removed '/etc/ssh/ssh_host_ed25519_key.pub' Jun 04 20:47:00 volumio firststart.sh[895]: removed '/etc/ssh/ssh_host_rsa_key' Jun 04 20:47:00 volumio firststart.sh[895]: removed '/etc/ssh/ssh_host_rsa_key.pub' Jun 04 20:47:00 volumio firststart.sh[895]: Generating SSH host keys Jun 04 20:47:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:00 volumio systemd[1]: Starting Samba SMB Daemon... Jun 04 20:47:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:01 volumio sh[541]: eth0: leased 192.168.1.105 for 28800 seconds Jun 04 20:47:01 volumio dhcpcd[585]: eth0: leased 192.168.1.105 for 28800 seconds Jun 04 20:47:01 volumio sh[541]: eth0: adding route to 192.168.1.0/24 Jun 04 20:47:01 volumio sh[541]: eth0: adding default route via 192.168.1.2 Jun 04 20:47:01 volumio avahi-daemon[646]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.105. Jun 04 20:47:01 volumio dhcpcd[585]: eth0: adding route to 192.168.1.0/24 Jun 04 20:47:01 volumio avahi-daemon[646]: New relevant interface eth0.IPv4 for mDNS. Jun 04 20:47:01 volumio dhcpcd[585]: eth0: adding default route via 192.168.1.2 Jun 04 20:47:01 volumio avahi-daemon[646]: Registering new address record for 192.168.1.105 on eth0.IPv4. Jun 04 20:47:02 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:02 volumio dnsmasq[883]: reading /etc/resolv.conf Jun 04 20:47:02 volumio dnsmasq[883]: using nameserver 192.168.0.1#53 Jun 04 20:47:02 volumio dnsmasq[883]: using nameserver 192.168.2.1#53 Jun 04 20:47:02 volumio dnsmasq[883]: using nameserver 8.8.8.8#53 Jun 04 20:47:02 volumio dnsmasq[883]: using nameserver 208.67.222.222#53 Jun 04 20:47:02 volumio dnsmasq[883]: using nameserver 208.67.220.220#53 Jun 04 20:47:02 volumio sh[541]: forked to background, child pid 946 Jun 04 20:47:02 volumio dhcpcd[585]: forked to background, child pid 946 Jun 04 20:47:02 volumio smbd[921]: [2024/06/04 18:47:02.819137, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 04 20:47:02 volumio smbd[921]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jun 04 20:47:02 volumio systemd[1]: Started Samba SMB Daemon. Jun 04 20:47:02 volumio systemd[1]: Reached target Multi-User System. Jun 04 20:47:02 volumio systemd[1]: Reached target Graphical Interface. Jun 04 20:47:02 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:02 volumio ntpd[764]: Listen normally on 4 eth0 192.168.1.105:123 Jun 04 20:47:02 volumio ntpd[764]: new interface(s) found: waking up resolver Jun 04 20:47:02 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 04 20:47:02 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 04 20:47:02 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 04 20:47:02 volumio systemd[1]: Startup finished in 43.416s (kernel) + 19.801s (userspace) = 1min 3.217s. Jun 04 20:47:02 volumio ifplugd(eth0)[767]: client: ifup: interface eth0 already configured Jun 04 20:47:02 volumio sh[541]: eth0=eth0 Jun 04 20:47:03 volumio ifplugd(eth0)[767]: Program executed successfully. Jun 04 20:47:03 volumio volumio-remote-updater[628]: [2024-06-04 18:47:03] [info] asio async_connect error: system:111 (Connection refused) Jun 04 20:47:03 volumio volumio-remote-updater[628]: [2024-06-04 18:47:03] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 04 20:47:03 volumio volumio-remote-updater[628]: [2024-06-04 18:47:03] [error] handle_connect error: Underlying Transport Error Jun 04 20:47:04 volumio firststart.sh[895]: debconf: unable to initialize frontend: Dialog Jun 04 20:47:04 volumio firststart.sh[895]: debconf: (TERM is not set, so the dialog frontend is not usable.) Jun 04 20:47:04 volumio firststart.sh[895]: debconf: falling back to frontend: Readline Jun 04 20:47:04 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:04 volumio firststart.sh[895]: debconf: unable to initialize frontend: Readline Jun 04 20:47:04 volumio firststart.sh[895]: debconf: (This frontend requires a controlling tty.) Jun 04 20:47:04 volumio firststart.sh[895]: debconf: falling back to frontend: Teletype Jun 04 20:47:06 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:07 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:07 volumio volumio[894]: info: ------------------------------------------- Jun 04 20:47:07 volumio volumio[894]: info: ----- Volumio3 ---- Jun 04 20:47:07 volumio volumio[894]: info: ------------------------------------------- Jun 04 20:47:07 volumio volumio[894]: info: ----- System startup ---- Jun 04 20:47:07 volumio volumio[894]: info: ------------------------------------------- Jun 04 20:47:07 volumio firststart.sh[895]: Creating SSH2 RSA key; this may take some time ... Jun 04 20:47:07 volumio firststart.sh[895]: 2048 SHA256:w7Pggm9DFZeOqiAaffOe4tgT+bA/EwcAiILGUe5VP9Y root@volumio (RSA) Jun 04 20:47:08 volumio volumio[894]: info: File /data/configuration/plugins.json does not exist. Copying from Volumio Jun 04 20:47:08 volumio volumio[894]: info: MYVOLUMIO Environment detected Jun 04 20:47:08 volumio volumio[894]: info: Plugin folders cleanup Jun 04 20:47:08 volumio volumio[894]: info: Scanning into folder /volumio/app/plugins/ Jun 04 20:47:08 volumio volumio[894]: info: Scanning category audio_interface Jun 04 20:47:08 volumio volumio[894]: info: Scanning category miscellanea Jun 04 20:47:08 volumio volumio[894]: info: Scanning category music_service Jun 04 20:47:08 volumio volumio[894]: info: Scanning category plugins.json Jun 04 20:47:08 volumio volumio[894]: info: Scanning category system_controller Jun 04 20:47:08 volumio volumio[894]: info: Scanning category user_interface Jun 04 20:47:08 volumio volumio[894]: info: Scanning into folder /data/plugins/ Jun 04 20:47:08 volumio volumio[894]: info: Plugin folders cleanup completed Jun 04 20:47:08 volumio volumio[894]: info: ------------------------------------------- Jun 04 20:47:08 volumio volumio[894]: info: ----- Core plugins startup ---- Jun 04 20:47:08 volumio volumio[894]: info: ------------------------------------------- Jun 04 20:47:08 volumio volumio[894]: info: Loading plugins from folder /volumio/app/plugins/ Jun 04 20:47:08 volumio volumio[894]: info: Adding plugin upnp to MyMusic Plugins Jun 04 20:47:08 volumio volumio[894]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 04 20:47:08 volumio volumio[894]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 04 20:47:08 volumio volumio[894]: info: Loading plugins from folder /data/plugins/ Jun 04 20:47:08 volumio volumio[894]: info: Loading plugin "system"... Jun 04 20:47:08 volumio volumio[894]: info: No id defined. Creating one Jun 04 20:47:08 volumio volumio[894]: info: Loading plugin "appearance"... Jun 04 20:47:09 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:09 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:09 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:09 volumio volumio[894]: info: Loading plugin "network"... Jun 04 20:47:09 volumio volumio[894]: info: Refreshing Cached IP Addresses Jun 04 20:47:09 volumio sudo[1101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 04 20:47:09 volumio sudo[1101]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:09 volumio sudo[1101]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:09 volumio sudo[1103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 04 20:47:09 volumio sudo[1103]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:09 volumio volumio[894]: info: Loading plugin "services"... Jun 04 20:47:09 volumio sudo[1103]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:09 volumio volumio[894]: info: Loading plugin "alsa_controller"... Jun 04 20:47:09 volumio sudo[1107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 04 20:47:09 volumio sudo[1107]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:10 volumio volumio[894]: warn: The ALSA output card is not set, defaulting to card [object Object] Jun 04 20:47:10 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 04 20:47:10 volumio volumio[894]: info: Found match in Cards Database: setting mixer PCM for card HDMI Out Jun 04 20:47:10 volumio volumio[894]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 04 20:47:10 volumio volumio[894]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 04 20:47:10 volumio volumio[894]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 04 20:47:10 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 04 20:47:10 volumio volumio[894]: info: Loading plugin "wizard"... Jun 04 20:47:10 volumio volumio[894]: info: Loading plugin "networkfs"... Jun 04 20:47:10 volumio volumio[894]: info: Starting Udev Watcher for removable devices Jun 04 20:47:10 volumio volumio[894]: info: Ignoring mount for partition: boot Jun 04 20:47:10 volumio volumio[894]: info: Ignoring mount for partition: volumio Jun 04 20:47:10 volumio volumio[894]: info: Ignoring mount for partition: volumio_data Jun 04 20:47:10 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 04 20:47:10 volumio volumio[894]: info: Loading plugin "volumio_command_line_client"... Jun 04 20:47:10 volumio volumio[894]: info: Loading plugin "upnp"... Jun 04 20:47:10 volumio volumio[894]: info: [1717526830457] Starting Upmpd Daemon Jun 04 20:47:10 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 04 20:47:10 volumio volumio[894]: info: Loading plugin "my_music"... Jun 04 20:47:10 volumio volumio[894]: info: Loading plugin "mpd"... Jun 04 20:47:10 volumio firststart.sh[895]: Creating SSH2 DSA key; this may take some time ... Jun 04 20:47:10 volumio firststart.sh[895]: 1024 SHA256:em0H/okUyJpgo8kHfwZxNWaPc+QU78h1etG69ca10Sg root@volumio (DSA) Jun 04 20:47:10 volumio firststart.sh[895]: Creating SSH2 ECDSA key; this may take some time ... Jun 04 20:47:10 volumio firststart.sh[895]: 256 SHA256:0nKtzKz5EY76SVZCLmzipu4irMmgzqduSxn+peiicLA root@volumio (ECDSA) Jun 04 20:47:10 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:10 volumio volumio[894]: info: Loading plugin "upnp_browser"... Jun 04 20:47:10 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:10 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:11 volumio volumio[894]: info: Loading plugin "alarm-clock"... Jun 04 20:47:11 volumio volumio[894]: info: Loading plugin "airplay_emulation"... Jun 04 20:47:11 volumio volumio[894]: info: Starting Shairport Sync Jun 04 20:47:11 volumio volumio[894]: info: Loading plugin "last_100"... Jun 04 20:47:11 volumio volumio[894]: info: Loading plugin "webradio"... Jun 04 20:47:11 volumio volumio[894]: info: Loading plugin "i2s_dacs"... Jun 04 20:47:11 volumio volumio[894]: info: I2S DAC not set, start Auto-detection Jun 04 20:47:11 volumio volumio[894]: info: Loading plugin "volumiodiscovery"... Jun 04 20:47:11 volumio volumio[894]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:11 volumio volumio[894]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:11 volumio volumio[894]: *** WARNING *** For more information see Jun 04 20:47:11 volumio node[894]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:11 volumio volumio[894]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:11 volumio volumio[894]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:11 volumio volumio[894]: *** WARNING *** For more information see Jun 04 20:47:11 volumio node[894]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:11 volumio node[894]: *** WARNING *** For more information see Jun 04 20:47:11 volumio node[894]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:11 volumio node[894]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:11 volumio node[894]: *** WARNING *** For more information see Jun 04 20:47:11 volumio volumio[894]: info: Discovery: Started advertising with name: Volumio Jun 04 20:47:11 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 04 20:47:11 volumio volumio[894]: info: Loading plugin "outputs"... Jun 04 20:47:11 volumio volumio[894]: info: Loading plugin "albumart"... Jun 04 20:47:11 volumio volumio[894]: info: Plugin example_plugin is not enabled Jun 04 20:47:11 volumio volumio[894]: info: Loading plugin "inputs"... Jun 04 20:47:11 volumio volumio[894]: info: Loading plugin "updater_comm"... Jun 04 20:47:11 volumio systemd[1]: Reloading. Jun 04 20:47:11 volumio volumio[894]: info: Plugin mpdemulation is not enabled Jun 04 20:47:11 volumio volumio[894]: info: Loading plugin "rest_api"... Jun 04 20:47:11 volumio volumio[894]: info: Loading plugin "websocket"... Jun 04 20:47:11 volumio volumio[894]: info: Starting Socket.io Server version 2.3.0 Jun 04 20:47:11 volumio volumio[894]: info: Loading i18n strings for locale en Jun 04 20:47:11 volumio volumio[894]: Updating browse sources language Jun 04 20:47:11 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:11 volumio volumio[894]: Forking 3 albumart workers Jun 04 20:47:12 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::initPlayerControls Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 20:47:12 volumio volumio[894]: Express server listening on port 3000 Jun 04 20:47:12 volumio volumio[894]: [Metrics] WebUI: 7s 56.99ms Jun 04 20:47:12 volumio volumio[894]: info: CoreStateMachine::resetVolumioState Jun 04 20:47:12 volumio volumio[894]: info: CoreStateMachine::getcurrentVolume Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::volumioRetrievevolume Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:12 volumio volumio[894]: info: Cannot read play queue from file Jun 04 20:47:12 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Jun 04 20:47:12 volumio volumio[894]: info: VolumeController:: Volume=86 Mute =false Jun 04 20:47:12 volumio volumio[894]: info: CoreStateMachine::pushState Jun 04 20:47:12 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:12 volumio volumio[894]: info: CoreStateMachine::updateTrackBlock Jun 04 20:47:12 volumio volumio[894]: info: CorePlayQueue::getTrackBlock Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::volumioRetrievevolume Jun 04 20:47:12 volumio volumio[894]: info: Setting Device type: Raspberry PI Jun 04 20:47:12 volumio volumio[894]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 04 20:47:12 volumio volumio[894]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 Jun 04 20:47:12 volumio volumio[894]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 04 20:47:12 volumio firststart.sh[895]: rescue-ssh.target is a disabled or a static unit, not starting it. Jun 04 20:47:12 volumio volumio[894]: info: Discovery: adding undefined Jun 04 20:47:12 volumio volumio[894]: info: Discovery: Found device Volumio Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::volumioGetState Jun 04 20:47:12 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:12 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:12 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:12 volumio volumio[894]: info: Discovery: this is already registered, undefined Jun 04 20:47:12 volumio volumio[894]: info: Discovery: Found device Volumio Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::volumioGetState Jun 04 20:47:12 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:12 volumio volumio[894]: info: VolumeController:: Volume=86 Mute =false Jun 04 20:47:12 volumio volumio[894]: info: CoreStateMachine::pushState Jun 04 20:47:12 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:12 volumio volumio[894]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:12 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:12 volumio volumio[894]: Starting albumart workers Jun 04 20:47:12 volumio volumio[894]: Starting albumart workers Jun 04 20:47:12 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:12 volumio volumio[894]: Starting albumart workers Jun 04 20:47:12 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:12 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:13 volumio volumio[894]: info: Completed loading Core Plugins Jun 04 20:47:13 volumio volumio[894]: info: Preparing to generate the ALSA configuration file Jun 04 20:47:13 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:13 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:13 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:13 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:13 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:13 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:13 volumio kernel: I/O error, dev mmcblk0, sector 1380408 op 0x0:(READ) flags 0x80700 phys_seg 17 prio class 2 Jun 04 20:47:13 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:13 volumio sudo[1107]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:13 volumio volumio-remote-updater[628]: [2024-06-04 18:47:13] [connect] Successful connection Jun 04 20:47:13 volumio volumio-remote-updater[628]: [2024-06-04 18:47:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1717526833 101 Jun 04 20:47:14 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:14 volumio kernel: I/O error, dev mmcblk0, sector 1381936 op 0x0:(READ) flags 0x80700 phys_seg 14 prio class 2 Jun 04 20:47:15 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: I/O error, dev mmcblk0, sector 1381936 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:15 volumio kernel: I/O error, dev loop0, sector 898592 op 0x0:(READ) flags 0x800 phys_seg 33 prio class 2 Jun 04 20:47:15 volumio kernel: SQUASHFS error: Failed to read block 0x1b6c437e: -5 Jun 04 20:47:15 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: I/O error, dev mmcblk0, sector 1374936 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: I/O error, dev mmcblk0, sector 1374936 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:15 volumio kernel: I/O error, dev loop0, sector 891570 op 0x0:(READ) flags 0x800 phys_seg 33 prio class 2 Jun 04 20:47:15 volumio kernel: SQUASHFS error: Failed to read block 0x1b356789: -5 Jun 04 20:47:15 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: I/O error, dev mmcblk0, sector 1380408 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:15 volumio kernel: I/O error, dev loop0, sector 896910 op 0x0:(READ) flags 0x800 phys_seg 11 prio class 2 Jun 04 20:47:15 volumio kernel: SQUASHFS error: Failed to read block 0x1b5f1c1d: -5 Jun 04 20:47:15 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:15 volumio kernel: I/O error, dev mmcblk0, sector 1380488 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:15 volumio kernel: SQUASHFS error: Failed to read block 0x1b611c1d: -5 Jun 04 20:47:16 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: SQUASHFS error: Failed to read block 0xd6f8ac4: -5 Jun 04 20:47:16 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: SQUASHFS error: Failed to read block 0x1b515638: -5 Jun 04 20:47:16 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: SQUASHFS error: Failed to read block 0xd74a331: -5 Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:16 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:17 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:17 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:17 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:17 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:17 volumio kernel: SQUASHFS error: Failed to read block 0xd755117: -5 Jun 04 20:47:17 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:17 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:17 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:17 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:17 volumio kernel: SQUASHFS error: Failed to read block 0xd74a331: -5 Jun 04 20:47:17 volumio kernel: SQUASHFS error: Unable to read data cache entry [d74a331] Jun 04 20:47:17 volumio kernel: SQUASHFS error: Unable to read page, block d74a331, size ade6 Jun 04 20:47:17 volumio kernel: SQUASHFS error: Unable to read data cache entry [d74a331] Jun 04 20:47:17 volumio kernel: SQUASHFS error: Unable to read page, block d74a331, size ade6 Jun 04 20:47:17 volumio volumio-remote-updater[628]: [2024-06-04 18:47:17] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 04 20:47:17 volumio volumio-remote-updater[628]: [2024-06-04 18:47:17] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 04 20:47:17 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=7/BUS Jun 04 20:47:17 volumio systemd[1]: volumio.service: Failed with result 'signal'. Jun 04 20:47:17 volumio firststart.sh[895]: insserv: warning: current start runlevel(s) (empty) of script `ssh' overrides LSB defaults (2 3 4 5). Jun 04 20:47:17 volumio firststart.sh[895]: insserv: warning: current stop runlevel(s) (2 3 4 5) of script `ssh' overrides LSB defaults (empty). Jun 04 20:47:17 volumio systemd[1]: Started dynamicswap service. Jun 04 20:47:17 volumio systemd[1]: Reloading. Jun 04 20:47:17 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:17 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jun 04 20:47:17 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 04 20:47:17 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 04 20:47:17 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Jun 04 20:47:17 volumio systemd[1]: Started dynamicswap service. Jun 04 20:47:17 volumio systemd[1]: Stopped Volumio Backend Module. Jun 04 20:47:17 volumio systemd[1]: Started Volumio Backend Module. Jun 04 20:47:18 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 04 20:47:18 volumio systemd[1]: systemd-fsckd.service: Succeeded. Jun 04 20:47:18 volumio firststart.sh[895]: Enabling SSH for first boot Jun 04 20:47:18 volumio systemd[1]: Starting OpenBSD Secure Shell server... Jun 04 20:47:18 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:18 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:19 volumio volumio[1267]: info: ------------------------------------------- Jun 04 20:47:19 volumio volumio[1267]: info: ----- Volumio3 ---- Jun 04 20:47:19 volumio volumio[1267]: info: ------------------------------------------- Jun 04 20:47:19 volumio volumio[1267]: info: ----- System startup ---- Jun 04 20:47:19 volumio volumio[1267]: info: ------------------------------------------- Jun 04 20:47:19 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:19 volumio kernel: blk_print_req_error: 15 callbacks suppressed Jun 04 20:47:19 volumio kernel: I/O error, dev mmcblk0, sector 1306240 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:19 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:19 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:19 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:19 volumio kernel: I/O error, dev mmcblk0, sector 1306240 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:19 volumio kernel: I/O error, dev loop0, sector 822916 op 0x0:(READ) flags 0x800 phys_seg 18 prio class 2 Jun 04 20:47:19 volumio kernel: SQUASHFS error: Failed to read block 0x191d094d: -5 Jun 04 20:47:19 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:19 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:19 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:19 volumio kernel: I/O error, dev mmcblk0, sector 1306240 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:19 volumio kernel: I/O error, dev loop0, sector 822916 op 0x0:(READ) flags 0x800 phys_seg 18 prio class 2 Jun 04 20:47:19 volumio kernel: SQUASHFS error: Failed to read block 0x191d094d: -5 Jun 04 20:47:19 volumio kernel: SQUASHFS error: Unable to read data cache entry [191d094d] Jun 04 20:47:19 volumio kernel: SQUASHFS error: Unable to read page, block 191d094d, size 10fcb Jun 04 20:47:19 volumio systemd[1289]: ssh.service: Failed to execute command: Input/output error Jun 04 20:47:19 volumio systemd[1289]: ssh.service: Failed at step EXEC spawning /usr/sbin/sshd: Input/output error Jun 04 20:47:19 volumio firststart.sh[895]: Job for ssh.service failed because the control process exited with error code. Jun 04 20:47:19 volumio firststart.sh[895]: See "systemctl status ssh.service" and "journalctl -xe" for details. Jun 04 20:47:19 volumio systemd[1]: ssh.service: Control process exited, code=exited, status=203/EXEC Jun 04 20:47:19 volumio systemd[1]: ssh.service: Failed with result 'exit-code'. Jun 04 20:47:19 volumio systemd[1]: Failed to start OpenBSD Secure Shell server. Jun 04 20:47:19 volumio systemd[1]: firststart.service: Main process exited, code=exited, status=1/FAILURE Jun 04 20:47:19 volumio systemd[1]: firststart.service: Failed with result 'exit-code'. Jun 04 20:47:19 volumio volumio[1267]: info: MYVOLUMIO Environment detected Jun 04 20:47:19 volumio systemd[1]: ssh.service: Service RestartSec=100ms expired, scheduling restart. Jun 04 20:47:19 volumio systemd[1]: ssh.service: Scheduled restart job, restart counter is at 1. Jun 04 20:47:19 volumio systemd[1]: Stopped OpenBSD Secure Shell server. Jun 04 20:47:19 volumio volumio[1267]: info: Plugin folders cleanup Jun 04 20:47:19 volumio volumio[1267]: info: Scanning into folder /volumio/app/plugins/ Jun 04 20:47:19 volumio volumio[1267]: info: Scanning category audio_interface Jun 04 20:47:19 volumio volumio[1267]: info: Scanning category miscellanea Jun 04 20:47:19 volumio volumio[1267]: info: Scanning category music_service Jun 04 20:47:19 volumio volumio[1267]: info: Scanning category plugins.json Jun 04 20:47:19 volumio volumio[1267]: info: Scanning category system_controller Jun 04 20:47:19 volumio volumio[1267]: info: Scanning category user_interface Jun 04 20:47:19 volumio volumio[1267]: info: Scanning into folder /data/plugins/ Jun 04 20:47:19 volumio volumio[1267]: info: Plugin folders cleanup completed Jun 04 20:47:19 volumio volumio[1267]: info: ------------------------------------------- Jun 04 20:47:19 volumio volumio[1267]: info: ----- Core plugins startup ---- Jun 04 20:47:19 volumio volumio[1267]: info: ------------------------------------------- Jun 04 20:47:19 volumio volumio[1267]: info: Loading plugins from folder /volumio/app/plugins/ Jun 04 20:47:19 volumio volumio[1267]: info: Adding plugin upnp to MyMusic Plugins Jun 04 20:47:19 volumio volumio[1267]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 04 20:47:19 volumio volumio[1267]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 04 20:47:19 volumio volumio[1267]: info: Loading plugins from folder /data/plugins/ Jun 04 20:47:19 volumio volumio[1267]: info: Loading plugin "system"... Jun 04 20:47:19 volumio systemd[1]: Starting OpenBSD Secure Shell server... Jun 04 20:47:19 volumio systemd[1295]: ssh.service: Failed to execute command: Input/output error Jun 04 20:47:19 volumio systemd[1295]: ssh.service: Failed at step EXEC spawning /usr/sbin/sshd: Input/output error Jun 04 20:47:19 volumio systemd[1]: ssh.service: Control process exited, code=exited, status=203/EXEC Jun 04 20:47:19 volumio systemd[1]: ssh.service: Failed with result 'exit-code'. Jun 04 20:47:19 volumio systemd[1]: Failed to start OpenBSD Secure Shell server. Jun 04 20:47:19 volumio kernel: SQUASHFS error: Unable to read data cache entry [191d094d] Jun 04 20:47:19 volumio kernel: SQUASHFS error: Unable to read page, block 191d094d, size 10fcb Jun 04 20:47:19 volumio volumio[1267]: info: Loading plugin "appearance"... Jun 04 20:47:19 volumio systemd[1]: ssh.service: Service RestartSec=100ms expired, scheduling restart. Jun 04 20:47:19 volumio systemd[1]: ssh.service: Scheduled restart job, restart counter is at 2. Jun 04 20:47:19 volumio systemd[1]: Stopped OpenBSD Secure Shell server. Jun 04 20:47:19 volumio systemd[1299]: ssh.service: Failed to execute command: Input/output error Jun 04 20:47:19 volumio systemd[1299]: ssh.service: Failed at step EXEC spawning /usr/sbin/sshd: Input/output error Jun 04 20:47:19 volumio systemd[1]: Starting OpenBSD Secure Shell server... Jun 04 20:47:19 volumio systemd[1]: ssh.service: Control process exited, code=exited, status=203/EXEC Jun 04 20:47:19 volumio systemd[1]: ssh.service: Failed with result 'exit-code'. Jun 04 20:47:19 volumio systemd[1]: Failed to start OpenBSD Secure Shell server. Jun 04 20:47:19 volumio kernel: SQUASHFS error: Unable to read data cache entry [191d094d] Jun 04 20:47:19 volumio kernel: SQUASHFS error: Unable to read page, block 191d094d, size 10fcb Jun 04 20:47:19 volumio systemd[1]: ssh.service: Service RestartSec=100ms expired, scheduling restart. Jun 04 20:47:19 volumio systemd[1]: ssh.service: Scheduled restart job, restart counter is at 3. Jun 04 20:47:19 volumio systemd[1]: Stopped OpenBSD Secure Shell server. Jun 04 20:47:20 volumio systemd[1300]: ssh.service: Failed to execute command: Input/output error Jun 04 20:47:20 volumio systemd[1300]: ssh.service: Failed at step EXEC spawning /usr/sbin/sshd: Input/output error Jun 04 20:47:20 volumio systemd[1]: Starting OpenBSD Secure Shell server... Jun 04 20:47:20 volumio systemd[1]: ssh.service: Control process exited, code=exited, status=203/EXEC Jun 04 20:47:20 volumio systemd[1]: ssh.service: Failed with result 'exit-code'. Jun 04 20:47:20 volumio systemd[1]: Failed to start OpenBSD Secure Shell server. Jun 04 20:47:20 volumio kernel: SQUASHFS error: Unable to read data cache entry [191d094d] Jun 04 20:47:20 volumio kernel: SQUASHFS error: Unable to read page, block 191d094d, size 10fcb Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "network"... Jun 04 20:47:20 volumio volumio[1267]: info: Refreshing Cached IP Addresses Jun 04 20:47:20 volumio sudo[1302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 04 20:47:20 volumio sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:20 volumio sudo[1302]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:20 volumio sudo[1304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "services"... Jun 04 20:47:20 volumio sudo[1304]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "alsa_controller"... Jun 04 20:47:20 volumio sudo[1304]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:20 volumio sudo[1307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 04 20:47:20 volumio sudo[1307]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:20 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "wizard"... Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "networkfs"... Jun 04 20:47:20 volumio systemd[1]: ssh.service: Service RestartSec=100ms expired, scheduling restart. Jun 04 20:47:20 volumio systemd[1]: ssh.service: Scheduled restart job, restart counter is at 4. Jun 04 20:47:20 volumio systemd[1]: Stopped OpenBSD Secure Shell server. Jun 04 20:47:20 volumio volumio[1267]: info: Starting Udev Watcher for removable devices Jun 04 20:47:20 volumio volumio[1267]: info: Ignoring mount for partition: boot Jun 04 20:47:20 volumio volumio[1267]: info: Ignoring mount for partition: volumio Jun 04 20:47:20 volumio volumio[1267]: info: Ignoring mount for partition: volumio_data Jun 04 20:47:20 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "volumio_command_line_client"... Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "upnp"... Jun 04 20:47:20 volumio volumio[1267]: info: [1717526840238] Starting Upmpd Daemon Jun 04 20:47:20 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "my_music"... Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "mpd"... Jun 04 20:47:20 volumio systemd[1]: Starting OpenBSD Secure Shell server... Jun 04 20:47:20 volumio systemd[1314]: ssh.service: Failed to execute command: Input/output error Jun 04 20:47:20 volumio systemd[1314]: ssh.service: Failed at step EXEC spawning /usr/sbin/sshd: Input/output error Jun 04 20:47:20 volumio systemd[1]: ssh.service: Control process exited, code=exited, status=203/EXEC Jun 04 20:47:20 volumio systemd[1]: ssh.service: Failed with result 'exit-code'. Jun 04 20:47:20 volumio systemd[1]: Failed to start OpenBSD Secure Shell server. Jun 04 20:47:20 volumio kernel: SQUASHFS error: Unable to read data cache entry [191d094d] Jun 04 20:47:20 volumio kernel: SQUASHFS error: Unable to read page, block 191d094d, size 10fcb Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "upnp_browser"... Jun 04 20:47:20 volumio systemd[1]: ssh.service: Service RestartSec=100ms expired, scheduling restart. Jun 04 20:47:20 volumio systemd[1]: ssh.service: Scheduled restart job, restart counter is at 5. Jun 04 20:47:20 volumio systemd[1]: Stopped OpenBSD Secure Shell server. Jun 04 20:47:20 volumio systemd[1]: ssh.service: Start request repeated too quickly. Jun 04 20:47:20 volumio systemd[1]: ssh.service: Failed with result 'exit-code'. Jun 04 20:47:20 volumio systemd[1]: Failed to start OpenBSD Secure Shell server. Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "alarm-clock"... Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "airplay_emulation"... Jun 04 20:47:20 volumio volumio[1267]: info: Starting Shairport Sync Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "last_100"... Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "webradio"... Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "i2s_dacs"... Jun 04 20:47:20 volumio volumio[1267]: info: I2S DAC not set, start Auto-detection Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "volumiodiscovery"... Jun 04 20:47:20 volumio volumio[1267]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:20 volumio volumio[1267]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:20 volumio node[1267]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:20 volumio volumio[1267]: *** WARNING *** For more information see Jun 04 20:47:20 volumio volumio[1267]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:20 volumio volumio[1267]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:20 volumio volumio[1267]: *** WARNING *** For more information see Jun 04 20:47:20 volumio node[1267]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:20 volumio node[1267]: *** WARNING *** For more information see Jun 04 20:47:20 volumio node[1267]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:20 volumio node[1267]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:20 volumio node[1267]: *** WARNING *** For more information see Jun 04 20:47:20 volumio volumio[1267]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 04 20:47:20 volumio volumio[1267]: info: Discovery: Started advertising with name: Volumio Jun 04 20:47:20 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "outputs"... Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "albumart"... Jun 04 20:47:20 volumio volumio[1267]: info: Plugin example_plugin is not enabled Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "inputs"... Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "updater_comm"... Jun 04 20:47:20 volumio volumio[1267]: info: Plugin mpdemulation is not enabled Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "rest_api"... Jun 04 20:47:20 volumio volumio[1267]: info: Loading plugin "websocket"... Jun 04 20:47:20 volumio volumio[1267]: info: Starting Socket.io Server version 2.3.0 Jun 04 20:47:20 volumio volumio[1267]: info: Loading i18n strings for locale en Jun 04 20:47:20 volumio volumio[1267]: Updating browse sources language Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:21 volumio volumio[1267]: Forking 3 albumart workers Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::initPlayerControls Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 20:47:21 volumio volumio[1267]: Express server listening on port 3000 Jun 04 20:47:21 volumio volumio[1267]: [Metrics] WebUI: 2s 457.58ms Jun 04 20:47:21 volumio volumio[1267]: info: CoreStateMachine::resetVolumioState Jun 04 20:47:21 volumio volumio[1267]: info: CoreStateMachine::getcurrentVolume Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::volumioRetrievevolume Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:21 volumio volumio[1267]: info: Cannot read play queue from file Jun 04 20:47:21 volumio volumio[1267]: info: VolumeController:: Volume=86 Mute =false Jun 04 20:47:21 volumio volumio[1267]: info: CoreStateMachine::pushState Jun 04 20:47:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:21 volumio volumio[1267]: info: CoreStateMachine::updateTrackBlock Jun 04 20:47:21 volumio volumio[1267]: info: CorePlayQueue::getTrackBlock Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::volumioRetrievevolume Jun 04 20:47:21 volumio volumio[1267]: info: CoreStateMachine::setRepeat null single undefined Jun 04 20:47:21 volumio volumio[1267]: info: CoreStateMachine::pushState Jun 04 20:47:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:21 volumio volumio[1267]: info: CoreStateMachine::setRandom null Jun 04 20:47:21 volumio volumio[1267]: info: CoreStateMachine::pushState Jun 04 20:47:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:21 volumio volumio[1267]: info: Setting Device type: Raspberry PI Jun 04 20:47:21 volumio volumio[1267]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 04 20:47:21 volumio volumio[1267]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 Jun 04 20:47:21 volumio volumio[1267]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 04 20:47:21 volumio volumio[1267]: info: Completed loading Core Plugins Jun 04 20:47:21 volumio volumio[1267]: info: Preparing to generate the ALSA configuration file Jun 04 20:47:21 volumio volumio[1267]: info: Asound.conf file written Jun 04 20:47:21 volumio sudo[1359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 04 20:47:21 volumio sudo[1359]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:21 volumio sudo[1359]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:21 volumio volumio[1267]: No state is present for card b1 Jun 04 20:47:21 volumio volumio[1267]: /usr/share/alsa/init/bcm2835:14: control element not found Jun 04 20:47:21 volumio volumio[1267]: No state is present for card b1 Jun 04 20:47:21 volumio volumio[1267]: No state is present for card Headphones Jun 04 20:47:21 volumio volumio[1267]: /usr/share/alsa/init/bcm2835:20: control element not found Jun 04 20:47:21 volumio volumio[1267]: No state is present for card Headphones Jun 04 20:47:21 volumio volumio[1267]: info: Output device has changed, restarting MPD Jun 04 20:47:21 volumio volumio[1267]: info: Output device has changed, restarting Shairport Sync Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:21 volumio sudo[1365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 04 20:47:21 volumio sudo[1367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 04 20:47:21 volumio sudo[1367]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:21 volumio sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:21 volumio volumio[1267]: Starting albumart workers Jun 04 20:47:21 volumio volumio[1267]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 04 20:47:21 volumio volumio[1267]: info: ___________ START PLUGINS ___________ Jun 04 20:47:21 volumio systemd[1]: Listening on mpd.socket. Jun 04 20:47:21 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:21 volumio volumio[1267]: Starting albumart workers Jun 04 20:47:21 volumio volumio[1267]: Starting albumart workers Jun 04 20:47:21 volumio sudo[1375]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:21 volumio sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:21 volumio sudo[1375]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:21 volumio sudo[1375]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:22 volumio volumio-remote-updater[628]: [2024-06-04 18:47:22] [connect] Successful connection Jun 04 20:47:22 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:22 volumio volumio[1267]: info: Setting Hotspot Unique name on first start: Volumio-488D6 Jun 04 20:47:22 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: network , getConfigParam Jun 04 20:47:22 volumio volumio[1267]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getConfigParam] in plugin network Jun 04 20:47:22 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings Jun 04 20:47:22 volumio volumio[1267]: info: CoreCommandRouter::Reload Ui Jun 04 20:47:22 volumio volumio[1267]: info: ControllerMpd::onStart: Initializing MPD Jun 04 20:47:22 volumio volumio[1267]: info: Creating MPD Configuration file Jun 04 20:47:22 volumio sudo[1403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 04 20:47:22 volumio sudo[1403]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:22 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 20:47:22 volumio volumio[1267]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 04 20:47:22 volumio volumio[1267]: info: [1717526842454] CoreMusicLibrary::Adding element Media Servers Jun 04 20:47:22 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:22 volumio sudo[1405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 04 20:47:22 volumio sudo[1405]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:22 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:22 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:22 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:22 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Jun 04 20:47:22 volumio sudo[1365]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:22 volumio sudo[1403]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:22 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:23 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:23 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:23 volumio kernel: I/O error, dev mmcblk0, sector 860672 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:23 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:23 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:23 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:23 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:23 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:23 volumio kernel: I/O error, dev mmcblk0, sector 860672 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:23 volumio kernel: I/O error, dev loop0, sector 393732 op 0x0:(READ) flags 0x800 phys_seg 9 prio class 2 Jun 04 20:47:23 volumio kernel: SQUASHFS error: Failed to read block 0xc040a4e: -5 Jun 04 20:47:23 volumio volumio[1267]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 04 20:47:23 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:23 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:23 volumio volumio[1267]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 04 20:47:23 volumio volumio[1267]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 04 20:47:23 volumio volumio[1267]: info: [1717526843199] CoreMusicLibrary::Adding element Last_100 Jun 04 20:47:23 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:23 volumio volumio[1267]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 04 20:47:23 volumio volumio[1267]: info: [1717526843201] CoreMusicLibrary::Adding element Webradio Jun 04 20:47:23 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:23 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 04 20:47:23 volumio volumio[1267]: info: Initializing BBC Radios Jun 04 20:47:23 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:23 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:23 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 04 20:47:23 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:23 volumio volumio[1267]: info: Volumio Calling Home Jun 04 20:47:23 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:23 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:23 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:23 volumio kernel: I/O error, dev mmcblk0, sector 860680 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:23 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:23 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:23 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:23 volumio sudo[1307]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:23 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:23 volumio kernel: I/O error, dev mmcblk0, sector 860688 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:23 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: I/O error, dev mmcblk0, sector 860688 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:24 volumio kernel: I/O error, dev loop0, sector 393732 op 0x0:(READ) flags 0x800 phys_seg 10 prio class 2 Jun 04 20:47:24 volumio kernel: SQUASHFS error: Failed to read block 0xc040a4e: -5 Jun 04 20:47:24 volumio kernel: SQUASHFS error: Unable to read data cache entry [c040a4e] Jun 04 20:47:24 volumio kernel: SQUASHFS error: Unable to read page, block c040a4e, size c067 Jun 04 20:47:24 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 04 20:47:24 volumio systemd[1]: mpd.service: Succeeded. Jun 04 20:47:24 volumio systemd[1]: Stopped Music Player Daemon. Jun 04 20:47:24 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:24 volumio sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Jun 04 20:47:24 volumio sudo[1430]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio sudo[1428]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:24 volumio sudo[1428]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:24 volumio sudo[1428]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:24 volumio sudo[1428]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:24 volumio volumio[1267]: info: MPD Permissions set Jun 04 20:47:24 volumio volumio[1267]: info: MPD Permissions set Jun 04 20:47:24 volumio volumio[1267]: info: VolumeController:: Volume=86 Mute =false Jun 04 20:47:24 volumio volumio[1267]: info: CoreStateMachine::pushState Jun 04 20:47:24 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:24 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:24 volumio volumio-remote-updater[628]: [2024-06-04 18:47:24] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1717526842 101 Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio sudo[1430]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:24 volumio kernel: I/O error, dev mmcblk0, sector 846976 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: I/O error, dev mmcblk0, sector 846976 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:24 volumio kernel: I/O error, dev loop0, sector 380026 op 0x0:(READ) flags 0x800 phys_seg 2 prio class 2 Jun 04 20:47:24 volumio kernel: SQUASHFS error: Failed to read block 0xb98f5e2: -5 Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: I/O error, dev mmcblk0, sector 907856 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:24 volumio kernel: I/O error, dev loop0, sector 440912 op 0x0:(READ) flags 0x800 phys_seg 12 prio class 2 Jun 04 20:47:24 volumio kernel: SQUASHFS error: Failed to read block 0xd74a331: -5 Jun 04 20:47:24 volumio kernel: SQUASHFS error: Unable to read data cache entry [d74a331] Jun 04 20:47:24 volumio kernel: SQUASHFS error: Unable to read page, block d74a331, size ade6 Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: I/O error, dev mmcblk0, sector 846976 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:24 volumio kernel: I/O error, dev loop0, sector 380026 op 0x0:(READ) flags 0x800 phys_seg 2 prio class 2 Jun 04 20:47:24 volumio kernel: SQUASHFS error: Failed to read block 0xb98f5e2: -5 Jun 04 20:47:24 volumio kernel: SQUASHFS error: Unable to read data cache entry [b98f5e2] Jun 04 20:47:24 volumio kernel: SQUASHFS error: Unable to read page, block b98f5e2, size cae Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio systemd[1433]: mpd.service: Failed to execute command: Input/output error Jun 04 20:47:24 volumio systemd[1433]: mpd.service: Failed at step EXEC spawning /usr/bin/mpd: Input/output error Jun 04 20:47:24 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=203/EXEC Jun 04 20:47:24 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:24 volumio kernel: I/O error, dev mmcblk0, sector 860688 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:24 volumio kernel: SQUASHFS error: Failed to read block 0xc040a4e: -5 Jun 04 20:47:24 volumio kernel: SQUASHFS error: Unable to read data cache entry [c040a4e] Jun 04 20:47:24 volumio kernel: SQUASHFS error: Unable to read page, block c040a4e, size c067 Jun 04 20:47:24 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:24 volumio sudo[1405]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:24 volumio sudo[1367]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: SQUASHFS error: Failed to read block 0xb98f5e2: -5 Jun 04 20:47:24 volumio kernel: SQUASHFS error: Unable to read data cache entry [b98f5e2] Jun 04 20:47:24 volumio kernel: SQUASHFS error: Unable to read page, block b98f5e2, size cae Jun 04 20:47:24 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:24 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:25 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:25 volumio kernel: SQUASHFS error: Failed to read block 0xd74a331: -5 Jun 04 20:47:25 volumio kernel: SQUASHFS error: Unable to read data cache entry [d74a331] Jun 04 20:47:25 volumio kernel: SQUASHFS error: Unable to read page, block d74a331, size ade6 Jun 04 20:47:25 volumio kernel: SQUASHFS error: Unable to read data cache entry [d74a331] Jun 04 20:47:25 volumio kernel: SQUASHFS error: Unable to read page, block d74a331, size ade6 Jun 04 20:47:25 volumio kernel: SQUASHFS error: Unable to read data cache entry [d74a331] Jun 04 20:47:25 volumio kernel: SQUASHFS error: Unable to read page, block d74a331, size ade6 Jun 04 20:47:25 volumio volumio-remote-updater[628]: [2024-06-04 18:47:25] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 04 20:47:25 volumio volumio-remote-updater[628]: [2024-06-04 18:47:25] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 04 20:47:25 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=7/BUS Jun 04 20:47:25 volumio systemd[1]: volumio.service: Failed with result 'signal'. Jun 04 20:47:25 volumio systemd[1]: Started dynamicswap service. Jun 04 20:47:25 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 04 20:47:25 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:25 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 04 20:47:25 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Jun 04 20:47:25 volumio systemd[1]: Started dynamicswap service. Jun 04 20:47:25 volumio systemd[1]: Stopped Volumio Backend Module. Jun 04 20:47:25 volumio systemd[1]: Started Volumio Backend Module. Jun 04 20:47:25 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 04 20:47:26 volumio volumio[1441]: info: ------------------------------------------- Jun 04 20:47:26 volumio volumio[1441]: info: ----- Volumio3 ---- Jun 04 20:47:26 volumio volumio[1441]: info: ------------------------------------------- Jun 04 20:47:26 volumio volumio[1441]: info: ----- System startup ---- Jun 04 20:47:26 volumio volumio[1441]: info: ------------------------------------------- Jun 04 20:47:26 volumio volumio[1441]: info: MYVOLUMIO Environment detected Jun 04 20:47:26 volumio volumio[1441]: info: Plugin folders cleanup Jun 04 20:47:26 volumio volumio[1441]: info: Scanning into folder /volumio/app/plugins/ Jun 04 20:47:26 volumio volumio[1441]: info: Scanning category audio_interface Jun 04 20:47:26 volumio volumio[1441]: info: Scanning category miscellanea Jun 04 20:47:26 volumio volumio[1441]: info: Scanning category music_service Jun 04 20:47:26 volumio volumio[1441]: info: Scanning category plugins.json Jun 04 20:47:26 volumio volumio[1441]: info: Scanning category system_controller Jun 04 20:47:26 volumio volumio[1441]: info: Scanning category user_interface Jun 04 20:47:26 volumio volumio[1441]: info: Scanning into folder /data/plugins/ Jun 04 20:47:26 volumio volumio[1441]: info: Plugin folders cleanup completed Jun 04 20:47:26 volumio volumio[1441]: info: ------------------------------------------- Jun 04 20:47:26 volumio volumio[1441]: info: ----- Core plugins startup ---- Jun 04 20:47:26 volumio volumio[1441]: info: ------------------------------------------- Jun 04 20:47:26 volumio volumio[1441]: info: Loading plugins from folder /volumio/app/plugins/ Jun 04 20:47:26 volumio volumio[1441]: info: Adding plugin upnp to MyMusic Plugins Jun 04 20:47:26 volumio volumio[1441]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 04 20:47:26 volumio volumio[1441]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 04 20:47:26 volumio volumio[1441]: info: Loading plugins from folder /data/plugins/ Jun 04 20:47:26 volumio volumio[1441]: info: Loading plugin "system"... Jun 04 20:47:26 volumio volumio[1441]: info: Loading plugin "appearance"... Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "network"... Jun 04 20:47:27 volumio volumio[1441]: info: Refreshing Cached IP Addresses Jun 04 20:47:27 volumio sudo[1467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 04 20:47:27 volumio sudo[1467]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:27 volumio sudo[1467]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:27 volumio sudo[1469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 04 20:47:27 volumio sudo[1469]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "services"... Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "alsa_controller"... Jun 04 20:47:27 volumio sudo[1469]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:27 volumio sudo[1472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 04 20:47:27 volumio sudo[1472]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:27 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "wizard"... Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "networkfs"... Jun 04 20:47:27 volumio volumio[1441]: info: Starting Udev Watcher for removable devices Jun 04 20:47:27 volumio volumio[1441]: info: Ignoring mount for partition: boot Jun 04 20:47:27 volumio volumio[1441]: info: Ignoring mount for partition: volumio Jun 04 20:47:27 volumio volumio[1441]: info: Ignoring mount for partition: volumio_data Jun 04 20:47:27 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "volumio_command_line_client"... Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "upnp"... Jun 04 20:47:27 volumio volumio[1441]: info: [1717526847431] Starting Upmpd Daemon Jun 04 20:47:27 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "my_music"... Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "mpd"... Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "upnp_browser"... Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "alarm-clock"... Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "airplay_emulation"... Jun 04 20:47:27 volumio volumio[1441]: info: Starting Shairport Sync Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "last_100"... Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "webradio"... Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "i2s_dacs"... Jun 04 20:47:27 volumio volumio[1441]: info: I2S DAC not set, start Auto-detection Jun 04 20:47:27 volumio volumio[1441]: info: Loading plugin "volumiodiscovery"... Jun 04 20:47:27 volumio volumio[1441]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:27 volumio volumio[1441]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:27 volumio volumio[1441]: *** WARNING *** For more information see Jun 04 20:47:27 volumio node[1441]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:27 volumio volumio[1441]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:27 volumio volumio[1441]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:27 volumio volumio[1441]: *** WARNING *** For more information see Jun 04 20:47:27 volumio node[1441]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:27 volumio node[1441]: *** WARNING *** For more information see Jun 04 20:47:27 volumio node[1441]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:27 volumio node[1441]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:27 volumio node[1441]: *** WARNING *** For more information see Jun 04 20:47:27 volumio volumio[1441]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 04 20:47:28 volumio volumio[1441]: info: Discovery: Started advertising with name: Volumio Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 04 20:47:28 volumio volumio[1441]: info: Loading plugin "outputs"... Jun 04 20:47:28 volumio volumio[1441]: info: Loading plugin "albumart"... Jun 04 20:47:28 volumio volumio[1441]: info: Plugin example_plugin is not enabled Jun 04 20:47:28 volumio volumio[1441]: info: Loading plugin "inputs"... Jun 04 20:47:28 volumio volumio[1441]: info: Loading plugin "updater_comm"... Jun 04 20:47:28 volumio volumio[1441]: info: Plugin mpdemulation is not enabled Jun 04 20:47:28 volumio volumio[1441]: info: Loading plugin "rest_api"... Jun 04 20:47:28 volumio volumio[1441]: info: Loading plugin "websocket"... Jun 04 20:47:28 volumio volumio[1441]: info: Starting Socket.io Server version 2.3.0 Jun 04 20:47:28 volumio volumio[1441]: info: Loading i18n strings for locale en Jun 04 20:47:28 volumio volumio[1441]: Updating browse sources language Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:28 volumio volumio[1441]: Forking 3 albumart workers Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::initPlayerControls Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 20:47:28 volumio volumio[1441]: Express server listening on port 3000 Jun 04 20:47:28 volumio volumio[1441]: [Metrics] WebUI: 2s 370.45ms Jun 04 20:47:28 volumio volumio[1441]: info: CoreStateMachine::resetVolumioState Jun 04 20:47:28 volumio volumio[1441]: info: CoreStateMachine::getcurrentVolume Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::volumioRetrievevolume Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:28 volumio volumio[1441]: info: Cannot read play queue from file Jun 04 20:47:28 volumio volumio[1441]: info: CoreStateMachine::setRepeat null single undefined Jun 04 20:47:28 volumio volumio[1441]: info: CoreStateMachine::pushState Jun 04 20:47:28 volumio volumio[1441]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:28 volumio volumio[1441]: info: CoreStateMachine::setRandom null Jun 04 20:47:28 volumio volumio[1441]: info: CoreStateMachine::pushState Jun 04 20:47:28 volumio volumio[1441]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:28 volumio volumio[1441]: info: Setting Device type: Raspberry PI Jun 04 20:47:28 volumio volumio[1441]: info: VolumeController:: Volume=86 Mute =false Jun 04 20:47:28 volumio volumio[1441]: info: CoreStateMachine::pushState Jun 04 20:47:28 volumio volumio[1441]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:28 volumio volumio[1441]: info: CoreStateMachine::updateTrackBlock Jun 04 20:47:28 volumio volumio[1441]: info: CorePlayQueue::getTrackBlock Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::volumioRetrievevolume Jun 04 20:47:28 volumio volumio[1441]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 04 20:47:28 volumio volumio[1441]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 Jun 04 20:47:28 volumio volumio[1441]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 04 20:47:28 volumio volumio[1441]: info: Completed loading Core Plugins Jun 04 20:47:28 volumio volumio[1441]: info: Preparing to generate the ALSA configuration file Jun 04 20:47:28 volumio volumio[1441]: info: Asound.conf file unchanged, so no further update is needed Jun 04 20:47:28 volumio volumio[1441]: info: Output device has changed, restarting MPD Jun 04 20:47:28 volumio volumio[1441]: info: Output device has changed, restarting Shairport Sync Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:28 volumio sudo[1523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 04 20:47:28 volumio sudo[1523]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:28 volumio sudo[1527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 04 20:47:28 volumio sudo[1527]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:28 volumio sudo[1523]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:28 volumio volumio[1441]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 04 20:47:28 volumio volumio[1441]: info: ___________ START PLUGINS ___________ Jun 04 20:47:28 volumio volumio[1441]: info: ControllerMpd::onStart: Initializing MPD Jun 04 20:47:28 volumio volumio[1441]: info: Creating MPD Configuration file Jun 04 20:47:28 volumio volumio[1441]: Starting albumart workers Jun 04 20:47:28 volumio sudo[1534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 04 20:47:28 volumio sudo[1534]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:28 volumio volumio[1441]: Starting albumart workers Jun 04 20:47:28 volumio sudo[1534]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 20:47:28 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 04 20:47:28 volumio volumio[1441]: info: [1717526848953] CoreMusicLibrary::Adding element Media Servers Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:28 volumio volumio[1441]: Starting albumart workers Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:28 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:28 volumio sudo[1536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 04 20:47:28 volumio sudo[1536]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:29 volumio sudo[1531]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:29 volumio sudo[1531]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:29 volumio sudo[1531]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:29 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 04 20:47:29 volumio systemd[1]: mpd.service: Succeeded. Jun 04 20:47:29 volumio systemd[1]: Stopped Music Player Daemon. Jun 04 20:47:29 volumio volumio[1441]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 04 20:47:29 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:29 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:29 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:29 volumio volumio[1441]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 04 20:47:29 volumio volumio[1441]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 04 20:47:29 volumio volumio[1441]: info: [1717526849087] CoreMusicLibrary::Adding element Last_100 Jun 04 20:47:29 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:29 volumio volumio[1441]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 04 20:47:29 volumio volumio[1441]: info: [1717526849090] CoreMusicLibrary::Adding element Webradio Jun 04 20:47:29 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:29 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 04 20:47:29 volumio volumio[1441]: info: Initializing BBC Radios Jun 04 20:47:29 volumio sudo[1541]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:29 volumio sudo[1541]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:29 volumio sudo[1541]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:29 volumio sudo[1541]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:29 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 04 20:47:29 volumio volumio[1441]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:29 volumio volumio[1441]: info: Volumio Calling Home Jun 04 20:47:29 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:29 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:29 volumio volumio[1441]: info: MPD Permissions set Jun 04 20:47:29 volumio volumio[1441]: info: MPD Permissions set Jun 04 20:47:29 volumio volumio[1441]: info: VolumeController:: Volume=86 Mute =false Jun 04 20:47:29 volumio volumio[1441]: info: CoreStateMachine::pushState Jun 04 20:47:29 volumio volumio[1441]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:29 volumio volumio[1441]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:30 volumio volumio-remote-updater[628]: [2024-06-04 18:47:30] [connect] Successful connection Jun 04 20:47:30 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:30 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:30 volumio kernel: blk_print_req_error: 5 callbacks suppressed Jun 04 20:47:30 volumio kernel: I/O error, dev mmcblk0, sector 860688 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:30 volumio kernel: I/O error, dev loop0, sector 393732 op 0x0:(READ) flags 0x800 phys_seg 13 prio class 2 Jun 04 20:47:30 volumio kernel: SQUASHFS error: Failed to read block 0xc040a4e: -5 Jun 04 20:47:30 volumio kernel: SQUASHFS error: Unable to read data cache entry [c040a4e] Jun 04 20:47:30 volumio kernel: SQUASHFS error: Unable to read page, block c040a4e, size c067 Jun 04 20:47:30 volumio systemd[1549]: mpd.service: Failed to execute command: Input/output error Jun 04 20:47:30 volumio systemd[1549]: mpd.service: Failed at step EXEC spawning /usr/bin/mpd: Input/output error Jun 04 20:47:30 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=203/EXEC Jun 04 20:47:30 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:30 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:30 volumio sudo[1527]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:30 volumio sudo[1536]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:30 volumio volumio[1441]: info: Discovery: adding 2c58d28e-7ac5-47a2-934b-79367f84dc17 Jun 04 20:47:30 volumio volumio[1441]: info: Discovery: Found device Volumio Jun 04 20:47:30 volumio volumio[1441]: info: CoreCommandRouter::volumioGetState Jun 04 20:47:30 volumio volumio[1441]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:30 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:30 volumio volumio[1441]: info: Discovery: this is already registered, 2c58d28e-7ac5-47a2-934b-79367f84dc17 Jun 04 20:47:30 volumio volumio[1441]: info: Discovery: Found device Volumio Jun 04 20:47:30 volumio volumio[1441]: info: CoreCommandRouter::volumioGetState Jun 04 20:47:30 volumio volumio[1441]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:30 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:30 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:30 volumio kernel: I/O error, dev mmcblk0, sector 846976 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:30 volumio kernel: I/O error, dev loop0, sector 380026 op 0x0:(READ) flags 0x800 phys_seg 2 prio class 2 Jun 04 20:47:30 volumio kernel: SQUASHFS error: Failed to read block 0xb98f5e2: -5 Jun 04 20:47:30 volumio kernel: SQUASHFS error: Unable to read data cache entry [b98f5e2] Jun 04 20:47:30 volumio kernel: SQUASHFS error: Unable to read page, block b98f5e2, size cae Jun 04 20:47:30 volumio kernel: SQUASHFS error: Unable to read data cache entry [b98f5e2] Jun 04 20:47:30 volumio kernel: SQUASHFS error: Unable to read page, block b98f5e2, size cae Jun 04 20:47:30 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:30 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:30 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:30 volumio kernel: I/O error, dev mmcblk0, sector 907856 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:30 volumio kernel: I/O error, dev loop0, sector 440912 op 0x0:(READ) flags 0x800 phys_seg 12 prio class 2 Jun 04 20:47:30 volumio kernel: SQUASHFS error: Failed to read block 0xd74a331: -5 Jun 04 20:47:30 volumio kernel: SQUASHFS error: Unable to read data cache entry [d74a331] Jun 04 20:47:30 volumio kernel: SQUASHFS error: Unable to read page, block d74a331, size ade6 Jun 04 20:47:30 volumio kernel: SQUASHFS error: Unable to read data cache entry [d74a331] Jun 04 20:47:30 volumio kernel: SQUASHFS error: Unable to read page, block d74a331, size ade6 Jun 04 20:47:30 volumio volumio-remote-updater[628]: [2024-06-04 18:47:30] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Jun 04 20:47:30 volumio volumio-remote-updater[628]: [2024-06-04 18:47:30] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Jun 04 20:47:30 volumio volumio-remote-updater[628]: [2024-06-04 18:47:30] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 04 20:47:30 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=7/BUS Jun 04 20:47:30 volumio sudo[1472]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:30 volumio systemd[1]: volumio.service: Failed with result 'signal'. Jun 04 20:47:30 volumio systemd[1]: Started dynamicswap service. Jun 04 20:47:30 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 04 20:47:30 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 04 20:47:30 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Jun 04 20:47:30 volumio systemd[1]: Stopped Volumio Backend Module. Jun 04 20:47:30 volumio systemd[1]: Started Volumio Backend Module. Jun 04 20:47:30 volumio systemd[1]: Started dynamicswap service. Jun 04 20:47:30 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 04 20:47:31 volumio volumio[1589]: info: ------------------------------------------- Jun 04 20:47:31 volumio volumio[1589]: info: ----- Volumio3 ---- Jun 04 20:47:31 volumio volumio[1589]: info: ------------------------------------------- Jun 04 20:47:31 volumio volumio[1589]: info: ----- System startup ---- Jun 04 20:47:31 volumio volumio[1589]: info: ------------------------------------------- Jun 04 20:47:32 volumio volumio[1589]: info: MYVOLUMIO Environment detected Jun 04 20:47:32 volumio volumio[1589]: info: Plugin folders cleanup Jun 04 20:47:32 volumio volumio[1589]: info: Scanning into folder /volumio/app/plugins/ Jun 04 20:47:32 volumio volumio[1589]: info: Scanning category audio_interface Jun 04 20:47:32 volumio volumio[1589]: info: Scanning category miscellanea Jun 04 20:47:32 volumio volumio[1589]: info: Scanning category music_service Jun 04 20:47:32 volumio volumio[1589]: info: Scanning category plugins.json Jun 04 20:47:32 volumio volumio[1589]: info: Scanning category system_controller Jun 04 20:47:32 volumio volumio[1589]: info: Scanning category user_interface Jun 04 20:47:32 volumio volumio[1589]: info: Scanning into folder /data/plugins/ Jun 04 20:47:32 volumio volumio[1589]: info: Plugin folders cleanup completed Jun 04 20:47:32 volumio volumio[1589]: info: ------------------------------------------- Jun 04 20:47:32 volumio volumio[1589]: info: ----- Core plugins startup ---- Jun 04 20:47:32 volumio volumio[1589]: info: ------------------------------------------- Jun 04 20:47:32 volumio volumio[1589]: info: Loading plugins from folder /volumio/app/plugins/ Jun 04 20:47:32 volumio volumio[1589]: info: Adding plugin upnp to MyMusic Plugins Jun 04 20:47:32 volumio volumio[1589]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 04 20:47:32 volumio volumio[1589]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 04 20:47:32 volumio volumio[1589]: info: Loading plugins from folder /data/plugins/ Jun 04 20:47:32 volumio volumio[1589]: info: Loading plugin "system"... Jun 04 20:47:32 volumio volumio[1589]: info: Loading plugin "appearance"... Jun 04 20:47:32 volumio volumio[1589]: info: Loading plugin "network"... Jun 04 20:47:32 volumio volumio[1589]: info: Refreshing Cached IP Addresses Jun 04 20:47:32 volumio sudo[1616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 04 20:47:32 volumio sudo[1616]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:32 volumio sudo[1616]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:32 volumio sudo[1618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 04 20:47:32 volumio sudo[1618]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:32 volumio volumio[1589]: info: Loading plugin "services"... Jun 04 20:47:32 volumio volumio[1589]: info: Loading plugin "alsa_controller"... Jun 04 20:47:32 volumio sudo[1618]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:32 volumio sudo[1621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 04 20:47:32 volumio sudo[1621]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:32 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 04 20:47:32 volumio volumio[1589]: info: Loading plugin "wizard"... Jun 04 20:47:32 volumio volumio[1589]: info: Loading plugin "networkfs"... Jun 04 20:47:32 volumio volumio[1589]: info: Starting Udev Watcher for removable devices Jun 04 20:47:32 volumio volumio[1589]: info: Ignoring mount for partition: boot Jun 04 20:47:32 volumio volumio[1589]: info: Ignoring mount for partition: volumio Jun 04 20:47:32 volumio volumio[1589]: info: Ignoring mount for partition: volumio_data Jun 04 20:47:32 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 04 20:47:32 volumio volumio[1589]: info: Loading plugin "volumio_command_line_client"... Jun 04 20:47:32 volumio volumio[1589]: info: Loading plugin "upnp"... Jun 04 20:47:32 volumio volumio[1589]: info: [1717526852935] Starting Upmpd Daemon Jun 04 20:47:32 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 04 20:47:32 volumio volumio[1589]: info: Loading plugin "my_music"... Jun 04 20:47:32 volumio volumio[1589]: info: Loading plugin "mpd"... Jun 04 20:47:33 volumio volumio[1589]: info: Loading plugin "upnp_browser"... Jun 04 20:47:33 volumio volumio[1589]: info: Loading plugin "alarm-clock"... Jun 04 20:47:33 volumio volumio[1589]: info: Loading plugin "airplay_emulation"... Jun 04 20:47:33 volumio volumio[1589]: info: Starting Shairport Sync Jun 04 20:47:33 volumio volumio[1589]: info: Loading plugin "last_100"... Jun 04 20:47:33 volumio volumio[1589]: info: Loading plugin "webradio"... Jun 04 20:47:33 volumio volumio[1589]: info: Loading plugin "i2s_dacs"... Jun 04 20:47:33 volumio volumio[1589]: info: I2S DAC not set, start Auto-detection Jun 04 20:47:33 volumio volumio[1589]: info: Loading plugin "volumiodiscovery"... Jun 04 20:47:33 volumio volumio[1589]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:33 volumio node[1589]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:33 volumio volumio[1589]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:33 volumio node[1589]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:33 volumio volumio[1589]: *** WARNING *** For more information see Jun 04 20:47:33 volumio node[1589]: *** WARNING *** For more information see Jun 04 20:47:33 volumio volumio[1589]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:33 volumio node[1589]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 04 20:47:33 volumio volumio[1589]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:33 volumio node[1589]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 04 20:47:33 volumio volumio[1589]: *** WARNING *** For more information see Jun 04 20:47:33 volumio node[1589]: *** WARNING *** For more information see Jun 04 20:47:33 volumio volumio[1589]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 04 20:47:33 volumio volumio[1589]: info: Discovery: Started advertising with name: Volumio Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 04 20:47:33 volumio volumio[1589]: info: Loading plugin "outputs"... Jun 04 20:47:33 volumio volumio[1589]: info: Loading plugin "albumart"... Jun 04 20:47:33 volumio volumio[1589]: info: Plugin example_plugin is not enabled Jun 04 20:47:33 volumio volumio[1589]: info: Loading plugin "inputs"... Jun 04 20:47:33 volumio volumio[1589]: info: Loading plugin "updater_comm"... Jun 04 20:47:33 volumio volumio[1589]: info: Plugin mpdemulation is not enabled Jun 04 20:47:33 volumio volumio[1589]: info: Loading plugin "rest_api"... Jun 04 20:47:33 volumio volumio[1589]: info: Loading plugin "websocket"... Jun 04 20:47:33 volumio volumio[1589]: info: Starting Socket.io Server version 2.3.0 Jun 04 20:47:33 volumio volumio[1589]: info: Loading i18n strings for locale en Jun 04 20:47:33 volumio volumio[1589]: Updating browse sources language Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:33 volumio volumio[1589]: Forking 3 albumart workers Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::initPlayerControls Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 20:47:33 volumio volumio[1589]: Express server listening on port 3000 Jun 04 20:47:33 volumio volumio[1589]: [Metrics] WebUI: 2s 417.50ms Jun 04 20:47:33 volumio volumio[1589]: info: CoreStateMachine::resetVolumioState Jun 04 20:47:33 volumio volumio[1589]: info: CoreStateMachine::getcurrentVolume Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::volumioRetrievevolume Jun 04 20:47:33 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:33 volumio volumio[1589]: info: Cannot read play queue from file Jun 04 20:47:34 volumio volumio[1589]: info: CoreStateMachine::setRepeat null single undefined Jun 04 20:47:34 volumio volumio[1589]: info: CoreStateMachine::pushState Jun 04 20:47:34 volumio volumio[1589]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:34 volumio volumio[1589]: info: CoreStateMachine::setRandom null Jun 04 20:47:34 volumio volumio[1589]: info: CoreStateMachine::pushState Jun 04 20:47:34 volumio volumio[1589]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:34 volumio volumio[1589]: info: Setting Device type: Raspberry PI Jun 04 20:47:34 volumio volumio[1589]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 04 20:47:34 volumio volumio[1589]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 Jun 04 20:47:34 volumio volumio[1589]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 04 20:47:34 volumio volumio[1589]: info: VolumeController:: Volume=86 Mute =false Jun 04 20:47:34 volumio volumio[1589]: info: CoreStateMachine::pushState Jun 04 20:47:34 volumio volumio[1589]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:34 volumio volumio[1589]: info: CoreStateMachine::updateTrackBlock Jun 04 20:47:34 volumio volumio[1589]: info: CorePlayQueue::getTrackBlock Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::volumioRetrievevolume Jun 04 20:47:34 volumio volumio[1589]: info: Completed loading Core Plugins Jun 04 20:47:34 volumio volumio[1589]: info: Preparing to generate the ALSA configuration file Jun 04 20:47:34 volumio volumio[1589]: info: Asound.conf file unchanged, so no further update is needed Jun 04 20:47:34 volumio volumio[1589]: info: Output device has changed, restarting MPD Jun 04 20:47:34 volumio volumio[1589]: info: Output device has changed, restarting Shairport Sync Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:34 volumio sudo[1672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 04 20:47:34 volumio sudo[1672]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:34 volumio sudo[1672]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:34 volumio sudo[1675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 04 20:47:34 volumio sudo[1675]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:34 volumio volumio[1589]: Starting albumart workers Jun 04 20:47:34 volumio volumio[1589]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 04 20:47:34 volumio volumio[1589]: info: ___________ START PLUGINS ___________ Jun 04 20:47:34 volumio volumio[1589]: info: ControllerMpd::onStart: Initializing MPD Jun 04 20:47:34 volumio volumio[1589]: info: Creating MPD Configuration file Jun 04 20:47:34 volumio volumio[1589]: Starting albumart workers Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 20:47:34 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 04 20:47:34 volumio volumio[1589]: info: [1717526854464] CoreMusicLibrary::Adding element Media Servers Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:34 volumio volumio[1589]: Starting albumart workers Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:34 volumio sudo[1683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 04 20:47:34 volumio sudo[1683]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:34 volumio sudo[1684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 04 20:47:34 volumio sudo[1684]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:34 volumio sudo[1683]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:34 volumio sudo[1680]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:34 volumio sudo[1680]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:34 volumio sudo[1680]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:34 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 04 20:47:34 volumio systemd[1]: mpd.service: Succeeded. Jun 04 20:47:34 volumio systemd[1]: Stopped Music Player Daemon. Jun 04 20:47:34 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:34 volumio volumio[1589]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:34 volumio volumio[1589]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 04 20:47:34 volumio volumio[1589]: info: [1717526854619] CoreMusicLibrary::Adding element Last_100 Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 04 20:47:34 volumio volumio[1589]: info: [1717526854624] CoreMusicLibrary::Adding element Webradio Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 04 20:47:34 volumio volumio[1589]: info: Initializing BBC Radios Jun 04 20:47:34 volumio sudo[1690]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:34 volumio sudo[1690]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:34 volumio sudo[1690]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:34 volumio sudo[1690]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 04 20:47:34 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:34 volumio volumio[1589]: info: Volumio Calling Home Jun 04 20:47:34 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:34 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:34 volumio systemd[1696]: mpd.service: Failed to execute command: Input/output error Jun 04 20:47:34 volumio systemd[1696]: mpd.service: Failed at step EXEC spawning /usr/bin/mpd: Input/output error Jun 04 20:47:34 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:34 volumio kernel: I/O error, dev mmcblk0, sector 860688 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:34 volumio kernel: I/O error, dev loop0, sector 393732 op 0x0:(READ) flags 0x800 phys_seg 13 prio class 2 Jun 04 20:47:34 volumio kernel: SQUASHFS error: Failed to read block 0xc040a4e: -5 Jun 04 20:47:34 volumio kernel: SQUASHFS error: Unable to read data cache entry [c040a4e] Jun 04 20:47:34 volumio kernel: SQUASHFS error: Unable to read page, block c040a4e, size c067 Jun 04 20:47:34 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=203/EXEC Jun 04 20:47:34 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:34 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:34 volumio sudo[1675]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:34 volumio sudo[1684]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:34 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:34 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:35 volumio volumio[1589]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Jun 04 20:47:35 volumio volumio[1589]: Job for mpd.service failed because the control process exited with error code. Jun 04 20:47:35 volumio volumio[1589]: See "systemctl status mpd.service" and "journalctl -xe" for details. Jun 04 20:47:35 volumio volumio[1589]: info: Completed starting Core Plugins Jun 04 20:47:35 volumio volumio[1589]: info: ------------------------------------------- Jun 04 20:47:35 volumio volumio[1589]: info: ----- MyVolumio plugins startup ---- Jun 04 20:47:35 volumio volumio[1589]: info: ------------------------------------------- Jun 04 20:47:35 volumio volumio[1589]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 04 20:47:35 volumio volumio[1589]: info: MPD Permissions set Jun 04 20:47:35 volumio volumio[1589]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Jun 04 20:47:35 volumio volumio[1589]: Job for mpd.service failed because the control process exited with error code. Jun 04 20:47:35 volumio volumio[1589]: See "systemctl status mpd.service" and "journalctl -xe" for details. Jun 04 20:47:35 volumio volumio[1589]: info: MPD Permissions set Jun 04 20:47:35 volumio volumio[1589]: info: VolumeController:: Volume=86 Mute =false Jun 04 20:47:35 volumio volumio[1589]: info: CoreStateMachine::pushState Jun 04 20:47:35 volumio volumio[1589]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::volumioPushState Jun 04 20:47:35 volumio volumio[1589]: info: Discovery: adding 2c58d28e-7ac5-47a2-934b-79367f84dc17 Jun 04 20:47:35 volumio volumio[1589]: info: Discovery: Found device Volumio Jun 04 20:47:35 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::volumioGetState Jun 04 20:47:35 volumio volumio[1589]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:35 volumio volumio[1589]: info: Discovery: this is already registered, 2c58d28e-7ac5-47a2-934b-79367f84dc17 Jun 04 20:47:35 volumio volumio[1589]: info: Discovery: Found device Volumio Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::volumioGetState Jun 04 20:47:35 volumio volumio[1589]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:35 volumio sudo[1725]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:35 volumio sudo[1725]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:35 volumio sudo[1725]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:35 volumio sudo[1725]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:35 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:35 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:35 volumio volumio[1589]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 04 20:47:35 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:35 volumio volumio[1589]: info: Volumio called home Jun 04 20:47:35 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:35 volumio volumio[1589]: info: Starting Shairport Sync Jun 04 20:47:35 volumio volumio[1589]: info: Starting Shairport Sync Jun 04 20:47:35 volumio volumio[1589]: info: Starting Shairport Sync Jun 04 20:47:35 volumio sudo[1747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 04 20:47:35 volumio sudo[1747]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:35 volumio sudo[1745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 04 20:47:35 volumio sudo[1745]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:35 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:35 volumio sudo[1750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 04 20:47:35 volumio sudo[1750]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:35 volumio volumio[1589]: info: CoreCommandRouter::volumioGetState Jun 04 20:47:35 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 04 20:47:35 volumio volumio[1589]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:35 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 04 20:47:35 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 04 20:47:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 04 20:47:36 volumio sudo[1747]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:36 volumio sudo[1745]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:36 volumio sudo[1750]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:36 volumio volumio[1589]: info: Shairport-Sync Started Jun 04 20:47:36 volumio volumio[1589]: Error adding Membership: Error: addMembership EINVAL Jun 04 20:47:36 volumio volumio[1589]: info: Shairport-Sync Started Jun 04 20:47:36 volumio volumio[1589]: info: Shairport-Sync Started Jun 04 20:47:36 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:36 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:36 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:36 volumio sudo[1621]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:36 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:36 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:37 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:38 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:38 volumio volumio-remote-updater[628]: [2024-06-04 18:47:38] [connect] Successful connection Jun 04 20:47:38 volumio volumio-remote-updater[628]: [2024-06-04 18:47:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1717526858 101 Jun 04 20:47:38 volumio volumio[1589]: 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: 2 Jun 04 20:47:38 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:38 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:38 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:38 volumio kernel: I/O error, dev mmcblk0, sector 1181552 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:38 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:38 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:38 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:38 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:38 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:38 volumio kernel: I/O error, dev mmcblk0, sector 1181552 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:38 volumio kernel: I/O error, dev loop0, sector 698140 op 0x0:(READ) flags 0x800 phys_seg 12 prio class 2 Jun 04 20:47:38 volumio kernel: SQUASHFS error: Failed to read block 0x154e3b97: -5 Jun 04 20:47:38 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:38 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:38 volumio kernel: SQUASHFS error: Unable to read page, block 154e3b97, size c7a8 Jun 04 20:47:38 volumio mpd[1735]: /usr/bin/mpd: error while loading shared libraries: /usr/lib/arm-linux-gnueabihf/libtheoradec.so.1: cannot read file data: Input/output error Jun 04 20:47:38 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=127/n/a Jun 04 20:47:38 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:38 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:38 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:38 volumio sudo[1757]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:38 volumio sudo[1757]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:38 volumio sudo[1757]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:38 volumio sudo[1757]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:38 volumio mpd[1759]: /usr/bin/mpd: error while loading shared libraries: /usr/lib/arm-linux-gnueabihf/libtheoradec.so.1: cannot read file data: Input/output error Jun 04 20:47:38 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=127/n/a Jun 04 20:47:38 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:38 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:38 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:38 volumio kernel: SQUASHFS error: Unable to read page, block 154e3b97, size c7a8 Jun 04 20:47:38 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:38 volumio sudo[1760]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:38 volumio sudo[1760]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:38 volumio sudo[1760]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:38 volumio sudo[1760]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:38 volumio mpd[1762]: /usr/bin/mpd: error while loading shared libraries: /usr/lib/arm-linux-gnueabihf/libtheoradec.so.1: cannot read file data: Input/output error Jun 04 20:47:38 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=127/n/a Jun 04 20:47:38 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:38 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:38 volumio kernel: SQUASHFS error: Unable to read page, block 154e3b97, size c7a8 Jun 04 20:47:38 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:38 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:38 volumio sudo[1763]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:38 volumio sudo[1763]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:38 volumio sudo[1763]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:38 volumio sudo[1763]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:38 volumio mpd[1765]: /usr/bin/mpd: error while loading shared libraries: /usr/lib/arm-linux-gnueabihf/libtheoradec.so.1: cannot read file data: Input/output error Jun 04 20:47:38 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:38 volumio kernel: SQUASHFS error: Unable to read page, block 154e3b97, size c7a8 Jun 04 20:47:38 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=127/n/a Jun 04 20:47:38 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:38 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:38 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:39 volumio sudo[1766]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:39 volumio sudo[1766]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:39 volumio sudo[1766]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:39 volumio sudo[1766]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:39 volumio mpd[1768]: /usr/bin/mpd: error while loading shared libraries: /usr/lib/arm-linux-gnueabihf/libtheoradec.so.1: cannot read file data: Input/output error Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read page, block 154e3b97, size c7a8 Jun 04 20:47:39 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=127/n/a Jun 04 20:47:39 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:39 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:39 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:39 volumio sudo[1769]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:39 volumio sudo[1769]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:39 volumio sudo[1769]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:39 volumio sudo[1769]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:39 volumio mpd[1771]: /usr/bin/mpd: error while loading shared libraries: /usr/lib/arm-linux-gnueabihf/libtheoradec.so.1: cannot read file data: Input/output error Jun 04 20:47:39 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=127/n/a Jun 04 20:47:39 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:39 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:39 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read page, block 154e3b97, size c7a8 Jun 04 20:47:39 volumio sudo[1772]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:39 volumio sudo[1772]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:39 volumio sudo[1772]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:39 volumio sudo[1772]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:39 volumio mpd[1774]: /usr/bin/mpd: error while loading shared libraries: /usr/lib/arm-linux-gnueabihf/libtheoradec.so.1: cannot read file data: Input/output error Jun 04 20:47:39 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=127/n/a Jun 04 20:47:39 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:39 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read page, block 154e3b97, size c7a8 Jun 04 20:47:39 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:39 volumio sudo[1775]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:39 volumio sudo[1775]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:39 volumio sudo[1775]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:39 volumio sudo[1775]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:39 volumio mpd[1778]: /usr/bin/mpd: error while loading shared libraries: /usr/lib/arm-linux-gnueabihf/libtheoradec.so.1: cannot read file data: Input/output error Jun 04 20:47:39 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=127/n/a Jun 04 20:47:39 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:39 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read page, block 154e3b97, size c7a8 Jun 04 20:47:39 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:39 volumio sudo[1779]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:39 volumio sudo[1779]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:39 volumio sudo[1779]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:39 volumio sudo[1779]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:39 volumio mpd[1781]: /usr/bin/mpd: error while loading shared libraries: /usr/lib/arm-linux-gnueabihf/libtheoradec.so.1: cannot read file data: Input/output error Jun 04 20:47:39 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=127/n/a Jun 04 20:47:39 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:39 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read page, block 154e3b97, size c7a8 Jun 04 20:47:39 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:39 volumio sudo[1782]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:39 volumio sudo[1782]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:39 volumio sudo[1782]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:39 volumio sudo[1782]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:39 volumio mpd[1784]: /usr/bin/mpd: error while loading shared libraries: /usr/lib/arm-linux-gnueabihf/libtheoradec.so.1: cannot read file data: Input/output error Jun 04 20:47:39 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=127/n/a Jun 04 20:47:39 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:39 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read page, block 154e3b97, size c7a8 Jun 04 20:47:39 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:39 volumio sudo[1785]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:39 volumio sudo[1785]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:39 volumio sudo[1785]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:39 volumio sudo[1785]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:39 volumio mpd[1787]: /usr/bin/mpd: error while loading shared libraries: /usr/lib/arm-linux-gnueabihf/libtheoradec.so.1: cannot read file data: Input/output error Jun 04 20:47:39 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=127/n/a Jun 04 20:47:39 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:39 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:39 volumio kernel: SQUASHFS error: Unable to read page, block 154e3b97, size c7a8 Jun 04 20:47:39 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:40 volumio sudo[1788]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:40 volumio sudo[1788]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:40 volumio sudo[1788]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:40 volumio sudo[1788]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:40 volumio mpd[1790]: /usr/bin/mpd: error while loading shared libraries: /usr/lib/arm-linux-gnueabihf/libtheoradec.so.1: cannot read file data: Input/output error Jun 04 20:47:40 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=127/n/a Jun 04 20:47:40 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:40 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:40 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:40 volumio kernel: SQUASHFS error: Unable to read page, block 154e3b97, size c7a8 Jun 04 20:47:40 volumio systemd[1]: Starting Music Player Daemon... Jun 04 20:47:40 volumio sudo[1791]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 04 20:47:40 volumio sudo[1791]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:40 volumio sudo[1791]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 04 20:47:40 volumio sudo[1791]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:40 volumio mpd[1793]: /usr/bin/mpd: error while loading shared libraries: /usr/lib/arm-linux-gnueabihf/libtheoradec.so.1: cannot read file data: Input/output error Jun 04 20:47:40 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=127/n/a Jun 04 20:47:40 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:40 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:40 volumio systemd[1]: mpd.service: Start request repeated too quickly. Jun 04 20:47:40 volumio systemd[1]: mpd.service: Failed with result 'exit-code'. Jun 04 20:47:40 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 20:47:40 volumio systemd[1]: mpd.socket: Failed with result 'service-start-limit-hit'. Jun 04 20:47:40 volumio volumio[1589]: error: MPD error: Error: read ECONNRESET Jun 04 20:47:40 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [154e3b97] Jun 04 20:47:40 volumio kernel: SQUASHFS error: Unable to read page, block 154e3b97, size c7a8 Jun 04 20:47:40 volumio volumio[1589]: error: MPD error: Error: read ECONNRESET Jun 04 20:47:42 volumio sudo[1795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 04 20:47:42 volumio sudo[1795]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:42 volumio sudo[1795]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:42 volumio sudo[1798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 04 20:47:42 volumio sudo[1798]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:42 volumio sudo[1798]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:42 volumio sudo[1801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 04 20:47:42 volumio sudo[1801]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:43 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jun 04 20:47:43 volumio sudo[1801]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:43 volumio volumio[1589]: info: Upmpdcli Daemon Started Jun 04 20:47:43 volumio volumio[1589]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 04 20:47:43 volumio volumio[1589]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 04 20:47:43 volumio volumio[1589]: info: Adding plugin bluetooth to MyMusic Plugins Jun 04 20:47:43 volumio volumio[1589]: info: Adding plugin multiroom to MyMusic Plugins Jun 04 20:47:43 volumio volumio[1589]: info: Adding plugin metavolumio to MyMusic Plugins Jun 04 20:47:43 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:43 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:43 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:43 volumio kernel: I/O error, dev mmcblk0, sector 768800 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:43 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:43 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:43 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:43 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:43 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:43 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:43 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:43 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:43 volumio kernel: I/O error, dev mmcblk0, sector 768824 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:44 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:44 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:44 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:44 volumio kernel: I/O error, dev mmcblk0, sector 768824 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:44 volumio kernel: I/O error, dev loop0, sector 301862 op 0x0:(READ) flags 0x800 phys_seg 19 prio class 2 Jun 04 20:47:44 volumio kernel: SQUASHFS error: Failed to read block 0x9364fd8: -5 Jun 04 20:47:44 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [9364fd8] Jun 04 20:47:44 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [9364fd8] Jun 04 20:47:44 volumio kernel: SQUASHFS error: Unable to read page, block 9364fd8, size 12ad9 Jun 04 20:47:44 volumio volumio[1589]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/cd_controller/package.json: EIO: i/o error, read Jun 04 20:47:44 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:44 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:44 volumio volumio[1589]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 04 20:47:44 volumio volumio[1589]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 04 20:47:44 volumio volumio[1589]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 04 20:47:44 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:45 volumio volumio[1589]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 04 20:47:45 volumio volumio[1589]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 04 20:47:45 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:45 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 04 20:47:45 volumio volumio[1589]: info: Starting MyVolumio Remote Streaming Endpoints Jun 04 20:47:45 volumio volumio[1589]: info: MyVolumio not started Jun 04 20:47:45 volumio volumio[1589]: info: Initializing device activation check Jun 04 20:47:45 volumio volumio[1589]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 04 20:47:45 volumio volumio[1589]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 04 20:47:46 volumio volumio[1589]: info: Starting Streaming Service Transparent Proxy Jun 04 20:47:46 volumio volumio[1589]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 04 20:47:46 volumio volumio[1589]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 04 20:47:46 volumio volumio[1589]: info: Streaming services startup Jun 04 20:47:46 volumio volumio[1589]: info: Starting Streaming Daemon Jun 04 20:47:46 volumio sudo[1811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 04 20:47:46 volumio sudo[1811]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:46 volumio volumio[1589]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 04 20:47:46 volumio sudo[1811]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:46 volumio volumio[1589]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Jun 04 20:47:46 volumio volumio[1589]: error: connect ECONNREFUSED /run/mpd/socket {"errno":-111,"code":"ECONNREFUSED","syscall":"connect","address":"/run/mpd/socket"} Jun 04 20:47:46 volumio volumio[1589]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Jun 04 20:47:46 volumio volumio[1589]: error: connect ECONNREFUSED /run/mpd/socket {"errno":-111,"code":"ECONNREFUSED","syscall":"connect","address":"/run/mpd/socket"} Jun 04 20:47:46 volumio volumio[1589]: error: Cannot start Volumio Streaming Daemon Jun 04 20:47:46 volumio volumio[1589]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 04 20:47:46 volumio volumio[1589]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 04 20:47:46 volumio volumio[1589]: STREAMING PROXY: Starting server on port 3245 Jun 04 20:47:46 volumio volumio[1589]: Node JS runtime: 14 Jun 04 20:47:47 volumio volumio[1589]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jun 04 20:47:53 volumio volumio[1589]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jun 04 20:47:56 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:56 volumio sudo[1857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 04 20:47:56 volumio sudo[1857]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:56 volumio sudo[1857]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:56 volumio sudo[1860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 04 20:47:56 volumio sudo[1860]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:56 volumio sudo[1860]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:56 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:56 volumio volumio[1589]: verbose: New Socket.io Connection to 192.168.1.105 from 192.168.1.94 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Edg/126.0.0.0 Engine version: 3 Transport: polling Total Clients: 3 Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::volumioGetVisibleSources Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Jun 04 20:47:56 volumio volumio[1589]: info: Received Get System Info Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 04 20:47:56 volumio volumio[1589]: info: Discovery: Getting this device information Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::volumioGetState Jun 04 20:47:56 volumio volumio[1589]: info: CorePlayQueue::getTrack 0 Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 04 20:47:56 volumio volumio-remote-updater[628]: No test mode Jun 04 20:47:56 volumio volumio-remote-updater[628]: No alpha test mode Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 04 20:47:56 volumio volumio[1589]: info: Retrieving Cloud Streaming UI Jun 04 20:47:56 volumio volumio[1589]: info: Getting Tidal Cloud Configuration Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 04 20:47:56 volumio volumio[1589]: info: Getting Qobuz Cloud Configuration Jun 04 20:47:56 volumio volumio[1589]: info: Asking plugin for UI Config Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 04 20:47:56 volumio volumio[1589]: info: Getting Spotify Cloud Configuration Jun 04 20:47:56 volumio volumio[1589]: info: Asking plugin for UI Config Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 04 20:47:56 volumio volumio[1589]: info: Saving Spotify Acccount Jun 04 20:47:56 volumio volumio[1589]: info: Got Tidal Cloud Configuration Jun 04 20:47:56 volumio volumio[1589]: info: Got it Jun 04 20:47:56 volumio volumio[1589]: info: Got it Jun 04 20:47:56 volumio volumio[1589]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 04 20:47:56 volumio volumio[1589]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 04 20:47:56 volumio volumio[1589]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jun 04 20:47:57 volumio volumio[1589]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 04 20:47:57 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 04 20:47:57 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:57 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:57 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:57 volumio kernel: I/O error, dev mmcblk0, sector 1398136 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:57 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:57 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:57 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:57 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:57 volumio kernel: I/O error, dev mmcblk0, sector 1398136 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:57 volumio kernel: I/O error, dev loop0, sector 914770 op 0x0:(READ) flags 0x800 phys_seg 14 prio class 2 Jun 04 20:47:57 volumio kernel: SQUASHFS error: Failed to read block 0x1beaa69f: -5 Jun 04 20:47:57 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1beaa69f] Jun 04 20:47:57 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1beaa69f] Jun 04 20:47:57 volumio kernel: SQUASHFS error: Unable to read page, block 1beaa69f, size c981 Jun 04 20:47:57 volumio volumio[1589]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read Jun 04 20:47:57 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:57 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:57 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:57 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:57 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:57 volumio kernel: I/O error, dev mmcblk0, sector 1370840 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:57 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:57 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:57 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jun 04 20:47:57 volumio volumio[1589]: info: Loading i18n strings for locale it Jun 04 20:47:57 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: I/O error, dev mmcblk0, sector 1370848 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: I/O error, dev mmcblk0, sector 1370864 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:58 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: I/O error, dev mmcblk0, sector 1370864 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:58 volumio kernel: I/O error, dev loop0, sector 887438 op 0x0:(READ) flags 0x800 phys_seg 33 prio class 2 Jun 04 20:47:58 volumio kernel: SQUASHFS error: Failed to read block 0x1b151de3: -5 Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:58 volumio kernel: I/O error, dev mmcblk0, sector 1369712 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jun 04 20:47:58 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: I/O error, dev mmcblk0, sector 1369712 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jun 04 20:47:59 volumio kernel: SQUASHFS error: Failed to read block 0x1b0ce854: -5 Jun 04 20:47:59 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1b0ce854] Jun 04 20:47:59 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1b0ce854] Jun 04 20:47:59 volumio kernel: SQUASHFS error: Unable to read page, block 1b0ce854, size 57cd Jun 04 20:47:59 volumio volumio[1589]: error: Failed to load i18n strings for locale it: Error: /volumio/app/i18n/strings_it.json: EIO: i/o error, read Jun 04 20:47:59 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1b0ce854] Jun 04 20:47:59 volumio kernel: SQUASHFS error: Unable to read page, block 1b0ce854, size 57cd Jun 04 20:47:59 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jun 04 20:47:59 volumio volumio[1589]: info: Setting timezone to Europe/Rome Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: SQUASHFS error: Failed to read block 0x1b171de3: -5 Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:47:59 volumio kernel: SQUASHFS error: Failed to read block 0x1b191de3: -5 Jun 04 20:47:59 volumio sudo[1867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jun 04 20:47:59 volumio sudo[1867]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:59 volumio sudo[1867]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:59 volumio sudo[1870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Rome /etc/localtime Jun 04 20:47:59 volumio sudo[1870]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:59 volumio sudo[1870]: pam_unix(sudo:session): session closed for user root Jun 04 20:47:59 volumio sudo[1873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jun 04 20:47:59 volumio sudo[1873]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:47:59 volumio ntpd[764]: Soliciting pool server 217.61.62.224 Jun 04 20:47:59 volumio ntpd[764]: Soliciting pool server 212.45.144.206 Jun 04 20:48:00 volumio sudo[1873]: pam_unix(sudo:session): session closed for user root Jun 04 20:48:00 volumio sudo[1876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Rome Jun 04 20:48:00 volumio sudo[1876]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:48:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:00 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:48:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:00 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:48:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:00 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:48:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:00 volumio sudo[1876]: pam_unix(sudo:session): session closed for user root Jun 04 20:48:00 volumio volumio[1589]: sudo: unable to execute /usr/bin/timedatectl: Input/output error Jun 04 20:48:00 volumio volumio[1589]: info: Could not set timezone, retrying Jun 04 20:48:00 volumio volumio[1589]: info: Fetching Streaming Services browse cache Jun 04 20:48:00 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:48:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:00 volumio kernel: SQUASHFS error: Failed to read block 0xe424207: -5 Jun 04 20:48:00 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [e424207] Jun 04 20:48:00 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [e424207] Jun 04 20:48:00 volumio kernel: SQUASHFS error: Unable to read page, block e424207, size bc33 Jun 04 20:48:00 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 04 20:48:00 volumio ntpd[764]: Soliciting pool server 31.14.133.122 Jun 04 20:48:00 volumio ntpd[764]: Soliciting pool server 162.159.200.1 Jun 04 20:48:00 volumio ntpd[764]: Soliciting pool server 162.159.200.123 Jun 04 20:48:00 volumio volumio[1589]: Updating browse sources language Jun 04 20:48:00 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 20:48:00 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 04 20:48:00 volumio volumio[1589]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 04 20:48:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:00 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: SQUASHFS error: Failed to read block 0x1b151de3: -5 Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read data cache entry [1b151de3] Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read page, block 1b151de3, size 1020000 Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read data cache entry [1b151de3] Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read page, block 1b151de3, size 1020000 Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio volumio[1589]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read Jun 04 20:48:01 volumio kernel: SQUASHFS error: Failed to read block 0x1b0ce854: -5 Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1b0ce854] Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1b0ce854] Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read page, block 1b0ce854, size 57cd Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read data cache entry [1b151de3] Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read page, block 1b151de3, size 1020000 Jun 04 20:48:01 volumio volumio[1589]: Error: EIO: i/o error, read Jun 04 20:48:01 volumio volumio[1589]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jun 04 20:48:01 volumio volumio[1589]: info: Loading i18n strings for locale it Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: SQUASHFS error: Failed to read block 0x1bf91422: -5 Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1bf91422] Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1bf91422] Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read page, block 1bf91422, size 17b7e Jun 04 20:48:01 volumio ntpd[764]: Soliciting pool server 185.157.229.254 Jun 04 20:48:01 volumio ntpd[764]: Soliciting pool server 93.44.243.48 Jun 04 20:48:01 volumio ntpd[764]: Soliciting pool server 185.19.184.35 Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio ntpd[764]: Soliciting pool server 95.230.240.5 Jun 04 20:48:01 volumio kernel: mmc0: Tuning failed, falling back to fixed sampling clock Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:01 volumio volumio[1589]: error: Failed to load i18n strings for locale it: Error: /volumio/app/i18n/strings_it.json: EIO: i/o error, read Jun 04 20:48:01 volumio kernel: SQUASHFS error: Failed to read block 0x1b0ce854: -5 Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1b0ce854] Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read page, block 1b0ce854, size 57cd Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1b0ce854] Jun 04 20:48:01 volumio kernel: SQUASHFS error: Unable to read page, block 1b0ce854, size 57cd Jun 04 20:48:01 volumio volumio[1589]: info: CoreCommandRouter::volumioGetState Jun 04 20:48:01 volumio volumio[1589]: info: CorePlayQueue::getTrack 0 Jun 04 20:48:02 volumio sudo[1879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Rome Jun 04 20:48:02 volumio sudo[1879]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 20:48:02 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:02 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:02 volumio kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Jun 04 20:48:02 volumio sudo[1879]: pam_unix(sudo:session): session closed for user root Jun 04 20:48:02 volumio kernel: SQUASHFS error: Failed to read block 0xe424207: -5 Jun 04 20:48:02 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [e424207] Jun 04 20:48:02 volumio kernel: SQUASHFS error: Unable to read page, block e424207, size bc33 Jun 04 20:48:02 volumio volumio[1589]: sudo: unable to execute /usr/bin/timedatectl: Input/output error Jun 04 20:48:02 volumio volumio[1589]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 04 20:48:02 volumio volumio[1589]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'Europe/Rome' Jun 04 20:48:02 volumio volumio[1589]: sudo: unable to execute /usr/bin/timedatectl: Input/output error Jun 04 20:48:02 volumio volumio[1589]: at checkExecSyncError (child_process.js:616:11) Jun 04 20:48:02 volumio volumio[1589]: at execSync (child_process.js:652:15) Jun 04 20:48:02 volumio volumio[1589]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1562:9) Jun 04 20:48:02 volumio volumio[1589]: at listOnTimeout (internal/timers.js:554:17) Jun 04 20:48:02 volumio volumio[1589]: at processTimers (internal/timers.js:497:7) { Jun 04 20:48:02 volumio volumio[1589]: status: 1, Jun 04 20:48:02 volumio volumio[1589]: signal: null, Jun 04 20:48:02 volumio volumio[1589]: output: [ Jun 04 20:48:02 volumio volumio[1589]: null, Jun 04 20:48:02 volumio volumio[1589]: '', Jun 04 20:48:02 volumio volumio[1589]: 'sudo: unable to execute /usr/bin/timedatectl: Input/output error\n' Jun 04 20:48:02 volumio volumio[1589]: ], Jun 04 20:48:02 volumio volumio[1589]: pid: 1878, Jun 04 20:48:02 volumio volumio[1589]: stdout: '', Jun 04 20:48:02 volumio volumio[1589]: stderr: 'sudo: unable to execute /usr/bin/timedatectl: Input/output error\n' Jun 04 20:48:02 volumio volumio[1589]: } Jun 04 20:48:02 volumio volumio[1589]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 04 20:48:02 volumio sudo[1890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-06-04 20:47 Jun 04 20:48:02 volumio sudo[1890]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"