-- Logs begin at Wed 2024-04-03 07:46:52 CEST, end at Wed 2024-04-03 07:48:10 CEST. --
Apr 03 07:47:00 nvb systemd[1]: Mounted /boot.
Apr 03 07:47:00 nvb systemd[1]: Reached target Local File Systems.
Apr 03 07:47:00 nvb systemd[1]: Starting Raise network interfaces...
Apr 03 07:47:00 nvb systemd[1]: Starting Create Volatile Files and Directories...
Apr 03 07:47:00 nvb systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Apr 03 07:47:00 nvb systemd[1]: Starting Preprocess NFS configuration...
Apr 03 07:47:00 nvb systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Apr 03 07:47:00 nvb systemd[1]: Started ifup for eth0.
Apr 03 07:47:00 nvb systemd[1]: Started ifup for wlan0.
Apr 03 07:47:00 nvb systemd[1]: Received SIGRTMIN+20 from PID 273 (plymouthd).
Apr 03 07:47:00 nvb systemd[1]: plymouth-read-write.service: Succeeded.
Apr 03 07:47:00 nvb systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Apr 03 07:47:00 nvb systemd[1]: nfs-config.service: Succeeded.
Apr 03 07:47:00 nvb systemd[1]: Started Preprocess NFS configuration.
Apr 03 07:47:00 nvb systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped.
Apr 03 07:47:00 nvb systemd[1]: Condition check resulted in RPC security service for NFS server being skipped.
Apr 03 07:47:00 nvb systemd[1]: Reached target NFS client services.
Apr 03 07:47:00 nvb systemd[1]: Started Create Volatile Files and Directories.
Apr 03 07:47:00 nvb systemd[1]: Starting RPC bind portmap service...
Apr 03 07:47:00 nvb systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Apr 03 07:47:00 nvb systemd[1]: Condition check resulted in Network Time Synchronization being skipped.
Apr 03 07:47:00 nvb systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
Apr 03 07:47:00 nvb systemd[1]: Started Update UTMP about System Boot/Shutdown.
Apr 03 07:47:00 nvb systemd[1]: Reached target System Initialization.
Apr 03 07:47:00 nvb systemd[1]: Started Daily apt download activities.
Apr 03 07:47:00 nvb systemd[1]: Started Daily apt upgrade and clean activities.
Apr 03 07:47:00 nvb systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Apr 03 07:47:00 nvb systemd[1]: Listening on triggerhappy.socket.
Apr 03 07:47:00 nvb systemd[1]: Started Daily Cleanup of Temporary Directories.
Apr 03 07:47:00 nvb systemd[1]: Reached target Timers.
Apr 03 07:47:00 nvb systemd[1]: Listening on D-Bus System Message Bus Socket.
Apr 03 07:47:00 nvb systemd[1]: Reached target Sockets.
Apr 03 07:47:00 nvb kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Apr 03 07:47:00 nvb kernel: 8021q: 802.1Q VLAN Support v1.8
Apr 03 07:47:00 nvb systemd[1]: Started Volumio Splash.
Apr 03 07:47:00 nvb systemd[1]: Reached target Basic System.
Apr 03 07:47:00 nvb systemd[537]: volumiosplash.service: Failed to execute command: No such file or directory
Apr 03 07:47:00 nvb systemd[537]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory
Apr 03 07:47:00 nvb systemd[1]: Starting Login Service...
Apr 03 07:47:00 nvb systemd[1]: Starting triggerhappy global hotkey daemon...
Apr 03 07:47:00 nvb systemd[1]: Started D-Bus System Message Bus.
Apr 03 07:47:00 nvb systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Apr 03 07:47:00 nvb systemd[1]: Starting Wireless Services...
Apr 03 07:47:00 nvb systemd[1]: Started Volumio Log Rotation Service.
Apr 03 07:47:00 nvb systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
Apr 03 07:47:00 nvb thd[551]: Unable to parse trigger line:
Apr 03 07:47:00 nvb thd[551]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle
Apr 03 07:47:00 nvb thd[551]: Unable to parse trigger line:
Apr 03 07:47:00 nvb thd[551]: Found socket passed from systemd
Apr 03 07:47:00 nvb systemd[1]: Starting Configure Bluetooth Modems connected by UART...
Apr 03 07:47:00 nvb systemd[1]: Started Volumio Iptables Module.
Apr 03 07:47:00 nvb systemd[1]: Condition check resulted in Volumio SSH enabler being skipped.
Apr 03 07:47:00 nvb systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Apr 03 07:47:00 nvb systemd[1]: Starting dhcpcd on all interfaces...
Apr 03 07:47:00 nvb systemd[1]: Started volumio-remote-updater.service.
Apr 03 07:47:00 nvb systemd[1]: Started Manage Sound Card State (restore and store).
Apr 03 07:47:00 nvb alsactl[577]: alsactl 1.1.8 daemon started
Apr 03 07:47:00 nvb systemd-logind[550]: New seat seat0.
Apr 03 07:47:00 nvb systemd[1]: Starting Save/Restore Sound Card State...
Apr 03 07:47:00 nvb systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 03 07:47:00 nvb dhcpcd[575]: Not running dhcpcd because /etc/network/interfaces
Apr 03 07:47:00 nvb dhcpcd[575]: defines some interfaces that will use a
Apr 03 07:47:00 nvb dhcpcd[575]: DHCP client or static address
Apr 03 07:47:00 nvb systemd[1]: Starting WPA supplicant...
Apr 03 07:47:01 nvb systemd[1]: Started triggerhappy global hotkey daemon.
Apr 03 07:47:01 nvb systemd[1]: Started RPC bind portmap service.
Apr 03 07:47:01 nvb systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC
Apr 03 07:47:01 nvb systemd[1]: volumiosplash.service: Failed with result 'exit-code'.
Apr 03 07:47:01 nvb systemd[1]: hciuart.service: Succeeded.
Apr 03 07:47:01 nvb systemd[1]: Started Configure Bluetooth Modems connected by UART.
Apr 03 07:47:01 nvb systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED
Apr 03 07:47:01 nvb systemd[1]: dhcpcd.service: Failed with result 'exit-code'.
Apr 03 07:47:01 nvb systemd[1]: Failed to start dhcpcd on all interfaces.
Apr 03 07:47:01 nvb systemd[1]: Starting Raspberry Pi bluetooth helper...
Apr 03 07:47:01 nvb systemd[1]: Reached target RPC Port Mapper.
Apr 03 07:47:01 nvb systemd[1]: Reached target Remote File Systems (Pre).
Apr 03 07:47:01 nvb systemd[1]: Reached target Remote File Systems.
Apr 03 07:47:01 nvb systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
Apr 03 07:47:01 nvb systemd[1]: Started Save/Restore Sound Card State.
Apr 03 07:47:01 nvb sh[471]: wlan0=wlan0
Apr 03 07:47:01 nvb systemd[1]: Reached target Sound Card.
Apr 03 07:47:01 nvb bthelper[585]: Raspberry Pi BDADDR already set
Apr 03 07:47:01 nvb avahi-daemon[570]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113).
Apr 03 07:47:01 nvb avahi-daemon[570]: Successfully dropped root privileges.
Apr 03 07:47:01 nvb avahi-daemon[570]: avahi-daemon 0.7 starting up.
Apr 03 07:47:01 nvb sh[470]: eth0: waiting for carrier
Apr 03 07:47:01 nvb dhcpcd[514]: eth0: waiting for carrier
Apr 03 07:47:01 nvb kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
Apr 03 07:47:01 nvb kernel: bcmgenet fd580000.ethernet eth0: Link is Down
Apr 03 07:47:02 nvb systemd[1]: Started Raspberry Pi bluetooth helper.
Apr 03 07:47:02 nvb wpa_supplicant[581]: Successfully initialized wpa_supplicant
Apr 03 07:47:02 nvb avahi-daemon[570]: Successfully called chroot().
Apr 03 07:47:02 nvb avahi-daemon[570]: Successfully dropped remaining capabilities.
Apr 03 07:47:02 nvb avahi-daemon[570]: Loading service file /services/volumio.service.
Apr 03 07:47:02 nvb avahi-daemon[570]: Network interface enumeration completed.
Apr 03 07:47:02 nvb avahi-daemon[570]: Server startup complete. Host name is nvb.local. Local service cookie is 2938980434.
Apr 03 07:47:02 nvb avahi-daemon[570]: Service "nvb" (/services/volumio.service) successfully established.
Apr 03 07:47:02 nvb systemd[1]: Started Raise network interfaces.
Apr 03 07:47:02 nvb systemd[1]: Started Login Service.
Apr 03 07:47:02 nvb systemd[1]: Started WPA supplicant.
Apr 03 07:47:02 nvb systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Apr 03 07:47:02 nvb systemd[1]: Reached target Network.
Apr 03 07:47:02 nvb systemd[1]: Starting Permit User Sessions...
Apr 03 07:47:02 nvb systemd[1]: Starting Network Time Service...
Apr 03 07:47:02 nvb systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Apr 03 07:47:02 nvb systemd[1]: Reached target Network is Online.
Apr 03 07:47:02 nvb systemd[1]: Starting /etc/rc.local Compatibility...
Apr 03 07:47:02 nvb systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 03 07:47:02 nvb systemd[1]: Starting Samba NMB Daemon...
Apr 03 07:47:02 nvb systemd[1]: Starting LSB: Brings up/down network automatically...
Apr 03 07:47:02 nvb systemd[1]: Starting Bluetooth service...
Apr 03 07:47:02 nvb systemd[1]: Started /etc/rc.local Compatibility.
Apr 03 07:47:02 nvb systemd[1]: Started Permit User Sessions.
Apr 03 07:47:02 nvb systemd[1]: Starting Hold until boot process finishes up...
Apr 03 07:47:02 nvb volumio-remote-updater[576]: Error: No active session
Apr 03 07:47:02 nvb volumio-remote-updater[576]: [2024-04-03 07:47:02] [info] asio async_connect error: system:111 (Connection refused)
Apr 03 07:47:02 nvb volumio-remote-updater[576]: [2024-04-03 07:47:02] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Apr 03 07:47:02 nvb volumio-remote-updater[576]: [2024-04-03 07:47:02] [error] handle_connect error: Underlying Transport Error
Apr 03 07:47:02 nvb systemd[1]: Starting Terminate Plymouth Boot Screen...
Apr 03 07:47:02 nvb systemd[1]: systemd-rfkill.service: Succeeded.
Apr 03 07:47:02 nvb systemd[1]: plymouth-start.service: Succeeded.
Apr 03 07:47:02 nvb systemd[1]: plymouth-quit-wait.service: Succeeded.
Apr 03 07:47:02 nvb systemd[1]: Started Hold until boot process finishes up.
Apr 03 07:47:02 nvb systemd[1]: plymouth-quit.service: Succeeded.
Apr 03 07:47:02 nvb systemd[1]: Started Terminate Plymouth Boot Screen.
Apr 03 07:47:02 nvb systemd[1]: iptables.service: Succeeded.
Apr 03 07:47:02 nvb systemd[1]: Received SIGRTMIN+21 from PID 273 (n/a).
Apr 03 07:47:02 nvb systemd[1]: Received SIGRTMIN+21 from PID 273 (n/a).
Apr 03 07:47:02 nvb volumio[580]: Could not open config: /tmp/upmpdcli.conf
Apr 03 07:47:02 nvb loadcpufreq[597]: Loading cpufreq kernel modules...done (none).
Apr 03 07:47:02 nvb systemd[1]: Started Getty on tty1.
Apr 03 07:47:02 nvb systemd[1]: Reached target Login Prompts.
Apr 03 07:47:02 nvb systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Apr 03 07:47:02 nvb systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Apr 03 07:47:02 nvb systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
Apr 03 07:47:02 nvb systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Apr 03 07:47:02 nvb ntpd[660]: ntpd 4.2.8p12@1.3728-o (1): Starting
Apr 03 07:47:02 nvb ntpd[660]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
Apr 03 07:47:02 nvb ifplugd(eth0)[715]: ifplugd 0.28 initializing.
Apr 03 07:47:02 nvb ifplugd(eth0)[715]: Using interface eth0/D8:3A:DD:99:36:30 with driver (version: 6.1.69-v7l+)
Apr 03 07:47:02 nvb ifplugd(eth0)[715]: Using detection mode: SIOCETHTOOL
Apr 03 07:47:02 nvb ifplugd(eth0)[715]: Initialization complete, link beat not detected.
Apr 03 07:47:02 nvb systemd[1]: Started Network Time Service.
Apr 03 07:47:03 nvb ntpd[713]: proto: precision = 2.167 usec (-19)
Apr 03 07:47:03 nvb bluetoothd[667]: Bluetooth daemon 5.50
Apr 03 07:47:03 nvb ifplugd[665]: Network Interface Plugging Daemon...start eth0...done.
Apr 03 07:47:03 nvb systemd[1]: Started LSB: Brings up/down network automatically.
Apr 03 07:47:03 nvb ntpd[713]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Apr 03 07:47:03 nvb ntpd[713]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Apr 03 07:47:03 nvb ntpd[713]: Listen and drop on 0 v6wildcard [::]:123
Apr 03 07:47:03 nvb ntpd[713]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Apr 03 07:47:03 nvb bluetoothd[667]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Apr 03 07:47:03 nvb ntpd[713]: Listen normally on 2 lo 127.0.0.1:123
Apr 03 07:47:03 nvb ntpd[713]: Listening on routing socket on fd #19 for interface updates
Apr 03 07:47:03 nvb ntpd[713]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Apr 03 07:47:03 nvb ntpd[713]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Apr 03 07:47:03 nvb systemd[1]: Started Bluetooth service.
Apr 03 07:47:03 nvb systemd[1]: Reached target Bluetooth.
Apr 03 07:47:03 nvb bluetoothd[667]: Starting SDP server
Apr 03 07:47:03 nvb bluetoothd[667]: Excluding (cli) sap
Apr 03 07:47:03 nvb cpufrequtils[709]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done.
Apr 03 07:47:03 nvb systemd[1]: Started LSB: set CPUFreq kernel parameters.
Apr 03 07:47:03 nvb kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Apr 03 07:47:03 nvb kernel: Bluetooth: BNEP filters: protocol multicast
Apr 03 07:47:03 nvb kernel: Bluetooth: BNEP socket layer initialized
Apr 03 07:47:03 nvb bluetoothd[667]: Bluetooth management interface 1.22 initialized
Apr 03 07:47:03 nvb dbus-daemon[552]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=667 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Apr 03 07:47:03 nvb kernel: Bluetooth: MGMT ver 1.22
Apr 03 07:47:03 nvb bluetoothd[667]: Failed to set privacy: Rejected (0x0b)
Apr 03 07:47:03 nvb systemd[1]: Starting Hostname Service...
Apr 03 07:47:03 nvb dbus-daemon[552]: [system] Successfully activated service 'org.freedesktop.hostname1'
Apr 03 07:47:03 nvb systemd[1]: Started Hostname Service.
Apr 03 07:47:03 nvb haveged[528]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K
Apr 03 07:47:03 nvb haveged[528]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488
Apr 03 07:47:03 nvb haveged[528]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00057
Apr 03 07:47:03 nvb haveged[528]: haveged: fills: 0, generated: 0
Apr 03 07:47:03 nvb nmbd[672]: [2024/04/03 07:47:03.923683, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Apr 03 07:47:03 nvb nmbd[672]: started asyncdns process 737
Apr 03 07:47:03 nvb nmbd[672]: [2024/04/03 07:47:03.926121, 0] ../lib/util/become_daemon.c:149(daemon_status)
Apr 03 07:47:03 nvb nmbd[672]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Apr 03 07:47:03 nvb nmbd[672]: [2024/04/03 07:47:03.926276, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
Apr 03 07:47:03 nvb nmbd[672]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Apr 03 07:47:04 nvb ntpd[713]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Apr 03 07:47:04 nvb wireless.js[560]: Cleaning previous...
Apr 03 07:47:04 nvb sudo[745]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Apr 03 07:47:04 nvb sudo[745]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:04 nvb sudo[745]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:04 nvb sudo[747]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Apr 03 07:47:04 nvb sudo[747]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:04 nvb sudo[747]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:04 nvb wireless.js[560]: Stopped aP
Apr 03 07:47:04 nvb ntpd[713]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Apr 03 07:47:04 nvb sudo[754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Apr 03 07:47:04 nvb sudo[754]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:05 nvb kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Apr 03 07:47:05 nvb sudo[754]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:05 nvb sudo[756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Apr 03 07:47:05 nvb sudo[756]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:05 nvb sudo[756]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:05 nvb sudo[763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Apr 03 07:47:05 nvb sudo[763]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:05 nvb sudo[763]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:05 nvb sudo[765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Apr 03 07:47:05 nvb sudo[765]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:05 nvb ntpd[713]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Apr 03 07:47:06 nvb bthelper[585]: Changing power off succeeded
Apr 03 07:47:06 nvb bthelper[585]: [CHG] Controller D8:3A:DD:99:36:33 Powered: no
Apr 03 07:47:06 nvb bthelper[585]: [CHG] Controller D8:3A:DD:99:36:33 Discovering: no
Apr 03 07:47:06 nvb bthelper[585]: [CHG] Controller D8:3A:DD:99:36:33 Class: 0x00000000
Apr 03 07:47:06 nvb bthelper[585]: [CHG] Controller D8:3A:DD:99:36:33 Class: 0x0000041c
Apr 03 07:47:06 nvb bthelper[585]: Changing power on succeeded
Apr 03 07:47:06 nvb ntpd[713]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Apr 03 07:47:07 nvb volumio-remote-updater[576]: [2024-04-03 07:47:07] [info] asio async_connect error: system:111 (Connection refused)
Apr 03 07:47:07 nvb volumio-remote-updater[576]: [2024-04-03 07:47:07] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Apr 03 07:47:07 nvb volumio-remote-updater[576]: [2024-04-03 07:47:07] [error] handle_connect error: Underlying Transport Error
Apr 03 07:47:07 nvb sudo[765]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:07 nvb wireless.js[560]: SETTING APPROPRIATE REG DOMAIN: DE
Apr 03 07:47:07 nvb sudo[777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Apr 03 07:47:07 nvb sudo[777]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:07 nvb sudo[777]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:07 nvb sudo[779]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE
Apr 03 07:47:07 nvb sudo[779]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:07 nvb sudo[779]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:07 nvb wireless.js[560]: SUCCESSFULLY SET NEW REGDOMAIN: DE
Apr 03 07:47:07 nvb wireless.js[560]: Start wireless flow
Apr 03 07:47:07 nvb wireless.js[560]: Stopped hotspot (if there)..
Apr 03 07:47:07 nvb sudo[784]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Apr 03 07:47:07 nvb sudo[784]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:07 nvb sudo[784]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:07 nvb sudo[786]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Apr 03 07:47:07 nvb sudo[786]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:08 nvb sudo[786]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:08 nvb wireless.js[560]: DHCP IP
Apr 03 07:47:08 nvb wireless.js[560]: Start ap
Apr 03 07:47:08 nvb wpa_supplicant[788]: Successfully initialized wpa_supplicant
Apr 03 07:47:08 nvb sudo[789]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Apr 03 07:47:08 nvb sudo[789]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:08 nvb dhcpcd[790]: dev: loaded udev
Apr 03 07:47:08 nvb kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Apr 03 07:47:08 nvb dhcpcd-run-hooks[808]: wlan0: starting wpa_supplicant
Apr 03 07:47:08 nvb dhcpcd-run-hooks[813]: wlan0: failed to start wpa_supplicant
Apr 03 07:47:08 nvb dhcpcd-run-hooks[814]: wlan0: Successfully initialized wpa_supplicant
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Ma
Apr 03 07:47:08 nvb dhcpcd[790]: wlan0: connected to Access Point `'
Apr 03 07:47:08 nvb dhcpcd[790]: no interfaces have a carrier
Apr 03 07:47:08 nvb dhcpcd[790]: forked to background, child pid 824
Apr 03 07:47:08 nvb dhcpcd[824]: eth0: waiting for carrier
Apr 03 07:47:08 nvb dhcpcd[824]: wlan0: waiting for carrier
Apr 03 07:47:08 nvb sudo[789]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:09 nvb wireless.js[560]: trying...
Apr 03 07:47:09 nvb sudo[826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:09 nvb sudo[826]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:09 nvb sudo[826]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:10 nvb wireless.js[560]: trying...
Apr 03 07:47:10 nvb sudo[829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:10 nvb sudo[829]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:10 nvb sudo[829]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:11 nvb wpa_supplicant[812]: wlan0: Trying to associate with SSID 'grafenwlan'
Apr 03 07:47:11 nvb wireless.js[560]: trying...
Apr 03 07:47:11 nvb sudo[832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:11 nvb sudo[832]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:11 nvb sudo[832]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:12 nvb wireless.js[560]: trying...
Apr 03 07:47:12 nvb sudo[835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:12 nvb sudo[835]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:12 nvb sudo[835]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:13 nvb wireless.js[560]: trying...
Apr 03 07:47:13 nvb sudo[838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:13 nvb sudo[838]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:13 nvb sudo[838]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:14 nvb dhcpcd[824]: wlan0: carrier acquired
Apr 03 07:47:14 nvb dhcpcd[824]: wlan0: connected to Access Point `grafenwlan'
Apr 03 07:47:14 nvb wpa_supplicant[812]: wlan0: Associated with f0:b0:14:fc:e7:fd
Apr 03 07:47:14 nvb wpa_supplicant[812]: wlan0: CTRL-EVENT-CONNECTED - Connection to f0:b0:14:fc:e7:fd completed [id=0 id_str=]
Apr 03 07:47:14 nvb wpa_supplicant[812]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 03 07:47:14 nvb wpa_supplicant[812]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE
Apr 03 07:47:14 nvb dhcpcd[824]: DUID 00:01:00:01:2d:69:1d:a7:d8:3a:dd:80:2b:94
Apr 03 07:47:14 nvb dhcpcd[824]: wlan0: IAID dd:99:36:32
Apr 03 07:47:14 nvb dhcpcd[824]: wlan0: adding address fe80::22b5:d303:2b4f:763c
Apr 03 07:47:14 nvb dhcpcd[824]: ipv6_addaddr1: Permission denied
Apr 03 07:47:14 nvb dhcpcd[824]: wlan0: carrier lost
Apr 03 07:47:14 nvb dhcpcd[824]: wlan0: carrier acquired
Apr 03 07:47:14 nvb dhcpcd[824]: wlan0: IAID dd:99:36:32
Apr 03 07:47:14 nvb wireless.js[560]: trying...
Apr 03 07:47:14 nvb sudo[853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:14 nvb sudo[853]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:14 nvb sudo[853]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:14 nvb dhcpcd[824]: wlan0: rebinding lease of 192.168.178.53
Apr 03 07:47:14 nvb dhcpcd[824]: wlan0: soliciting an IPv6 router
Apr 03 07:47:15 nvb volumio-remote-updater[576]: [2024-04-03 07:47:15] [info] asio async_connect error: system:111 (Connection refused)
Apr 03 07:47:15 nvb volumio-remote-updater[576]: [2024-04-03 07:47:15] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Apr 03 07:47:15 nvb volumio-remote-updater[576]: [2024-04-03 07:47:15] [error] handle_connect error: Underlying Transport Error
Apr 03 07:47:15 nvb wireless.js[560]: trying...
Apr 03 07:47:15 nvb sudo[856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:15 nvb sudo[856]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:15 nvb sudo[856]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:16 nvb wireless.js[560]: trying...
Apr 03 07:47:16 nvb sudo[859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:16 nvb sudo[859]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:16 nvb sudo[859]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:17 nvb wireless.js[560]: trying...
Apr 03 07:47:17 nvb sudo[862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:17 nvb sudo[862]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:17 nvb sudo[862]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:18 nvb wireless.js[560]: trying...
Apr 03 07:47:18 nvb sudo[865]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:18 nvb sudo[865]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:18 nvb sudo[865]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:19 nvb wireless.js[560]: trying...
Apr 03 07:47:19 nvb sudo[868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:19 nvb sudo[868]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:19 nvb sudo[868]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:19 nvb dhcpcd[824]: wlan0: probing for an IPv4LL address
Apr 03 07:47:19 nvb dhcpcd[824]: wlan0: DHCP lease expired
Apr 03 07:47:19 nvb dhcpcd[824]: wlan0: soliciting a DHCP lease
Apr 03 07:47:20 nvb wireless.js[560]: trying...
Apr 03 07:47:20 nvb sudo[880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:20 nvb sudo[880]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:20 nvb sudo[880]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:21 nvb wireless.js[560]: trying...
Apr 03 07:47:21 nvb sudo[883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:21 nvb sudo[883]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:21 nvb sudo[883]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:22 nvb wireless.js[560]: trying...
Apr 03 07:47:22 nvb sudo[886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:22 nvb sudo[886]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:22 nvb sudo[886]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:23 nvb wireless.js[560]: trying...
Apr 03 07:47:23 nvb sudo[889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:23 nvb sudo[889]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:23 nvb sudo[889]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:24 nvb wireless.js[560]: trying...
Apr 03 07:47:24 nvb sudo[892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:24 nvb sudo[892]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:24 nvb sudo[892]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:24 nvb dhcpcd[824]: wlan0: using IPv4LL address 169.254.126.23
Apr 03 07:47:24 nvb avahi-daemon[570]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.126.23.
Apr 03 07:47:24 nvb avahi-daemon[570]: New relevant interface wlan0.IPv4 for mDNS.
Apr 03 07:47:24 nvb dhcpcd[824]: wlan0: adding route to 169.254.0.0/16
Apr 03 07:47:24 nvb avahi-daemon[570]: Registering new address record for 169.254.126.23 on wlan0.IPv4.
Apr 03 07:47:24 nvb dhcpcd[824]: wlan0: adding default route
Apr 03 07:47:25 nvb volumio-remote-updater[576]: [2024-04-03 07:47:25] [info] asio async_connect error: system:111 (Connection refused)
Apr 03 07:47:25 nvb volumio-remote-updater[576]: [2024-04-03 07:47:25] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Apr 03 07:47:25 nvb volumio-remote-updater[576]: [2024-04-03 07:47:25] [error] handle_connect error: Underlying Transport Error
Apr 03 07:47:25 nvb wireless.js[560]: trying...
Apr 03 07:47:25 nvb sudo[906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 03 07:47:25 nvb sudo[906]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:25 nvb sudo[906]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:25 nvb wireless.js[560]: Connected to: ----grafenwlan
Apr 03 07:47:25 nvb wireless.js[560]: ----
Apr 03 07:47:25 nvb sudo[909]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 03 07:47:25 nvb sudo[909]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:25 nvb sudo[909]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:25 nvb wireless.js[560]: ... joined AP, wlan0 IPv4 is 169.254.126.23, ipV6 is undefined
Apr 03 07:47:25 nvb wireless.js[560]: It's done! AP
Apr 03 07:47:25 nvb systemd[1]: Started Wireless Services.
Apr 03 07:47:25 nvb kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Apr 03 07:47:25 nvb systemd[1]: Started Volumio Backend Module.
Apr 03 07:47:25 nvb systemd[1]: Started Volumio Cpu Tweaker.
Apr 03 07:47:25 nvb volumio-cpu-tweak[915]: Setting RT Priority for mpd
Apr 03 07:47:25 nvb volumio-cpu-tweak[915]: pid 35's current scheduling policy: SCHED_OTHER
Apr 03 07:47:25 nvb volumio-cpu-tweak[915]: pid 35's current scheduling priority: 0
Apr 03 07:47:25 nvb volumio-cpu-tweak[915]: Setting MPD Affinity
Apr 03 07:47:25 nvb volumio-cpu-tweak[915]: pid 3's current affinity mask: f
Apr 03 07:47:25 nvb volumio-cpu-tweak[915]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input
Apr 03 07:47:25 nvb volumio-cpu-tweak[915]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Apr 03 07:47:25 nvb systemd[1]: volumio_cpu_tweak.service: Succeeded.
Apr 03 07:47:25 nvb ntpd[713]: Listen normally on 3 wlan0 169.254.126.23:123
Apr 03 07:47:25 nvb ntpd[713]: new interface(s) found: waking up resolver
Apr 03 07:47:27 nvb volumio[914]: info: -------------------------------------------
Apr 03 07:47:27 nvb volumio[914]: info: ----- Volumio3 ----
Apr 03 07:47:27 nvb volumio[914]: info: -------------------------------------------
Apr 03 07:47:27 nvb volumio[914]: info: ----- System startup ----
Apr 03 07:47:27 nvb volumio[914]: info: -------------------------------------------
Apr 03 07:47:27 nvb systemd[1]: systemd-fsckd.service: Succeeded.
Apr 03 07:47:28 nvb volumio[914]: info: MYVOLUMIO Environment detected
Apr 03 07:47:28 nvb volumio[914]: info: Plugin folders cleanup
Apr 03 07:47:28 nvb volumio[914]: info: Scanning into folder /volumio/app/plugins/
Apr 03 07:47:28 nvb volumio[914]: info: Scanning category audio_interface
Apr 03 07:47:28 nvb volumio[914]: info: Scanning category miscellanea
Apr 03 07:47:28 nvb volumio[914]: info: Scanning category music_service
Apr 03 07:47:28 nvb volumio[914]: info: Scanning category plugins.json
Apr 03 07:47:28 nvb volumio[914]: info: Scanning category system_controller
Apr 03 07:47:28 nvb volumio[914]: info: Scanning category user_interface
Apr 03 07:47:28 nvb volumio[914]: info: Scanning into folder /data/plugins/
Apr 03 07:47:28 nvb volumio[914]: info: Plugin folders cleanup completed
Apr 03 07:47:28 nvb volumio[914]: info: -------------------------------------------
Apr 03 07:47:28 nvb volumio[914]: info: ----- Core plugins startup ----
Apr 03 07:47:28 nvb volumio[914]: info: -------------------------------------------
Apr 03 07:47:28 nvb volumio[914]: info: Loading plugins from folder /volumio/app/plugins/
Apr 03 07:47:28 nvb volumio[914]: info: Adding plugin upnp to MyMusic Plugins
Apr 03 07:47:28 nvb volumio[914]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 03 07:47:28 nvb volumio[914]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 03 07:47:28 nvb volumio[914]: info: Loading plugins from folder /data/plugins/
Apr 03 07:47:28 nvb volumio[914]: info: Loading plugin "system"...
Apr 03 07:47:28 nvb volumio[914]: info: Loading plugin "appearance"...
Apr 03 07:47:28 nvb nmbd[672]: [2024/04/03 07:47:28.932401, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Apr 03 07:47:28 nvb systemd[1]: Started Samba NMB Daemon.
Apr 03 07:47:28 nvb nmbd[672]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Apr 03 07:47:28 nvb systemd[1]: Starting Samba Winbind Daemon...
Apr 03 07:47:29 nvb wpa_supplicant[812]: RRM: Ignoring radio measurement request: Not RRM network
Apr 03 07:47:29 nvb winbindd[944]: [2024/04/03 07:47:29.245006, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Apr 03 07:47:29 nvb winbindd[944]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Apr 03 07:47:29 nvb winbindd[944]: [2024/04/03 07:47:29.283145, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Apr 03 07:47:29 nvb winbindd[944]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Apr 03 07:47:29 nvb systemd[1]: Started Samba Winbind Daemon.
Apr 03 07:47:29 nvb systemd[1]: Starting Samba SMB Daemon...
Apr 03 07:47:29 nvb volumio[914]: info: Loading plugin "network"...
Apr 03 07:47:29 nvb volumio[914]: info: Refreshing Cached IP Addresses
Apr 03 07:47:29 nvb sudo[951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 03 07:47:29 nvb sudo[951]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:29 nvb volumio[914]: info: Loading plugin "services"...
Apr 03 07:47:29 nvb sudo[953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 03 07:47:29 nvb sudo[953]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:29 nvb sudo[951]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:29 nvb volumio[914]: info: Loading plugin "alsa_controller"...
Apr 03 07:47:29 nvb sudo[953]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:29 nvb sudo[957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 03 07:47:29 nvb sudo[957]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:29 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 03 07:47:29 nvb volumio[914]: info: Loading plugin "wizard"...
Apr 03 07:47:29 nvb volumio[914]: info: Loading plugin "networkfs"...
Apr 03 07:47:29 nvb volumio[914]: info: Starting Udev Watcher for removable devices
Apr 03 07:47:29 nvb volumio[914]: info: Ignoring mount for partition: boot
Apr 03 07:47:29 nvb volumio[914]: info: Ignoring mount for partition: volumio
Apr 03 07:47:29 nvb volumio[914]: info: Ignoring mount for partition: volumio_data
Apr 03 07:47:29 nvb volumio[914]: error: Cannot associate FS Label, not mounting
Apr 03 07:47:29 nvb volumio[914]: info: Mounting Device Crucial_X9
Apr 03 07:47:29 nvb sudo[968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/Crucial_X9 -o noatime
Apr 03 07:47:29 nvb sudo[968]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:29 nvb winbindd[944]: [2024/04/03 07:47:29.681234, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv)
Apr 03 07:47:29 nvb winbindd[944]: res_names->count = 3, expected 4
Apr 03 07:47:29 nvb systemd[1]: Started Samba SMB Daemon.
Apr 03 07:47:29 nvb systemd[1]: Reached target Multi-User System.
Apr 03 07:47:29 nvb systemd[1]: Reached target Graphical Interface.
Apr 03 07:47:29 nvb smbd[949]: [2024/04/03 07:47:29.734817, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Apr 03 07:47:29 nvb smbd[949]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Apr 03 07:47:29 nvb mount.exfat[972]: volume was not unmounted cleanly
Apr 03 07:47:29 nvb systemd[1]: Starting Update UTMP about System Runlevel Changes...
Apr 03 07:47:29 nvb systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Apr 03 07:47:29 nvb systemd[1]: Started Update UTMP about System Runlevel Changes.
Apr 03 07:47:29 nvb systemd[1]: Startup finished in 10.592s (kernel) + 39.666s (userspace) = 50.259s.
Apr 03 07:47:29 nvb sudo[968]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:29 nvb volumio[914]: WARN: volume was not unmounted cleanly.
Apr 03 07:47:29 nvb kernel: fuse: init (API version 7.37)
Apr 03 07:47:29 nvb volumio[914]: error: Cannot associate FS Label, not mounting
Apr 03 07:47:29 nvb systemd[1]: Mounting FUSE Control File System...
Apr 03 07:47:29 nvb systemd[1]: Mounted FUSE Control File System.
Apr 03 07:47:29 nvb volumio[914]: info: Mounting Device Lossless4tb
Apr 03 07:47:29 nvb sudo[986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb2 /mnt/USB/Lossless4tb -o noatime
Apr 03 07:47:29 nvb sudo[986]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:30 nvb mount.exfat[988]: volume was not unmounted cleanly
Apr 03 07:47:30 nvb sudo[986]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:30 nvb volumio[914]: WARN: volume was not unmounted cleanly.
Apr 03 07:47:30 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 03 07:47:30 nvb volumio[914]: info: Loading plugin "volumio_command_line_client"...
Apr 03 07:47:30 nvb volumio[914]: info: Loading plugin "upnp"...
Apr 03 07:47:30 nvb volumio[914]: info: [1712123250134] Starting Upmpd Daemon
Apr 03 07:47:30 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 03 07:47:30 nvb volumio[914]: info: Loading plugin "my_music"...
Apr 03 07:47:30 nvb volumio[914]: info: Loading plugin "mpd"...
Apr 03 07:47:30 nvb volumio[914]: info: Loading plugin "upnp_browser"...
Apr 03 07:47:30 nvb volumio[914]: info: Loading plugin "alarm-clock"...
Apr 03 07:47:30 nvb volumio[914]: info: Loading plugin "airplay_emulation"...
Apr 03 07:47:30 nvb volumio[914]: info: Starting Shairport Sync
Apr 03 07:47:30 nvb volumio[914]: info: Loading plugin "last_100"...
Apr 03 07:47:30 nvb volumio[914]: info: Loading plugin "webradio"...
Apr 03 07:47:30 nvb volumio[914]: info: Loading plugin "i2s_dacs"...
Apr 03 07:47:31 nvb volumio[914]: info: Loading plugin "volumiodiscovery"...
Apr 03 07:47:31 nvb volumio[914]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 03 07:47:31 nvb volumio[914]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 03 07:47:31 nvb node[914]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 03 07:47:31 nvb volumio[914]: *** WARNING *** For more information see
Apr 03 07:47:31 nvb volumio[914]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 03 07:47:31 nvb volumio[914]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 03 07:47:31 nvb volumio[914]: *** WARNING *** For more information see
Apr 03 07:47:31 nvb node[914]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 03 07:47:31 nvb node[914]: *** WARNING *** For more information see
Apr 03 07:47:31 nvb node[914]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 03 07:47:31 nvb node[914]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 03 07:47:31 nvb node[914]: *** WARNING *** For more information see
Apr 03 07:47:31 nvb volumio[914]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 03 07:47:31 nvb volumio[914]: info: Discovery: Started advertising with name: nvb
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 03 07:47:31 nvb volumio[914]: info: Loading plugin "outputs"...
Apr 03 07:47:31 nvb volumio[914]: info: Loading plugin "albumart"...
Apr 03 07:47:31 nvb volumio[914]: info: Plugin example_plugin is not enabled
Apr 03 07:47:31 nvb volumio[914]: info: Loading plugin "inputs"...
Apr 03 07:47:31 nvb volumio[914]: info: Loading plugin "updater_comm"...
Apr 03 07:47:31 nvb volumio[914]: info: Plugin mpdemulation is not enabled
Apr 03 07:47:31 nvb volumio[914]: info: Loading plugin "rest_api"...
Apr 03 07:47:31 nvb volumio[914]: info: Loading plugin "websocket"...
Apr 03 07:47:31 nvb volumio[914]: info: Loading i18n strings for locale de
Apr 03 07:47:31 nvb volumio[914]: Updating browse sources language
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 03 07:47:31 nvb volumio[914]: Forking 3 albumart workers
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::initPlayerControls
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 03 07:47:31 nvb volumio[914]: Express server listening on port 3000
Apr 03 07:47:31 nvb volumio[914]: [Metrics] WebUI: 4s 856.72ms
Apr 03 07:47:31 nvb volumio[914]: info: CoreStateMachine::resetVolumioState
Apr 03 07:47:31 nvb volumio[914]: info: CoreStateMachine::getcurrentVolume
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::volumioRetrievevolume
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 03 07:47:31 nvb volumio[914]: info: Reloading queue from file
Apr 03 07:47:31 nvb volumio[914]: info: CoreStateMachine::pushState
Apr 03 07:47:31 nvb volumio[914]: info: CorePlayQueue::getTrack 0
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::volumioPushState
Apr 03 07:47:31 nvb volumio[914]: info: CoreStateMachine::updateTrackBlock
Apr 03 07:47:31 nvb volumio[914]: info: CorePlayQueue::getTrackBlock
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::volumioRetrievevolume
Apr 03 07:47:31 nvb volumio[914]: info: CoreStateMachine::setRepeat true single undefined
Apr 03 07:47:31 nvb volumio[914]: info: CoreStateMachine::pushState
Apr 03 07:47:31 nvb volumio[914]: info: CorePlayQueue::getTrack 0
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::volumioPushState
Apr 03 07:47:31 nvb volumio[914]: info: CoreStateMachine::setRandom null
Apr 03 07:47:31 nvb volumio[914]: info: CoreStateMachine::pushState
Apr 03 07:47:31 nvb volumio[914]: info: CorePlayQueue::getTrack 0
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::volumioPushState
Apr 03 07:47:31 nvb volumio[914]: info: Setting Device type: Raspberry PI
Apr 03 07:47:31 nvb volumio[914]: info: CoreStateMachine::pushState
Apr 03 07:47:31 nvb volumio[914]: info: CorePlayQueue::getTrack 0
Apr 03 07:47:31 nvb volumio[914]: info: CoreCommandRouter::volumioPushState
Apr 03 07:47:31 nvb sh[470]: timed out
Apr 03 07:47:31 nvb dhcpcd[514]: timed out
Apr 03 07:47:31 nvb sh[470]: dhcpcd exited
Apr 03 07:47:31 nvb dhcpcd[514]: dhcpcd exited
Apr 03 07:47:31 nvb sh[470]: ifup: failed to bring up eth0
Apr 03 07:47:31 nvb systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Apr 03 07:47:31 nvb systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Apr 03 07:47:31 nvb volumio[914]: Starting albumart workers
Apr 03 07:47:31 nvb volumio[914]: Starting albumart workers
Apr 03 07:47:31 nvb volumio[914]: Starting albumart workers
Apr 03 07:47:33 nvb sudo[957]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:33 nvb systemd[1]: systemd-hostnamed.service: Succeeded.
Apr 03 07:47:35 nvb volumio-remote-updater[576]: [2024-04-03 07:47:35] [connect] Successful connection
Apr 03 07:47:35 nvb volumio-remote-updater[576]: [2024-04-03 07:47:35] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1712123255 101
Apr 03 07:47:35 nvb volumio[914]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1
Apr 03 07:47:35 nvb wpa_supplicant[812]: RRM: Ignoring radio measurement request: Not RRM network
Apr 03 07:47:37 nvb wpa_supplicant[812]: RRM: Ignoring radio measurement request: Not RRM network
Apr 03 07:47:39 nvb wpa_supplicant[812]: RRM: Ignoring radio measurement request: Not RRM network
Apr 03 07:47:40 nvb dhcpcd[824]: wlan0: carrier lost
Apr 03 07:47:40 nvb wpa_supplicant[812]: wlan0: Associated with f0:b0:14:fc:e7:fe
Apr 03 07:47:40 nvb wpa_supplicant[812]: wlan0: CTRL-EVENT-CONNECTED - Connection to f0:b0:14:fc:e7:fe completed [id=0 id_str=]
Apr 03 07:47:40 nvb wpa_supplicant[812]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 03 07:47:40 nvb avahi-daemon[570]: Withdrawing address record for 169.254.126.23 on wlan0.
Apr 03 07:47:40 nvb avahi-daemon[570]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.126.23.
Apr 03 07:47:40 nvb avahi-daemon[570]: Interface wlan0.IPv4 no longer relevant for mDNS.
Apr 03 07:47:40 nvb dhcpcd[824]: wlan0: deleting route to 169.254.0.0/16
Apr 03 07:47:40 nvb dhcpcd[824]: wlan0: deleting default route
Apr 03 07:47:40 nvb volumio[914]: info: Discovery: A device disappeared from network
Apr 03 07:47:40 nvb volumio[914]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined
Apr 03 07:47:40 nvb sudo[1093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 03 07:47:40 nvb sudo[1093]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:40 nvb sudo[1093]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:40 nvb sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 03 07:47:40 nvb sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:40 nvb sudo[1100]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:40 nvb sudo[1103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 03 07:47:40 nvb sudo[1103]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:47:40 nvb dhcpcd[824]: wlan0: carrier acquired
Apr 03 07:47:40 nvb dhcpcd[824]: wlan0: IAID dd:99:36:32
Apr 03 07:47:40 nvb systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 03 07:47:40 nvb sudo[1103]: pam_unix(sudo:session): session closed for user root
Apr 03 07:47:40 nvb volumio[914]: info: Upmpdcli Daemon Started
Apr 03 07:47:40 nvb volumio[914]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Apr 03 07:47:40 nvb dhcpcd[824]: wlan0: soliciting an IPv6 router
Apr 03 07:47:41 nvb dhcpcd[824]: wlan0: soliciting a DHCP lease
Apr 03 07:47:41 nvb dhcpcd[824]: wlan0: offered 192.168.178.53 from 192.168.178.1
Apr 03 07:47:41 nvb dhcpcd[824]: wlan0: probing address 192.168.178.53/24
Apr 03 07:47:41 nvb ntpd[713]: Deleting interface #3 wlan0, 169.254.126.23#123, interface stats: received=0, sent=0, dropped=0, active_time=16 secs
Apr 03 07:47:43 nvb systemd[1]: Stopped target Local File Systems.
Apr 03 07:47:43 nvb kernel: I/O error, dev mmcblk0, sector 188416 op 0x1:(WRITE) flags 0x103000 phys_seg 1 prio class 2
Apr 03 07:47:43 nvb kernel: mmc0: card e624 removed
Apr 03 07:47:43 nvb kernel: Buffer I/O error on dev mmcblk0p2, logical block 0, lost async page write
Apr 03 07:47:43 nvb kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 4653363 starting block 3772058)
Apr 03 07:47:43 nvb kernel: Buffer I/O error on device mmcblk0p3, logical block 1037978
Apr 03 07:47:43 nvb kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 4653371 starting block 21994006)
Apr 03 07:47:43 nvb kernel: Buffer I/O error on device mmcblk0p3, logical block 19259926
Apr 03 07:47:43 nvb kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 4653371 starting block 21995529)
Apr 03 07:47:43 nvb kernel: Buffer I/O error on device mmcblk0p3, logical block 19261449
Apr 03 07:47:43 nvb kernel: Buffer I/O error on device mmcblk0p3, logical block 19261450
Apr 03 07:47:43 nvb kernel: Buffer I/O error on device mmcblk0p3, logical block 19261451
Apr 03 07:47:43 nvb kernel: Buffer I/O error on device mmcblk0p3, logical block 19261452
Apr 03 07:47:43 nvb kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 4653371 starting block 21996119)
Apr 03 07:47:43 nvb kernel: Buffer I/O error on device mmcblk0p3, logical block 19262039
Apr 03 07:47:43 nvb kernel: Buffer I/O error on device mmcblk0p3, logical block 19262040
Apr 03 07:47:43 nvb kernel: Buffer I/O error on device mmcblk0p3, logical block 19262041
Apr 03 07:47:43 nvb kernel: Buffer I/O error on device mmcblk0p3, logical block 19262042
Apr 03 07:47:43 nvb kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 4653370 starting block 22118402)
Apr 03 07:47:43 nvb kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 4658999 starting block 22118407)
Apr 03 07:47:43 nvb kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 4653363 starting block 3767809)
Apr 03 07:47:43 nvb kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 4653363 starting block 3767812)
Apr 03 07:47:43 nvb kernel: JBD2: Detected IO errors while flushing file data on mmcblk0p3-8
Apr 03 07:47:43 nvb kernel: Aborting journal on device mmcblk0p3-8.
Apr 03 07:47:43 nvb kernel: JBD2: I/O error when updating journal superblock for mmcblk0p3-8.
Apr 03 07:47:43 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653577: comm node: reading directory lblock 0
Apr 03 07:47:43 nvb kernel: EXT4-fs (mmcblk0p3): previous I/O error to superblock detected
Apr 03 07:47:43 nvb kernel: EXT4-fs (mmcblk0p3): I/O error while writing superblock
Apr 03 07:47:43 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653577: comm node: reading directory lblock 0
Apr 03 07:47:43 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653577: comm node: reading directory lblock 0
Apr 03 07:47:43 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb volumio[914]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/F102-DE29 /dev/disk/by-path/platform-fe340000.mmc-part1 /dev/disk/by-partuuid/8ca0658c-01 /dev/disk/by-id/mmc-SU32G_0x186a3b0e-part1 /dev/disk/by-label/boot","DEVNAME":"/dev/mmcblk0p1","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p1","DEVTYPE":"partition","DISKSEQ":"25","ID_FS_LABEL":"boot","ID_FS_LABEL_ENC":"boot","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"F102-DE29","ID_FS_UUID_ENC":"F102-DE29","ID_FS_VERSION":"FAT16","ID_NAME":"SU32G","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"1","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"187500","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"8ca0658c-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x186a3b0e","MAJOR":"179","MINOR":"1","PARTN":"1","SEQNUM":"1816","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"14165412"}
Apr 03 07:47:43 nvb systemd[1109]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb volumio[914]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p2","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-fe340000.mmc-part2 /dev/disk/by-uuid/db7775c5-9234-4b9a-955e-7341a245d498 /dev/disk/by-id/mmc-SU32G_0x186a3b0e-part2 /dev/disk/by-partuuid/8ca0658c-02 /dev/disk/by-label/volumio","DEVNAME":"/dev/mmcblk0p2","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p2","DEVTYPE":"partition","DISKSEQ":"25","ID_FS_LABEL":"volumio","ID_FS_LABEL_ENC":"volumio","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"db7775c5-9234-4b9a-955e-7341a245d498","ID_FS_UUID_ENC":"db7775c5-9234-4b9a-955e-7341a245d498","ID_FS_VERSION":"1.0","ID_NAME":"SU32G","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"188416","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"5279744","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"8ca0658c-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x186a3b0e","MAJOR":"179","MINOR":"2","PARTN":"2","SEQNUM":"1817","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"14150058"}
Apr 03 07:47:43 nvb systemd[1109]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb volumio[914]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p3","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/8ca0658c-03 /dev/disk/by-uuid/4112086d-38d3-4206-a7af-ef93bf4e4008 /dev/disk/by-id/mmc-SU32G_0x186a3b0e-part3 /dev/disk/by-label/volumio_data /dev/disk/by-path/platform-fe340000.mmc-part3","DEVNAME":"/dev/mmcblk0p3","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p3","DEVTYPE":"partition","DISKSEQ":"25","ID_FS_LABEL":"volumio_data","ID_FS_LABEL_ENC":"volumio_data","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"4112086d-38d3-4206-a7af-ef93bf4e4008","ID_FS_UUID_ENC":"4112086d-38d3-4206-a7af-ef93bf4e4008","ID_FS_VERSION":"1.0","ID_NAME":"SU32G","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_NUMBER":"3","ID_PART_ENTRY_OFFSET":"5468160","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"56865792","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"8ca0658c-03","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x186a3b0e","MAJOR":"179","MINOR":"3","PARTN":"3","SEQNUM":"1818","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"14092658"}
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1111]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1111]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1112]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1112]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:47:43 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1113]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1113]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1114]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1114]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1115]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1115]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:47:43 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1116]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1116]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1117]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1117]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1118]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1118]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1119]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1119]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1120]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1120]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1121]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1121]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1122]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1122]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1123]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1123]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1124]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1124]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1125]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1125]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:43 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:43 nvb systemd[1126]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:43 nvb systemd[1126]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:43 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:43 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device, but not stopping since we tried this too often recently.
Apr 03 07:47:43 nvb systemd[1]: systemd-fsck@dev-mmcblk0p1.service: Succeeded.
Apr 03 07:47:43 nvb systemd[1]: Stopped File System Check on /dev/mmcblk0p1.
Apr 03 07:47:43 nvb kernel: mmc0: error -110 whilst initialising SD card
Apr 03 07:47:44 nvb volumio[914]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Apr 03 07:47:45 nvb dhcpcd[824]: wlan0: leased 192.168.178.53 for 864000 seconds
Apr 03 07:47:45 nvb dhcpcd[824]: dhcp_bind: Input/output error
Apr 03 07:47:45 nvb avahi-daemon[570]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.53.
Apr 03 07:47:45 nvb avahi-daemon[570]: New relevant interface wlan0.IPv4 for mDNS.
Apr 03 07:47:45 nvb dhcpcd[824]: wlan0: adding route to 192.168.178.0/24
Apr 03 07:47:45 nvb avahi-daemon[570]: Registering new address record for 192.168.178.53 on wlan0.IPv4.
Apr 03 07:47:45 nvb dhcpcd[824]: wlan0: adding default route via 192.168.178.1
Apr 03 07:47:45 nvb kernel: EXT4-fs (mmcblk0p3): Remounting filesystem read-only
Apr 03 07:47:46 nvb wpa_supplicant[812]: RRM: Ignoring radio measurement request: Not RRM network
Apr 03 07:47:46 nvb volumio[914]: info: Discovery: adding 51b9f286-d8a2-475f-8fc7-a3b2545e52d8
Apr 03 07:47:46 nvb volumio[914]: info: Discovery: Found device nvb
Apr 03 07:47:46 nvb volumio[914]: info: CoreCommandRouter::volumioGetState
Apr 03 07:47:46 nvb volumio[914]: info: CorePlayQueue::getTrack 0
Apr 03 07:47:46 nvb volumio[914]: info: Discovery: this is already registered, 51b9f286-d8a2-475f-8fc7-a3b2545e52d8
Apr 03 07:47:46 nvb volumio[914]: info: Discovery: Found device nvb
Apr 03 07:47:46 nvb volumio[914]: info: CoreCommandRouter::volumioGetState
Apr 03 07:47:46 nvb volumio[914]: info: CorePlayQueue::getTrack 0
Apr 03 07:47:46 nvb dhcpcd[824]: wlan0: carrier lost
Apr 03 07:47:46 nvb wpa_supplicant[812]: wlan0: Associated with 98:9b:cb:03:24:b9
Apr 03 07:47:46 nvb wpa_supplicant[812]: wlan0: CTRL-EVENT-CONNECTED - Connection to 98:9b:cb:03:24:b9 completed [id=0 id_str=]
Apr 03 07:47:46 nvb wpa_supplicant[812]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 03 07:47:46 nvb avahi-daemon[570]: Withdrawing address record for 192.168.178.53 on wlan0.
Apr 03 07:47:46 nvb avahi-daemon[570]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.53.
Apr 03 07:47:46 nvb dhcpcd[824]: wlan0: deleting route to 192.168.178.0/24
Apr 03 07:47:46 nvb dhcpcd[824]: wlan0: deleting default route via 192.168.178.1
Apr 03 07:47:46 nvb avahi-daemon[570]: Interface wlan0.IPv4 no longer relevant for mDNS.
Apr 03 07:47:46 nvb volumio[914]: info: Discovery: A device disappeared from network
Apr 03 07:47:46 nvb volumio[914]: info: Discovery: Device nvb disappeared from network
Apr 03 07:47:46 nvb dhcpcd[824]: wlan0: carrier acquired
Apr 03 07:47:46 nvb dhcpcd[824]: wlan0: IAID dd:99:36:32
Apr 03 07:47:46 nvb dhcpcd[824]: wlan0: soliciting a DHCP lease
Apr 03 07:47:46 nvb dhcpcd[824]: wlan0: offered 192.168.178.53 from 192.168.178.1
Apr 03 07:47:47 nvb dhcpcd[824]: wlan0: probing address 192.168.178.53/24
Apr 03 07:47:47 nvb dhcpcd[824]: wlan0: soliciting an IPv6 router
Apr 03 07:47:50 nvb volumio[914]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Apr 03 07:47:50 nvb kernel: mmc0: new high speed SDHC card at address e624
Apr 03 07:47:50 nvb kernel: mmcblk0: mmc0:e624 SU32G 29.7 GiB
Apr 03 07:47:50 nvb kernel: mmcblk0: p1 p2 p3
Apr 03 07:47:50 nvb kernel: mmcblk0: mmc0:e624 SU32G 29.7 GiB (quirks 0x00004000)
Apr 03 07:47:51 nvb volumio[914]: info: Ignoring mount for partition: volumio
Apr 03 07:47:51 nvb volumio[914]: info: Ignoring mount for partition: volumio_data
Apr 03 07:47:51 nvb volumio[914]: info: Ignoring mount for partition: boot
Apr 03 07:47:51 nvb dhcpcd[824]: wlan0: leased 192.168.178.53 for 864000 seconds
Apr 03 07:47:51 nvb dhcpcd[824]: dhcp_bind: Read-only file system
Apr 03 07:47:51 nvb avahi-daemon[570]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.53.
Apr 03 07:47:51 nvb avahi-daemon[570]: New relevant interface wlan0.IPv4 for mDNS.
Apr 03 07:47:51 nvb dhcpcd[824]: wlan0: adding route to 192.168.178.0/24
Apr 03 07:47:51 nvb avahi-daemon[570]: Registering new address record for 192.168.178.53 on wlan0.IPv4.
Apr 03 07:47:51 nvb dhcpcd[824]: wlan0: adding default route via 192.168.178.1
Apr 03 07:47:52 nvb volumio[914]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/F102-DE29 /dev/disk/by-path/platform-fe340000.mmc-part1 /dev/disk/by-partuuid/8ca0658c-01 /dev/disk/by-id/mmc-SU32G_0x186a3b0e-part1 /dev/disk/by-label/boot","DEVNAME":"/dev/mmcblk0p1","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p1","DEVTYPE":"partition","DISKSEQ":"29","ID_FS_LABEL":"boot","ID_FS_LABEL_ENC":"boot","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"F102-DE29","ID_FS_UUID_ENC":"F102-DE29","ID_FS_VERSION":"FAT16","ID_NAME":"SU32G","ID_PART_ENTRY_DISK":"179:32","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"1","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"187500","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"8ca0658c-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x186a3b0e","MAJOR":"179","MINOR":"33","PARTN":"1","SEQNUM":"1830","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"71699317"}
Apr 03 07:47:52 nvb volumio[914]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p2","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-fe340000.mmc-part2 /dev/disk/by-uuid/db7775c5-9234-4b9a-955e-7341a245d498 /dev/disk/by-id/mmc-SU32G_0x186a3b0e-part2 /dev/disk/by-partuuid/8ca0658c-02 /dev/disk/by-label/volumio","DEVNAME":"/dev/mmcblk0p2","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p2","DEVTYPE":"partition","DISKSEQ":"29","ID_FS_LABEL":"volumio","ID_FS_LABEL_ENC":"volumio","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"db7775c5-9234-4b9a-955e-7341a245d498","ID_FS_UUID_ENC":"db7775c5-9234-4b9a-955e-7341a245d498","ID_FS_VERSION":"1.0","ID_NAME":"SU32G","ID_PART_ENTRY_DISK":"179:32","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"188416","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"5279744","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"8ca0658c-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x186a3b0e","MAJOR":"179","MINOR":"34","PARTN":"2","SEQNUM":"1831","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"71673590"}
Apr 03 07:47:52 nvb volumio[914]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p3","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/8ca0658c-03 /dev/disk/by-uuid/4112086d-38d3-4206-a7af-ef93bf4e4008 /dev/disk/by-id/mmc-SU32G_0x186a3b0e-part3 /dev/disk/by-label/volumio_data /dev/disk/by-path/platform-fe340000.mmc-part3","DEVNAME":"/dev/mmcblk0p3","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p3","DEVTYPE":"partition","DISKSEQ":"29","ID_FS_LABEL":"volumio_data","ID_FS_LABEL_ENC":"volumio_data","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"4112086d-38d3-4206-a7af-ef93bf4e4008","ID_FS_UUID_ENC":"4112086d-38d3-4206-a7af-ef93bf4e4008","ID_FS_VERSION":"1.0","ID_NAME":"SU32G","ID_PART_ENTRY_DISK":"179:32","ID_PART_ENTRY_NUMBER":"3","ID_PART_ENTRY_OFFSET":"5468160","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"56865792","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"8ca0658c-03","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x186a3b0e","MAJOR":"179","MINOR":"35","PARTN":"3","SEQNUM":"1832","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"71673683"}
Apr 03 07:47:52 nvb kernel: mmc0: card e624 removed
Apr 03 07:47:52 nvb kernel: EXT4-fs error: 12 callbacks suppressed
Apr 03 07:47:52 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653577: comm node: reading directory lblock 0
Apr 03 07:47:52 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653577: comm node: reading directory lblock 0
Apr 03 07:47:52 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653577: comm node: reading directory lblock 0
Apr 03 07:47:52 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:52 nvb systemd[1207]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:52 nvb systemd[1207]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:52 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:52 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:52 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device, but not stopping since we tried this too often recently.
Apr 03 07:47:52 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:47:52 nvb volumio[914]: info: Discovery: adding 51b9f286-d8a2-475f-8fc7-a3b2545e52d8
Apr 03 07:47:52 nvb volumio[914]: info: Discovery: Found device nvb
Apr 03 07:47:52 nvb volumio[914]: info: CoreCommandRouter::volumioGetState
Apr 03 07:47:52 nvb volumio[914]: info: CorePlayQueue::getTrack 0
Apr 03 07:47:52 nvb ntpd[713]: Listen normally on 4 wlan0 192.168.178.53:123
Apr 03 07:47:52 nvb ntpd[713]: new interface(s) found: waking up resolver
Apr 03 07:47:54 nvb kernel: mmc0: new high speed SDHC card at address e624
Apr 03 07:47:54 nvb kernel: mmcblk0: mmc0:e624 SU32G 29.7 GiB
Apr 03 07:47:54 nvb kernel: mmcblk0: p1 p2 p3
Apr 03 07:47:54 nvb kernel: mmcblk0: mmc0:e624 SU32G 29.7 GiB (quirks 0x00004000)
Apr 03 07:47:54 nvb wpa_supplicant[812]: RRM: Ignoring radio measurement request: Not RRM network
Apr 03 07:47:54 nvb volumio[914]: info: Ignoring mount for partition: volumio
Apr 03 07:47:54 nvb volumio[914]: info: Ignoring mount for partition: volumio_data
Apr 03 07:47:54 nvb volumio[914]: info: Ignoring mount for partition: boot
Apr 03 07:47:56 nvb wpa_supplicant[812]: RRM: Ignoring radio measurement request: Not RRM network
Apr 03 07:47:58 nvb volumio[914]: error: Failed to update update history file: function createApplication() {
Apr 03 07:47:58 nvb volumio[914]: var app = function(req, res, next) {
Apr 03 07:47:58 nvb volumio[914]: app.handle(req, res, next);
Apr 03 07:47:58 nvb volumio[914]: };
Apr 03 07:47:58 nvb volumio[914]: mixin(app, EventEmitter.prototype, false);
Apr 03 07:47:58 nvb volumio[914]: mixin(app, proto, false);
Apr 03 07:47:58 nvb volumio[914]: // expose the prototype that will get set on requests
Apr 03 07:47:58 nvb volumio[914]: app.request = Object.create(req, {
Apr 03 07:47:58 nvb volumio[914]: app: { configurable: true, enumerable: true, writable: true, value: app }
Apr 03 07:47:58 nvb volumio[914]: })
Apr 03 07:47:58 nvb volumio[914]: // expose the prototype that will get set on responses
Apr 03 07:47:58 nvb volumio[914]: app.response = Object.create(res, {
Apr 03 07:47:58 nvb volumio[914]: app: { configurable: true, enumerable: true, writable: true, value: app }
Apr 03 07:47:58 nvb volumio[914]: })
Apr 03 07:47:58 nvb volumio[914]: app.init();
Apr 03 07:47:58 nvb volumio[914]: return app;
Apr 03 07:47:58 nvb volumio[914]: }
Apr 03 07:47:58 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653404: comm node: reading directory lblock 0
Apr 03 07:47:58 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653404: comm node: reading directory lblock 0
Apr 03 07:47:58 nvb volumio[914]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/F102-DE29 /dev/disk/by-path/platform-fe340000.mmc-part1 /dev/disk/by-partuuid/8ca0658c-01 /dev/disk/by-id/mmc-SU32G_0x186a3b0e-part1 /dev/disk/by-label/boot","DEVNAME":"/dev/mmcblk0p1","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p1","DEVTYPE":"partition","DISKSEQ":"30","ID_FS_LABEL":"boot","ID_FS_LABEL_ENC":"boot","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"F102-DE29","ID_FS_UUID_ENC":"F102-DE29","ID_FS_VERSION":"FAT16","ID_NAME":"SU32G","ID_PART_ENTRY_DISK":"179:32","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"1","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"187500","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"8ca0658c-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x186a3b0e","MAJOR":"179","MINOR":"33","PARTN":"1","SEQNUM":"1844","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"75297915"}
Apr 03 07:47:58 nvb volumio[914]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p2","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-fe340000.mmc-part2 /dev/disk/by-uuid/db7775c5-9234-4b9a-955e-7341a245d498 /dev/disk/by-id/mmc-SU32G_0x186a3b0e-part2 /dev/disk/by-partuuid/8ca0658c-02 /dev/disk/by-label/volumio","DEVNAME":"/dev/mmcblk0p2","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p2","DEVTYPE":"partition","DISKSEQ":"30","ID_FS_LABEL":"volumio","ID_FS_LABEL_ENC":"volumio","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"db7775c5-9234-4b9a-955e-7341a245d498","ID_FS_UUID_ENC":"db7775c5-9234-4b9a-955e-7341a245d498","ID_FS_VERSION":"1.0","ID_NAME":"SU32G","ID_PART_ENTRY_DISK":"179:32","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"188416","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"5279744","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"8ca0658c-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x186a3b0e","MAJOR":"179","MINOR":"34","PARTN":"2","SEQNUM":"1845","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"75259506"}
Apr 03 07:47:58 nvb kernel: mmc0: card e624 removed
Apr 03 07:47:58 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653577: comm node: reading directory lblock 0
Apr 03 07:47:58 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653577: comm node: reading directory lblock 0
Apr 03 07:47:58 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653577: comm node: reading directory lblock 0
Apr 03 07:47:58 nvb volumio[914]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p3","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/8ca0658c-03 /dev/disk/by-uuid/4112086d-38d3-4206-a7af-ef93bf4e4008 /dev/disk/by-id/mmc-SU32G_0x186a3b0e-part3 /dev/disk/by-label/volumio_data /dev/disk/by-path/platform-fe340000.mmc-part3","DEVNAME":"/dev/mmcblk0p3","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p3","DEVTYPE":"partition","DISKSEQ":"30","ID_FS_LABEL":"volumio_data","ID_FS_LABEL_ENC":"volumio_data","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"4112086d-38d3-4206-a7af-ef93bf4e4008","ID_FS_UUID_ENC":"4112086d-38d3-4206-a7af-ef93bf4e4008","ID_FS_VERSION":"1.0","ID_NAME":"SU32G","ID_PART_ENTRY_DISK":"179:32","ID_PART_ENTRY_NUMBER":"3","ID_PART_ENTRY_OFFSET":"5468160","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"56865792","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"8ca0658c-03","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x186a3b0e","MAJOR":"179","MINOR":"35","PARTN":"3","SEQNUM":"1846","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"75259691"}
Apr 03 07:47:58 nvb wpa_supplicant[812]: RRM: Ignoring radio measurement request: Not RRM network
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1212]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1212]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1213]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1213]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1214]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1214]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:47:58 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1215]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1215]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1216]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1216]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1217]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1217]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1218]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1218]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1219]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1219]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1220]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1220]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1221]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1221]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1222]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1222]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1223]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1223]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1224]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1224]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1225]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1225]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1226]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1226]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1227]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1227]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Apr 03 07:47:58 nvb systemd[1]: Unmounting /boot...
Apr 03 07:47:58 nvb systemd[1228]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:47:58 nvb systemd[1228]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:47:58 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:47:58 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device, but not stopping since we tried this too often recently.
Apr 03 07:47:58 nvb kernel: mmc0: new high speed SDHC card at address e624
Apr 03 07:47:58 nvb kernel: mmcblk0: mmc0:e624 SU32G 29.7 GiB
Apr 03 07:47:58 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:58 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: I/O error, dev mmcblk0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Apr 03 07:47:59 nvb kernel: Buffer I/O error on dev mmcblk0, logical block 0, async page read
Apr 03 07:47:59 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: I/O error, dev mmcblk0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Apr 03 07:47:59 nvb kernel: Buffer I/O error on dev mmcblk0, logical block 0, async page read
Apr 03 07:47:59 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: I/O error, dev mmcblk0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Apr 03 07:47:59 nvb kernel: Buffer I/O error on dev mmcblk0, logical block 0, async page read
Apr 03 07:47:59 nvb kernel: mmcblk0: unable to read partition table
Apr 03 07:47:59 nvb kernel: mmcblk0: mmc0:e624 SU32G 29.7 GiB (quirks 0x00004000)
Apr 03 07:47:59 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: I/O error, dev mmcblk0, sector 62333824 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2
Apr 03 07:47:59 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress.
Apr 03 07:47:59 nvb kernel: I/O error, dev mmcblk0, sector 62333824 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Apr 03 07:47:59 nvb kernel: Buffer I/O error on dev mmcblk0, logical block 7791728, async page read
Apr 03 07:48:00 nvb kernel: mmc0: card e624 removed
Apr 03 07:48:00 nvb volumio[914]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Apr 03 07:48:01 nvb volumio[914]: error: Plugin system_controller system failed to complete 'onVolumioStart' in a timely fashion
Apr 03 07:48:01 nvb volumio[914]: info: Preparing to generate the ALSA configuration file
Apr 03 07:48:01 nvb volumio[914]: warn: Unable to scan plugin alsa_controller for ALSA configuration: Error: EIO: i/o error, scandir '/data/configuration/audio_interface/alsa_controller/asound'
Apr 03 07:48:01 nvb volumio[914]: error: Cannot write /etc/asound.conf: Error: EROFS: read-only file system, open '/home/volumio/.asoundrc'
Apr 03 07:48:01 nvb kernel: EXT4-fs warning (device mmcblk0p3): htree_dirblock_to_tree:1082: inode #4657298: lblock 0: comm node: error -5 reading directory block
Apr 03 07:48:01 nvb volumio[914]: info: Output device has changed, restarting MPD
Apr 03 07:48:01 nvb sudo[1231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 03 07:48:01 nvb volumio[914]: info: Output device has changed, restarting Shairport Sync
Apr 03 07:48:01 nvb sudo[1231]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 03 07:48:01 nvb sudo[1231]: pam_unix(sudo:session): session closed for user root
Apr 03 07:48:01 nvb sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 03 07:48:01 nvb sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:48:01 nvb systemd[1]: Failed to canonicalize path '/etc/systemd/system/mpd.service.wants': Input/output error
Apr 03 07:48:01 nvb systemd[1]: Failed to canonicalize path '/etc/systemd/system/mpd.service.requires': Input/output error
Apr 03 07:48:01 nvb volumio[914]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 03 07:48:01 nvb volumio[914]: info: ___________ START PLUGINS ___________
Apr 03 07:48:01 nvb volumio[914]: info: ControllerMpd::onStart: Initializing MPD
Apr 03 07:48:01 nvb volumio[914]: info: Creating MPD Configuration file
Apr 03 07:48:01 nvb sudo[1241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 03 07:48:01 nvb sudo[1241]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 03 07:48:01 nvb volumio[914]: info: [1712123281407] CoreMusicLibrary::Adding element Medienserver
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 03 07:48:01 nvb sudo[1241]: pam_unix(sudo:session): session closed for user root
Apr 03 07:48:01 nvb sudo[1243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 03 07:48:01 nvb systemd[1]: Starting Music Player Daemon...
Apr 03 07:48:01 nvb sudo[1243]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 03 07:48:01 nvb systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 03 07:48:01 nvb systemd[1]: mpd.service: Succeeded.
Apr 03 07:48:01 nvb systemd[1]: Stopped Music Player Daemon.
Apr 03 07:48:01 nvb systemd[1]: Starting Music Player Daemon...
Apr 03 07:48:01 nvb volumio[914]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 03 07:48:01 nvb systemd[1]: mpd.service: Main process exited, code=killed, status=11/SEGV
Apr 03 07:48:01 nvb systemd[1]: mpd.service: Failed with result 'signal'.
Apr 03 07:48:01 nvb systemd[1]: Failed to start Music Player Daemon.
Apr 03 07:48:01 nvb kernel: I/O error, dev loop0, sector 393582 op 0x0:(READ) flags 0x800 phys_seg 13 prio class 2
Apr 03 07:48:01 nvb kernel: SQUASHFS error: Failed to read block 0xc02dc3f: -5
Apr 03 07:48:01 nvb kernel: I/O error, dev loop0, sector 393582 op 0x0:(READ) flags 0x800 phys_seg 13 prio class 2
Apr 03 07:48:01 nvb kernel: SQUASHFS error: Failed to read block 0xc02dc3f: -5
Apr 03 07:48:01 nvb kernel: SQUASHFS error: Unable to read data cache entry [c02dc3f]
Apr 03 07:48:01 nvb kernel: SQUASHFS error: Unable to read page, block c02dc3f, size c003
Apr 03 07:48:01 nvb kernel: SQUASHFS error: Unable to read data cache entry [c02dc3f]
Apr 03 07:48:01 nvb kernel: SQUASHFS error: Unable to read page, block c02dc3f, size c003
Apr 03 07:48:01 nvb sudo[1243]: pam_unix(sudo:session): session closed for user root
Apr 03 07:48:01 nvb sudo[1233]: pam_unix(sudo:session): session closed for user root
Apr 03 07:48:01 nvb volumio[914]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 03 07:48:01 nvb volumio[914]: info: [1712123281519] CoreMusicLibrary::Adding element Last_100
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 03 07:48:01 nvb volumio[914]: info: [1712123281521] CoreMusicLibrary::Adding element Webradio
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 03 07:48:01 nvb volumio[914]: info: Volumio Calling Home
Apr 03 07:48:01 nvb volumio[914]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service
Apr 03 07:48:01 nvb volumio[914]: Job for mpd.service failed because a fatal signal was delivered to the control process.
Apr 03 07:48:01 nvb volumio[914]: See "systemctl status mpd.service" and "journalctl -xe" for details.
Apr 03 07:48:01 nvb volumio[914]: info: Completed starting Core Plugins
Apr 03 07:48:01 nvb volumio[914]: info: -------------------------------------------
Apr 03 07:48:01 nvb volumio[914]: info: ----- MyVolumio plugins startup ----
Apr 03 07:48:01 nvb volumio[914]: info: -------------------------------------------
Apr 03 07:48:01 nvb volumio[914]: info: [MyVolumio PluginManager] Fetching plans data....
Apr 03 07:48:01 nvb volumio[914]: info: Error setting mpd conf file perms: Error: Command failed: /usr/bin/sudo /bin/chmod 777 /etc/mpd.conf
Apr 03 07:48:01 nvb volumio[914]: /bin/chmod: cannot access '/etc/mpd.conf': Input/output error
Apr 03 07:48:01 nvb volumio[914]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service
Apr 03 07:48:01 nvb volumio[914]: Job for mpd.service failed because a fatal signal was delivered to the control process.
Apr 03 07:48:01 nvb volumio[914]: See "systemctl status mpd.service" and "journalctl -xe" for details.
Apr 03 07:48:01 nvb volumio[914]: info: Error setting mpd conf file perms: Error: Command failed: /usr/bin/sudo /bin/chmod 777 /etc/mpd.conf
Apr 03 07:48:01 nvb volumio[914]: /bin/chmod: cannot access '/etc/mpd.conf': Input/output error
Apr 03 07:48:01 nvb volumio[914]: error: MPD error: Error: connect ENOENT /run/mpd/socket
Apr 03 07:48:01 nvb volumio[914]: error: connect ENOENT /run/mpd/socket {"errno":-2,"code":"ENOENT","syscall":"connect","address":"/run/mpd/socket"}
Apr 03 07:48:01 nvb volumio[914]: error: MPD error: Error: connect ENOENT /run/mpd/socket
Apr 03 07:48:01 nvb volumio[914]: error: connect ENOENT /run/mpd/socket {"errno":-2,"code":"ENOENT","syscall":"connect","address":"/run/mpd/socket"}
Apr 03 07:48:01 nvb volumio[914]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 03 07:48:01 nvb volumio[914]: info: Could not write mpd.conf:Error: EIO: i/o error, open '/etc/mpd.conf'
Apr 03 07:48:01 nvb volumio[914]: info: Could not write mpd.conf:Error: EIO: i/o error, open '/etc/mpd.conf'
Apr 03 07:48:01 nvb volumio[914]: info: Starting Shairport Sync
Apr 03 07:48:01 nvb volumio[914]: info: Starting Shairport Sync
Apr 03 07:48:01 nvb sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 03 07:48:01 nvb sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:48:01 nvb volumio[914]: info: Starting Shairport Sync
Apr 03 07:48:01 nvb sudo[1302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 03 07:48:01 nvb sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:48:01 nvb systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 03 07:48:01 nvb systemd[1]: shairport-sync.service: Succeeded.
Apr 03 07:48:01 nvb systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 03 07:48:01 nvb sudo[1306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 03 07:48:01 nvb sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 03 07:48:01 nvb volumio[914]: info: Volumio called home
Apr 03 07:48:01 nvb volumio[914]: info: CoreCommandRouter::volumioGetState
Apr 03 07:48:01 nvb volumio[914]: info: CorePlayQueue::getTrack 0
Apr 03 07:48:01 nvb systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 03 07:48:01 nvb systemd[1]: Failed to canonicalize path '/etc/systemd/system/shairport-.service.d': Input/output error
Apr 03 07:48:01 nvb sudo[1300]: pam_unix(sudo:session): session closed for user root
Apr 03 07:48:01 nvb volumio[914]: info: Shairport-Sync Started
Apr 03 07:48:01 nvb volumio[914]: Error adding Membership: Error: addMembership EINVAL
Apr 03 07:48:01 nvb systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 03 07:48:01 nvb systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Apr 03 07:48:01 nvb systemd[1]: shairport-sync.service: Succeeded.
Apr 03 07:48:01 nvb systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 03 07:48:01 nvb systemd[1]: Failed to canonicalize path '/etc/systemd/system/shairport-.service.d': Input/output error
Apr 03 07:48:01 nvb systemd[1]: Failed to canonicalize path '/etc/systemd/system/shairport-.service.d': Input/output error
Apr 03 07:48:01 nvb systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 03 07:48:01 nvb sudo[1302]: pam_unix(sudo:session): session closed for user root
Apr 03 07:48:01 nvb sudo[1306]: pam_unix(sudo:session): session closed for user root
Apr 03 07:48:01 nvb volumio[914]: info: Shairport-Sync Started
Apr 03 07:48:01 nvb volumio[914]: info: Shairport-Sync Started
Apr 03 07:48:02 nvb volumio[914]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/plugins.json'
Apr 03 07:48:05 nvb kernel: mmc0: new high speed SDHC card at address e624
Apr 03 07:48:05 nvb kernel: mmcblk0: mmc0:e624 SU32G 29.7 GiB
Apr 03 07:48:05 nvb kernel: mmcblk0: p1 p2 p3
Apr 03 07:48:05 nvb kernel: mmcblk0: mmc0:e624 SU32G 29.7 GiB (quirks 0x00004000)
Apr 03 07:48:05 nvb volumio[914]: info: Ignoring mount for partition: volumio_data
Apr 03 07:48:05 nvb volumio[914]: info: Ignoring mount for partition: volumio
Apr 03 07:48:05 nvb volumio[914]: info: Ignoring mount for partition: boot
Apr 03 07:48:06 nvb volumio[914]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/F102-DE29 /dev/disk/by-path/platform-fe340000.mmc-part1 /dev/disk/by-partuuid/8ca0658c-01 /dev/disk/by-id/mmc-SU32G_0x186a3b0e-part1 /dev/disk/by-label/boot","DEVNAME":"/dev/mmcblk0p1","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p1","DEVTYPE":"partition","DISKSEQ":"32","ID_FS_LABEL":"boot","ID_FS_LABEL_ENC":"boot","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"F102-DE29","ID_FS_UUID_ENC":"F102-DE29","ID_FS_VERSION":"FAT16","ID_NAME":"SU32G","ID_PART_ENTRY_DISK":"179:32","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"1","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"187500","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"8ca0658c-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x186a3b0e","MAJOR":"179","MINOR":"33","PARTN":"1","SEQNUM":"1866","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"85906453"}
Apr 03 07:48:06 nvb volumio[914]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p2","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-fe340000.mmc-part2 /dev/disk/by-uuid/db7775c5-9234-4b9a-955e-7341a245d498 /dev/disk/by-id/mmc-SU32G_0x186a3b0e-part2 /dev/disk/by-partuuid/8ca0658c-02 /dev/disk/by-label/volumio","DEVNAME":"/dev/mmcblk0p2","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p2","DEVTYPE":"partition","DISKSEQ":"32","ID_FS_LABEL":"volumio","ID_FS_LABEL_ENC":"volumio","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"db7775c5-9234-4b9a-955e-7341a245d498","ID_FS_UUID_ENC":"db7775c5-9234-4b9a-955e-7341a245d498","ID_FS_VERSION":"1.0","ID_NAME":"SU32G","ID_PART_ENTRY_DISK":"179:32","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"188416","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"5279744","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"8ca0658c-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x186a3b0e","MAJOR":"179","MINOR":"34","PARTN":"2","SEQNUM":"1867","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"85893564"}
Apr 03 07:48:06 nvb kernel: mmc0: card e624 removed
Apr 03 07:48:06 nvb kernel: EXT4-fs error: 27 callbacks suppressed
Apr 03 07:48:06 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653577: comm node: reading directory lblock 0
Apr 03 07:48:06 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653577: comm node: reading directory lblock 0
Apr 03 07:48:06 nvb volumio[914]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p3","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/8ca0658c-03 /dev/disk/by-uuid/4112086d-38d3-4206-a7af-ef93bf4e4008 /dev/disk/by-id/mmc-SU32G_0x186a3b0e-part3 /dev/disk/by-label/volumio_data /dev/disk/by-path/platform-fe340000.mmc-part3","DEVNAME":"/dev/mmcblk0p3","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:e624/block/mmcblk0/mmcblk0p3","DEVTYPE":"partition","DISKSEQ":"32","ID_FS_LABEL":"volumio_data","ID_FS_LABEL_ENC":"volumio_data","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"4112086d-38d3-4206-a7af-ef93bf4e4008","ID_FS_UUID_ENC":"4112086d-38d3-4206-a7af-ef93bf4e4008","ID_FS_VERSION":"1.0","ID_NAME":"SU32G","ID_PART_ENTRY_DISK":"179:32","ID_PART_ENTRY_NUMBER":"3","ID_PART_ENTRY_OFFSET":"5468160","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"56865792","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"8ca0658c-03","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x186a3b0e","MAJOR":"179","MINOR":"35","PARTN":"3","SEQNUM":"1868","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"85893532"}
Apr 03 07:48:06 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653577: comm node: reading directory lblock 0
Apr 03 07:48:06 nvb systemd[1]: Unmounting /boot...
Apr 03 07:48:06 nvb systemd[1317]: boot.mount: Failed to execute command: Input/output error
Apr 03 07:48:06 nvb systemd[1317]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Apr 03 07:48:06 nvb systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Apr 03 07:48:06 nvb systemd[1]: Failed unmounting /boot.
Apr 03 07:48:06 nvb systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device, but not stopping since we tried this too often recently.
Apr 03 07:48:06 nvb kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #4653354: comm (umount): reading directory lblock 0
Apr 03 07:48:06 nvb kernel: sdhci-iproc fe340000.mmc: card claims to support voltages below defined range
Apr 03 07:48:06 nvb kernel: sdhci-iproc fe340000.mmc: no support for card's volts
Apr 03 07:48:06 nvb kernel: mmc0: error -22 whilst initialising SDIO card
Apr 03 07:48:10 nvb ntpd[713]: Soliciting pool server 194.36.144.87
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Apr 03 07:48:10 nvb volumio[914]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Apr 03 07:48:10 nvb volumio[914]: info: Adding plugin bluetooth to MyMusic Plugins
Apr 03 07:48:10 nvb volumio[914]: info: Adding plugin multiroom to MyMusic Plugins
Apr 03 07:48:10 nvb volumio[914]: info: Adding plugin metavolumio to MyMusic Plugins
Apr 03 07:48:10 nvb volumio[914]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/cd_controller/package.json: EIO: i/o error, read
Apr 03 07:48:10 nvb kernel: I/O error, dev loop0, sector 301802 op 0x0:(READ) flags 0x800 phys_seg 19 prio class 2
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Failed to read block 0x935d635: -5
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [935d635]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [935d635]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read page, block 935d635, size 12ad7
Apr 03 07:48:10 nvb kernel: I/O error, dev loop0, sector 302148 op 0x0:(READ) flags 0x800 phys_seg 23 prio class 2
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Failed to read block 0x9388b20: -5
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [9388b20]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [9388b20]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read page, block 9388b20, size 155c5
Apr 03 07:48:10 nvb volumio[914]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/hi_res_audio/package.json: EIO: i/o error, read
Apr 03 07:48:10 nvb volumio[914]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/qobuz/package.json: EIO: i/o error, read
Apr 03 07:48:10 nvb volumio[914]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/smart_inputs/package.json: EIO: i/o error, read
Apr 03 07:48:10 nvb volumio[914]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services/package.json: EIO: i/o error, read
Apr 03 07:48:10 nvb volumio[914]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/tidal/package.json: EIO: i/o error, read
Apr 03 07:48:10 nvb volumio[914]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/tidalconnect/package.json: EIO: i/o error, read
Apr 03 07:48:10 nvb volumio[914]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/system_controller/my_volumio/package.json: EIO: i/o error, read
Apr 03 07:48:10 nvb volumio[914]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/system_controller/my_volumio/package.json: EIO: i/o error, read
Apr 03 07:48:10 nvb volumio[914]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 03 07:48:10 nvb kernel: I/O error, dev loop0, sector 333426 op 0x0:(READ) flags 0x800 phys_seg 21 prio class 2
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Failed to read block 0xa2ce554: -5
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [a2ce554]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [a2ce554]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read page, block a2ce554, size 16546
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [a2ce554]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [a2ce554]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read page, block a2ce554, size 16546
Apr 03 07:48:10 nvb kernel: I/O error, dev loop0, sector 334556 op 0x0:(READ) flags 0x800 phys_seg 14 prio class 2
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Failed to read block 0xa35bb4a: -5
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [a35bb4a]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [a35bb4a]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read page, block a35bb4a, size c6bb
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [a35bb4a]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [a35bb4a]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read page, block a35bb4a, size c6bb
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [a35bb4a]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [a35bb4a]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read page, block a35bb4a, size c6bb
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [a35bb4a]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [a35bb4a]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read page, block a35bb4a, size c6bb
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read fragment cache entry [a35bb4a]
Apr 03 07:48:10 nvb kernel: SQUASHFS error: Unable to read page, block a35bb4a, size c6bb
Apr 03 07:48:10 nvb volumio[914]: TypeError: Cannot read property 'volumio_info' of undefined
Apr 03 07:48:10 nvb volumio[914]: at MyVolumioPluginManager.loadMyVolumioPlugin (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:12309)
Apr 03 07:48:10 nvb volumio[914]: at MyVolumioPluginManager.loadMyVolumio (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:6489)
Apr 03 07:48:10 nvb volumio[914]: at MyVolumioPluginManager.initMyVolumio (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:1533)
Apr 03 07:48:10 nvb volumio[914]: at /myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:3480
Apr 03 07:48:10 nvb volumio[914]: at Request.handleRequestResponse [as _callback] (/volumio/node_modules/unirest/index.js:552:70)
Apr 03 07:48:10 nvb volumio[914]: at Request.self.callback (/volumio/node_modules/request/request.js:185:22)
Apr 03 07:48:10 nvb volumio[914]: at Request.emit (events.js:315:20)
Apr 03 07:48:10 nvb volumio[914]: at Request. (/volumio/node_modules/request/request.js:1154:10)
Apr 03 07:48:10 nvb volumio[914]: at Request.emit (events.js:315:20)
Apr 03 07:48:10 nvb volumio[914]: at IncomingMessage. (/volumio/node_modules/request/request.js:1076:12)
Apr 03 07:48:10 nvb volumio[914]: at Object.onceWrapper (events.js:421:28)
Apr 03 07:48:10 nvb volumio[914]: at IncomingMessage.emit (events.js:327:22)
Apr 03 07:48:10 nvb volumio[914]: at endReadableNT (internal/streams/readable.js:1327:12)
Apr 03 07:48:10 nvb volumio[914]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Apr 03 07:48:10 nvb volumio[914]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 03 07:48:10 nvb sudo[1327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-03 07:47
Apr 03 07:48:10 nvb sudo[1327]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET"
VOLUMIO_VERSION="3.631"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"