-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2025-06-27 12:21:12 CEST. --
Jun 27 12:20:02 volumio volumio[706]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done'
Jun 27 12:20:02 volumio volumio[706]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-ymp48ypn/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9
Jun 27 12:20:02 volumio volumio[706]: info: Successfully built camilladsp-plot
Jun 27 12:20:03 volumio volumio[706]: info: copying hw detection script
Jun 27 12:20:03 volumio volumio[706]: info: Detected cpu architecture as armv7l
Jun 27 12:20:04 volumio volumio[706]: info: CoreCommandRouter::volumioGetState
Jun 27 12:20:05 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 27 12:20:05 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 27 12:20:05 volumio volumio[706]: info: Discovery: Getting this device information
Jun 27 12:20:05 volumio volumio[706]: info: CoreCommandRouter::volumioGetState
Jun 27 12:20:05 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 27 12:20:05 volumio sudo[28407]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params
Jun 27 12:20:05 volumio sudo[28407]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:20:06 volumio sudo[28407]: pam_unix(sudo:session): session closed for user root
Jun 27 12:20:06 volumio sudo[28409]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params
Jun 27 12:20:06 volumio sudo[28409]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:20:06 volumio sudo[28409]: pam_unix(sudo:session): session closed for user root
Jun 27 12:20:06 volumio sudo[28413]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc
Jun 27 12:20:06 volumio sudo[28413]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:20:06 volumio volumio[706]: info: Reading package lists...
Jun 27 12:20:07 volumio volumio[706]: info: Building dependency tree...
Jun 27 12:20:07 volumio volumio[706]: info: Reading state information...
Jun 27 12:20:09 volumio volumio[706]: info: drc is already the newest version (3.2.2~dfsg0-2).
Jun 27 12:20:09 volumio sudo[28413]: pam_unix(sudo:session): session closed for user root
Jun 27 12:20:09 volumio sudo[27823]: pam_unix(sudo:session): session closed for user root
Jun 27 12:20:09 volumio volumio[706]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded.
Jun 27 12:20:09 volumio volumio[706]: info: Install script completed
Jun 27 12:20:09 volumio volumio[706]: info: Done installing plugin.
Jun 27 12:20:09 volumio volumio[706]: info: Enabling plugin fusiondsp
Jun 27 12:20:09 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 27 12:20:09 volumio volumio[706]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.61","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":true,"enabled":true,"active":false},{"prettyName":"Calm Radio","name":"calmradio","category":"music_service","version":"1.2.4","icon":"fa-heartbeat","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.1.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.1","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":true}]
Jun 27 12:20:09 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jun 27 12:20:09 volumio volumio[706]: info: Folder /tmp/plugins removed
Jun 27 12:20:09 volumio volumio[706]: info: Folder /tmp/downloaded_plugin.zip removed
Jun 27 12:20:09 volumio volumio[706]: Plugin install end detected on script
Jun 27 12:20:09 volumio volumio[706]: info: Folder /data/temp removed
Jun 27 12:20:09 volumio volumio[706]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 27 12:20:09 volumio volumio[706]: info: FusionDsp -
Jun 27 12:20:10 volumio volumio[706]: info: FusionDsp - undefined
Jun 27 12:20:14 volumio volumio[706]: info: CoreCommandRouter::volumioGetState
Jun 27 12:20:14 volumio volumio[706]: info: Listing playlists
Jun 27 12:20:14 volumio volumio[706]: info: Listing playlists
Jun 27 12:20:22 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 27 12:20:22 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jun 27 12:20:22 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 27 12:20:22 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 27 12:20:22 volumio volumio[706]: info: Discovery: Getting this device information
Jun 27 12:20:22 volumio volumio[706]: info: CoreCommandRouter::volumioGetState
Jun 27 12:20:22 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 27 12:20:22 volumio go-librespot[979]: time="2025-06-27T12:20:22+02:00" level=trace msg="received accesspoint ping"
Jun 27 12:20:22 volumio go-librespot[979]: time="2025-06-27T12:20:22+02:00" level=trace msg="received accesspoint pong ack"
Jun 27 12:20:22 volumio go-librespot[979]: time="2025-06-27T12:20:22+02:00" level=trace msg="sent dealer ping"
Jun 27 12:20:22 volumio go-librespot[979]: time="2025-06-27T12:20:22+02:00" level=trace msg="received dealer pong"
Jun 27 12:20:24 volumio volumio[706]: info: CoreCommandRouter::volumioGetState
Jun 27 12:20:24 volumio volumio[706]: verbose: New Socket.io Connection to 192.168.1.33:3000 from 192.168.1.10 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11
Jun 27 12:20:25 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 27 12:20:25 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 27 12:20:25 volumio volumio[706]: info: Discovery: Getting this device information
Jun 27 12:20:25 volumio volumio[706]: info: CoreCommandRouter::volumioGetState
Jun 27 12:20:25 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 27 12:20:26 volumio volumio[706]: verbose: New Socket.io Connection to 192.168.1.33:3000 from 192.168.1.10 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11
Jun 27 12:20:31 volumio volumio[706]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/calmradio/volumio/buster/armhf
Jun 27 12:20:33 volumio volumio[706]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/calmradio/volumio/buster/armhf
Jun 27 12:20:33 volumio volumio[706]: info: CoreCommandRouter::volumioRemoveToBrowseSourcescalmradio
Jun 27 12:20:33 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 12:20:33 volumio volumio[706]: Cannot find translation for source Calm Radio
Jun 27 12:20:34 volumio volumio[706]: info: CoreCommandRouter::volumioGetState
Jun 27 12:20:34 volumio volumio[706]: info: Listing playlists
Jun 27 12:20:34 volumio volumio[706]: info: Listing playlists
Jun 27 12:20:34 volumio volumio[706]: info: Check plugin dependencies
Jun 27 12:20:34 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 27 12:20:34 volumio volumio[706]: info: Rename folder
Jun 27 12:20:34 volumio volumio[706]: info: Folder /tmp/downloaded_plugin.zip removed
Jun 27 12:20:34 volumio volumio[706]: info: Move to category
Jun 27 12:20:35 volumio volumio[706]: info: Checking if install.sh is present
Jun 27 12:20:35 volumio volumio[706]: info: Executing install.sh
Jun 27 12:20:35 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 27 12:20:35 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 27 12:20:35 volumio volumio[706]: info: Discovery: Getting this device information
Jun 27 12:20:35 volumio volumio[706]: info: CoreCommandRouter::volumioGetState
Jun 27 12:20:35 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 27 12:20:36 volumio sudo[28558]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/calmradio/install.sh
Jun 27 12:20:36 volumio sudo[28558]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:20:36 volumio sudo[28558]: pam_unix(sudo:session): session closed for user root
Jun 27 12:20:36 volumio volumio[706]: Plugin install end detected on script
Jun 27 12:20:36 volumio volumio[706]: info: Install script completed
Jun 27 12:20:36 volumio volumio[706]: info: Done installing plugin.
Jun 27 12:20:36 volumio volumio[706]: info: Enabling plugin calmradio
Jun 27 12:20:36 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 27 12:20:36 volumio volumio[706]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.61","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":true,"enabled":true,"active":false},{"prettyName":"Calm Radio","name":"calmradio","category":"music_service","version":"1.2.4","icon":"fa-heartbeat","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.1.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.1","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":true}]
Jun 27 12:20:36 volumio volumio[706]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jun 27 12:20:36 volumio volumio[706]: info: Folder /tmp/plugins removed
Jun 27 12:20:36 volumio volumio[706]: info: Folder /tmp/downloaded_plugin.zip removed
Jun 27 12:20:36 volumio volumio[706]: info: Folder /data/temp removed
Jun 27 12:20:41 volumio volumio[706]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Jun 27 12:20:43 volumio volumio[706]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Jun 27 12:20:43 volumio volumio[706]: info: FusionDsp - Stopping FusionDsp service
Jun 27 12:20:44 volumio volumio[706]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 27 12:20:44 volumio volumio[706]: TypeError: Cannot read property 'stop' of null
Jun 27 12:20:44 volumio volumio[706]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23)
Jun 27 12:20:44 volumio volumio[706]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Jun 27 12:20:44 volumio volumio[706]: at /volumio/app/pluginmanager.js:956:12
Jun 27 12:20:44 volumio volumio[706]: at ChildProcess.exithandler (child_process.js:299:7)
Jun 27 12:20:44 volumio volumio[706]: at ChildProcess.emit (events.js:315:20)
Jun 27 12:20:44 volumio volumio[706]: at maybeClose (internal/child_process.js:1048:16)
Jun 27 12:20:44 volumio volumio[706]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5)
Jun 27 12:20:44 volumio volumio[706]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 27 12:20:45 volumio sudo[28590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-27 12:19
Jun 27 12:20:45 volumio sudo[28590]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:20:45 volumio sudo[28590]: pam_unix(sudo:session): session closed for user root
Jun 27 12:20:45 volumio volumio-remote-updater[465]: [2025-06-27 12:20:45] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jun 27 12:20:45 volumio volumio-remote-updater[465]: [2025-06-27 12:20:45] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jun 27 12:20:45 volumio go-librespot[979]: time="2025-06-27T12:20:45+02:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF"
Jun 27 12:20:45 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Jun 27 12:20:45 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Jun 27 12:20:45 volumio systemd[1]: Started dynamicswap service.
Jun 27 12:20:45 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Jun 27 12:20:45 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1.
Jun 27 12:20:45 volumio systemd[1]: Stopped Volumio Backend Module.
Jun 27 12:20:45 volumio systemd[1]: Started Volumio Backend Module.
Jun 27 12:20:45 volumio systemd[1]: dynamicswap.service: Succeeded.
Jun 27 12:20:49 volumio volumio[28612]: info: -------------------------------------------
Jun 27 12:20:49 volumio volumio[28612]: info: ----- Volumio3 ----
Jun 27 12:20:49 volumio volumio[28612]: info: -------------------------------------------
Jun 27 12:20:49 volumio volumio[28612]: info: ----- System startup ----
Jun 27 12:20:49 volumio volumio[28612]: info: -------------------------------------------
Jun 27 12:20:50 volumio volumio[28612]: info: MYVOLUMIO Environment detected
Jun 27 12:20:50 volumio volumio-remote-updater[465]: [2025-06-27 12:20:50] [connect] Successful connection
Jun 27 12:20:50 volumio volumio[28612]: info: Plugin folders cleanup
Jun 27 12:20:50 volumio volumio[28612]: info: Scanning into folder /volumio/app/plugins/
Jun 27 12:20:50 volumio volumio[28612]: info: Scanning category audio_interface
Jun 27 12:20:50 volumio volumio[28612]: info: Scanning category miscellanea
Jun 27 12:20:50 volumio volumio[28612]: info: Scanning category music_service
Jun 27 12:20:50 volumio volumio[28612]: info: Scanning category plugins.json
Jun 27 12:20:50 volumio volumio[28612]: info: Scanning category system_controller
Jun 27 12:20:50 volumio volumio[28612]: info: Scanning category user_interface
Jun 27 12:20:50 volumio volumio[28612]: info: Scanning into folder /data/plugins/
Jun 27 12:20:50 volumio volumio[28612]: info: Scanning category audio_interface
Jun 27 12:20:50 volumio volumio[28612]: info: Scanning category music_service
Jun 27 12:20:50 volumio volumio[28612]: info: Scanning category system_controller
Jun 27 12:20:50 volumio volumio[28612]: info: Plugin folders cleanup completed
Jun 27 12:20:50 volumio volumio[28612]: info: -------------------------------------------
Jun 27 12:20:50 volumio volumio[28612]: info: ----- Core plugins startup ----
Jun 27 12:20:50 volumio volumio[28612]: info: -------------------------------------------
Jun 27 12:20:50 volumio volumio[28612]: info: Loading plugins from folder /volumio/app/plugins/
Jun 27 12:20:50 volumio volumio[28612]: info: Adding plugin upnp to MyMusic Plugins
Jun 27 12:20:50 volumio volumio[28612]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 27 12:20:50 volumio volumio[28612]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 27 12:20:50 volumio volumio[28612]: info: Loading plugins from folder /data/plugins/
Jun 27 12:20:50 volumio volumio[28612]: info: Loading plugin "system"...
Jun 27 12:20:50 volumio volumio[28612]: info: Loading plugin "ampswitch"...
Jun 27 12:20:51 volumio volumio[28612]: info: Applying required configuration parameters for plugin ampswitch
Jun 27 12:20:51 volumio volumio[28612]: info: Loading plugin "appearance"...
Jun 27 12:20:52 volumio go-librespot[979]: time="2025-06-27T12:20:52+02:00" level=trace msg="sent dealer ping"
Jun 27 12:20:52 volumio go-librespot[979]: time="2025-06-27T12:20:52+02:00" level=trace msg="received dealer pong"
Jun 27 12:20:53 volumio volumio[28612]: info: Loading plugin "network"...
Jun 27 12:20:53 volumio volumio[28612]: info: Refreshing Cached IP Addresses
Jun 27 12:20:53 volumio sudo[28639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 27 12:20:53 volumio sudo[28639]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:20:53 volumio sudo[28639]: pam_unix(sudo:session): session closed for user root
Jun 27 12:20:53 volumio volumio[28612]: info: Loading plugin "services"...
Jun 27 12:20:53 volumio sudo[28641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 27 12:20:53 volumio sudo[28641]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:20:53 volumio volumio[28612]: info: Loading plugin "alsa_controller"...
Jun 27 12:20:53 volumio sudo[28644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 27 12:20:53 volumio sudo[28644]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:20:53 volumio sudo[28641]: pam_unix(sudo:session): session closed for user root
Jun 27 12:20:53 volumio sudo[28644]: pam_unix(sudo:session): session closed for user root
Jun 27 12:20:53 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 27 12:20:53 volumio volumio[28612]: info: Loading plugin "wizard"...
Jun 27 12:20:53 volumio volumio[28612]: info: Loading plugin "networkfs"...
Jun 27 12:20:53 volumio volumio[28612]: info: Starting Udev Watcher for removable devices
Jun 27 12:20:53 volumio volumio[28612]: info: Ignoring mount for partition: boot
Jun 27 12:20:53 volumio volumio[28612]: info: Ignoring mount for partition: volumio
Jun 27 12:20:53 volumio volumio[28612]: info: Ignoring mount for partition: volumio_data
Jun 27 12:20:53 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 27 12:20:53 volumio volumio[28612]: info: Loading plugin "volumio_command_line_client"...
Jun 27 12:20:53 volumio volumio[28612]: info: Loading plugin "upnp"...
Jun 27 12:20:54 volumio volumio[28612]: info: [1751019654007] Starting Upmpd Daemon
Jun 27 12:20:54 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 27 12:20:54 volumio volumio[28612]: info: Loading plugin "my_music"...
Jun 27 12:20:54 volumio volumio[28612]: info: Loading plugin "mpd"...
Jun 27 12:20:54 volumio volumio[28612]: info: Loading plugin "upnp_browser"...
Jun 27 12:20:55 volumio volumio[28612]: info: Loading plugin "alarm-clock"...
Jun 27 12:20:55 volumio volumio[28612]: info: Loading plugin "airplay_emulation"...
Jun 27 12:20:55 volumio volumio[28612]: info: Starting Shairport Sync
Jun 27 12:20:55 volumio volumio[28612]: info: Loading plugin "last_100"...
Jun 27 12:20:55 volumio volumio[28612]: info: Loading plugin "webradio"...
Jun 27 12:20:55 volumio volumio[28612]: info: Loading plugin "i2s_dacs"...
Jun 27 12:20:55 volumio volumio[28612]: info: I2S DAC not set, start Auto-detection
Jun 27 12:20:55 volumio volumio[28612]: info: Loading plugin "volumiodiscovery"...
Jun 27 12:20:56 volumio volumio[28612]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 27 12:20:56 volumio volumio[28612]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 27 12:20:56 volumio volumio[28612]: *** WARNING *** For more information see
Jun 27 12:20:56 volumio node[28612]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 27 12:20:56 volumio volumio[28612]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 27 12:20:56 volumio volumio[28612]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 27 12:20:56 volumio volumio[28612]: *** WARNING *** For more information see
Jun 27 12:20:56 volumio node[28612]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 27 12:20:56 volumio node[28612]: *** WARNING *** For more information see
Jun 27 12:20:56 volumio node[28612]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 27 12:20:56 volumio node[28612]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 27 12:20:56 volumio node[28612]: *** WARNING *** For more information see
Jun 27 12:20:56 volumio volumio[28612]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 27 12:20:56 volumio volumio[28612]: info: Discovery: Started advertising with name: Volumio
Jun 27 12:20:56 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 27 12:20:56 volumio volumio[28612]: info: Loading plugin "calmradio"...
Jun 27 12:20:57 volumio volumio[28612]: info: Loading plugin "spop"...
Jun 27 12:20:59 volumio volumio[28612]: info: Loading plugin "outputs"...
Jun 27 12:20:59 volumio volumio[28612]: info: Loading plugin "albumart"...
Jun 27 12:20:59 volumio volumio[28612]: info: Plugin example_plugin is not enabled
Jun 27 12:20:59 volumio volumio[28612]: info: Loading plugin "inputs"...
Jun 27 12:20:59 volumio volumio[28612]: info: Loading plugin "updater_comm"...
Jun 27 12:21:00 volumio volumio[28612]: info: Plugin mpdemulation is not enabled
Jun 27 12:21:00 volumio volumio[28612]: info: Loading plugin "rest_api"...
Jun 27 12:21:00 volumio volumio[28612]: info: Loading plugin "websocket"...
Jun 27 12:21:00 volumio volumio[28612]: info: Starting Socket.io Server version 2.3.0
Jun 27 12:21:00 volumio volumio[28612]: info: Loading plugin "fusiondsp"...
Jun 27 12:21:00 volumio volumio[28612]: Forking 3 albumart workers
Jun 27 12:21:00 volumio volumio[28612]: info: Applying required configuration parameters for plugin fusiondsp
Jun 27 12:21:01 volumio volumio[28612]: info: Loading i18n strings for locale fr
Jun 27 12:21:01 volumio volumio[28612]: Updating browse sources language
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::initPlayerControls
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 27 12:21:01 volumio volumio[28612]: Express server listening on port 3000
Jun 27 12:21:01 volumio volumio[28612]: [Metrics] WebUI: 13s 531.72ms
Jun 27 12:21:01 volumio volumio[28612]: info: CoreStateMachine::resetVolumioState
Jun 27 12:21:01 volumio volumio[28612]: info: CoreStateMachine::getcurrentVolume
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::volumioRetrievevolume
Jun 27 12:21:01 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 12:21:02 volumio volumio[28612]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Jun 27 12:21:02 volumio volumio[28612]: wlan0 Interface doesn't support scanning.
Jun 27 12:21:02 volumio volumio[28612]: info: Cannot use regular scanning, forcing with ap-force
Jun 27 12:21:02 volumio sudo[28701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Jun 27 12:21:02 volumio sudo[28701]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:21:02 volumio sudo[28701]: pam_unix(sudo:session): session closed for user root
Jun 27 12:21:02 volumio volumio[28612]: command failed: No such device (-19)
Jun 27 12:21:02 volumio volumio[28612]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Jun 27 12:21:02 volumio volumio[28612]: command failed: No such device (-19)
Jun 27 12:21:02 volumio volumio[28612]: verbose: New Socket.io Connection to 192.168.1.33:3000 from 192.168.1.30 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1
Jun 27 12:21:02 volumio volumio[28612]: verbose: New Socket.io Connection to 192.168.1.33 from 192.168.1.30 UA: Mozilla/5.0 (Linux; Android 16; Pixel 8 Build/BP2A.250605.031.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Jun 27 12:21:02 volumio volumio[28612]: verbose: New Socket.io Connection to 192.168.1.33:3000 from 192.168.1.10 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3
Jun 27 12:21:02 volumio volumio[28612]: verbose: New Socket.io Connection to 192.168.1.33 from 192.168.1.30 UA: Mozilla/5.0 (Linux; Android 16; Pixel 8 Build/BP2A.250605.031.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Jun 27 12:21:02 volumio volumio[28612]: verbose: New Socket.io Connection to 192.168.1.33 from 192.168.1.30 UA: Mozilla/5.0 (Linux; Android 16; Pixel 8 Build/BP2A.250605.031.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Jun 27 12:21:02 volumio volumio[28612]: info: CoreCommandRouter::volumioGetState
Jun 27 12:21:02 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:02 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 27 12:21:02 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 27 12:21:02 volumio volumio[28612]: info: Discovery: Getting this device information
Jun 27 12:21:02 volumio volumio[28612]: info: CoreCommandRouter::volumioGetState
Jun 27 12:21:02 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:02 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 27 12:21:02 volumio volumio[28612]: Starting albumart workers
Jun 27 12:21:02 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 27 12:21:02 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 27 12:21:02 volumio volumio[28612]: info: Discovery: Getting this device information
Jun 27 12:21:02 volumio volumio[28612]: Starting albumart workers
Jun 27 12:21:02 volumio volumio[28612]: info: CoreCommandRouter::volumioGetState
Jun 27 12:21:02 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:02 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 27 12:21:03 volumio volumio[28612]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Jun 27 12:21:03 volumio volumio[28612]: Starting albumart workers
Jun 27 12:21:03 volumio volumio[28612]: info: Reloading queue from file
Jun 27 12:21:03 volumio volumio-remote-updater[465]: [2025-06-27 12:21:03] [connect] Successful connection
Jun 27 12:21:03 volumio volumio[28612]: info: VolumeController:: Volume=52 Mute =false
Jun 27 12:21:03 volumio volumio[28612]: info: CoreStateMachine::pushState
Jun 27 12:21:03 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:03 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 27 12:21:03 volumio volumio[28612]: info: CoreCommandRouter::volumioPushState
Jun 27 12:21:03 volumio volumio[28612]: info: CoreStateMachine::updateTrackBlock
Jun 27 12:21:03 volumio volumio[28612]: info: CorePlayQueue::getTrackBlock
Jun 27 12:21:03 volumio volumio[28612]: info: CoreCommandRouter::volumioRetrievevolume
Jun 27 12:21:03 volumio volumio[28612]: info: CoreStateMachine::setRepeat null single undefined
Jun 27 12:21:03 volumio volumio[28612]: info: CoreStateMachine::pushState
Jun 27 12:21:03 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:03 volumio volumio[28612]: info: CoreCommandRouter::volumioPushState
Jun 27 12:21:03 volumio volumio[28612]: info: CoreStateMachine::setRandom null
Jun 27 12:21:03 volumio volumio[28612]: info: CoreStateMachine::pushState
Jun 27 12:21:03 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:03 volumio volumio[28612]: info: CoreCommandRouter::volumioPushState
Jun 27 12:21:03 volumio volumio[28612]: info: Setting Device type: Raspberry PI
Jun 27 12:21:03 volumio volumio[28612]: info: Listing playlists
Jun 27 12:21:03 volumio volumio[28612]: info: Listing playlists
Jun 27 12:21:03 volumio volumio-remote-updater[465]: [2025-06-27 12:21:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751019663 101
Jun 27 12:21:03 volumio volumio[28612]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 7
Jun 27 12:21:03 volumio volumio[28612]: info: Discovery: adding 85e78cfb-0965-40f3-97aa-13783422a7ff
Jun 27 12:21:03 volumio volumio[28612]: info: Discovery: Found device Volumio
Jun 27 12:21:03 volumio volumio[28612]: info: CoreCommandRouter::volumioGetState
Jun 27 12:21:03 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:04 volumio volumio[28612]: info: VolumeController:: Volume=52 Mute =false
Jun 27 12:21:04 volumio volumio[28612]: info: CoreStateMachine::pushState
Jun 27 12:21:04 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:04 volumio volumio[28612]: info: CoreCommandRouter::volumioPushState
Jun 27 12:21:04 volumio volumio[28612]: info: Completed loading Core Plugins
Jun 27 12:21:04 volumio volumio[28612]: info: Preparing to generate the ALSA configuration file
Jun 27 12:21:04 volumio sudo[28714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 27 12:21:04 volumio sudo[28714]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:21:04 volumio volumio[28612]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jun 27 12:21:04 volumio sudo[28716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 27 12:21:04 volumio volumio[28612]: info: Reading ALSA contributions from plugins.
Jun 27 12:21:04 volumio sudo[28714]: pam_unix(sudo:session): session closed for user root
Jun 27 12:21:04 volumio sudo[28716]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:21:04 volumio volumio[28612]: info: CoreCommandRouter::volumioGetState
Jun 27 12:21:04 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:04 volumio sudo[28716]: pam_unix(sudo:session): session closed for user root
Jun 27 12:21:04 volumio volumio[28612]: info: Asound.conf file unchanged, so no further update is needed
Jun 27 12:21:04 volumio volumio[28612]: info: Output device has changed, restarting MPD
Jun 27 12:21:04 volumio sudo[28730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jun 27 12:21:04 volumio sudo[28730]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:21:04 volumio volumio[28612]: info: Output device has changed, restarting Shairport Sync
Jun 27 12:21:04 volumio sudo[28736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 27 12:21:04 volumio sudo[28736]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:21:04 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:04 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 12:21:04 volumio sudo[28736]: pam_unix(sudo:session): session closed for user root
Jun 27 12:21:04 volumio sudo[28730]: pam_unix(sudo:session): session closed for user root
Jun 27 12:21:04 volumio sudo[28745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 27 12:21:04 volumio sudo[28745]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:21:04 volumio systemd[1]: Stopping Music Player Daemon...
Jun 27 12:21:04 volumio volumio[28612]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 27 12:21:04 volumio volumio[28612]: info: ___________ START PLUGINS ___________
Jun 27 12:21:04 volumio volumio[28612]: info: ControllerMpd::onStart: Initializing MPD
Jun 27 12:21:04 volumio volumio[28612]: info: Creating MPD Configuration file
Jun 27 12:21:04 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 27 12:21:04 volumio volumio[28612]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 27 12:21:04 volumio sudo[28781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 27 12:21:04 volumio volumio[28612]: info: [1751019664971] CoreMusicLibrary::Adding element Serveurs Média
Jun 27 12:21:04 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 12:21:04 volumio sudo[28781]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:21:04 volumio sudo[28781]: pam_unix(sudo:session): session closed for user root
Jun 27 12:21:05 volumio sudo[28783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 27 12:21:05 volumio sudo[28783]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 12:21:05 volumio kernel: mmc0: card aaaa removed
Jun 27 12:21:05 volumio kernel: I/O error, dev loop0, sector 725614 op 0x0:(READ) flags 0x800 phys_seg 18 prio class 2
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Failed to read block 0x1624dc76: -5
Jun 27 12:21:05 volumio kernel: I/O error, dev loop0, sector 725746 op 0x0:(READ) flags 0x800 phys_seg 17 prio class 2
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Failed to read block 0x1625e5fa: -5
Jun 27 12:21:05 volumio kernel: I/O error, dev loop0, sector 725614 op 0x0:(READ) flags 0x800 phys_seg 18 prio class 2
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Failed to read block 0x1624dc76: -5
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Unable to read data cache entry [1624dc76]
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Unable to read page, block 1624dc76, size 10984
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Unable to read data cache entry [1624dc76]
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Unable to read page, block 1624dc76, size 10984
Jun 27 12:21:05 volumio kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 393581 starting block 2727171)
Jun 27 12:21:05 volumio kernel: Buffer I/O error on device mmcblk0p3, logical block 2043651
Jun 27 12:21:05 volumio kernel: Aborting journal on device mmcblk0p3-8.
Jun 27 12:21:05 volumio kernel: JBD2: I/O error when updating journal superblock for mmcblk0p3-8.
Jun 27 12:21:05 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=7/BUS
Jun 27 12:21:05 volumio systemd[1]: mpd.service: Failed with result 'signal'.
Jun 27 12:21:05 volumio systemd[1]: Stopped Music Player Daemon.
Jun 27 12:21:05 volumio volumio[28612]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 12:21:05 volumio systemd[1]: Starting Music Player Daemon...
Jun 27 12:21:05 volumio systemd[1]: Stopped target Local File Systems.
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio systemd[28795]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio systemd[28795]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #394163: comm (umount): reading directory lblock 0
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio systemd[28796]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio systemd[28796]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio volumio[28612]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 27 12:21:05 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #394163: comm (umount): reading directory lblock 0
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 27 12:21:05 volumio volumio[28612]: info: [1751019665346] CoreMusicLibrary::Adding element Last_100
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio volumio[28612]: info: [1751019665366] CoreMusicLibrary::Adding element Webradio
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 12:21:05 volumio systemd[28797]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #394163: comm (umount): reading directory lblock 0
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 27 12:21:05 volumio systemd[28797]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio volumio[28612]: info: Initializing BBC Radios
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio systemd[28798]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio systemd[28798]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #394163: comm (umount): reading directory lblock 0
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #394163: comm (umount): reading directory lblock 0
Jun 27 12:21:05 volumio systemd[28801]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio systemd[28801]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio systemd[28803]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #394163: comm (umount): reading directory lblock 0
Jun 27 12:21:05 volumio systemd[28803]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio sudo[28791]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 27 12:21:05 volumio sudo[28791]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio sudo[28791]: pam_unix(sudo:session): session closed for user root
Jun 27 12:21:05 volumio systemd[28808]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio systemd[28808]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #394163: comm (umount): reading directory lblock 0
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio systemd[28811]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio systemd[28811]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #394163: comm (umount): reading directory lblock 0
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio systemd[28815]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 27 12:21:05 volumio systemd[28815]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 12:21:05 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #394163: comm (umount): reading directory lblock 0
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio volumio[28612]: info: Adding Calm Radio to Browse Sources
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 27 12:21:05 volumio volumio[28612]: info: [1751019665681] CoreMusicLibrary::Adding element Calm Radio
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 12:21:05 volumio volumio[28612]: Cannot find translation for source Calm Radio
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio systemd[28816]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio systemd[28816]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio kernel: EXT4-fs error (device mmcblk0p3): ext4_journal_check_start:83: comm node: Detected aborted journal
Jun 27 12:21:05 volumio kernel: EXT4-fs (mmcblk0p3): Remounting filesystem read-only
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio systemd[28817]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio systemd[28817]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio systemd[28818]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio systemd[28818]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio volumio[28612]: info: Creating Spotify config file
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio systemd[28819]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio systemd[28819]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio systemd[28820]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio systemd[28820]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio smbd[28821]: [2025/06/27 12:21:05.839109, 0] ../source3/lib/util.c:493(reinit_after_fork)
Jun 27 12:21:05 volumio smbd[28821]: [2025/06/27 12:21:05.848516, 0] ../lib/util/fault.c:79(fault_report)
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio kernel: I/O error, dev loop0, sector 686198 op 0x0:(READ) flags 0x800 phys_seg 10 prio class 2
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Failed to read block 0x14f0ee16: -5
Jun 27 12:21:05 volumio kernel: I/O error, dev loop0, sector 686270 op 0x0:(READ) flags 0x800 phys_seg 10 prio class 2
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Failed to read block 0x14f17f9e: -5
Jun 27 12:21:05 volumio kernel: I/O error, dev loop0, sector 686270 op 0x0:(READ) flags 0x800 phys_seg 10 prio class 2
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Failed to read block 0x14f17f9e: -5
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Unable to read data cache entry [14f17f9e]
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Unable to read page, block 14f17f9e, size 8931
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Unable to read data cache entry [14f17f9e]
Jun 27 12:21:05 volumio kernel: SQUASHFS error: Unable to read page, block 14f17f9e, size 8931
Jun 27 12:21:05 volumio smbd[28821]: ===============================================================
Jun 27 12:21:05 volumio smbd[28821]: [2025/06/27 12:21:05.848974, 0] ../lib/util/fault.c:80(fault_report)
Jun 27 12:21:05 volumio smbd[28821]: INTERNAL ERROR: Signal 7 in pid 28821 (4.9.5-Debian)
Jun 27 12:21:05 volumio smbd[28821]: Please read the Trouble-Shooting section of the Samba HOWTO
Jun 27 12:21:05 volumio smbd[28821]: [2025/06/27 12:21:05.849297, 0] ../lib/util/fault.c:82(fault_report)
Jun 27 12:21:05 volumio smbd[28821]: ===============================================================
Jun 27 12:21:05 volumio smbd[28821]: [2025/06/27 12:21:05.849549, 0] ../source3/lib/util.c:816(smb_panic_s3)
Jun 27 12:21:05 volumio systemd[28822]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio smbd[28821]: PANIC (pid 28821): internal error
Jun 27 12:21:05 volumio systemd[28822]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio smbd[28821]: [2025/06/27 12:21:05.867281, 0] ../lib/util/fault.c:261(log_stack_trace)
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio smbd[28821]: BACKTRACE: 0 stack frames:
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio smbd[28821]: [2025/06/27 12:21:05.867870, 0] ../source3/lib/dumpcore.c:315(dump_core)
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio smbd[28821]: dumping core in /var/log/samba/cores/smbd
Jun 27 12:21:05 volumio smbd[28821]:
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio systemd[28823]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio systemd[28823]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Jun 27 12:21:05 volumio systemd[1]: Unmounting /boot...
Jun 27 12:21:05 volumio systemd[28824]: boot.mount: Failed to execute command: Input/output error
Jun 27 12:21:05 volumio systemd[28824]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Jun 27 12:21:05 volumio systemd[1]: Failed unmounting /boot.
Jun 27 12:21:05 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device, but not stopping since we tried this too often recently.
Jun 27 12:21:05 volumio systemd[1]: systemd-fsck@dev-disk-by\x2duuid-7883\x2d9333.service: Succeeded.
Jun 27 12:21:05 volumio systemd[1]: Stopped File System Check on /dev/disk/by-uuid/7883-9333.
Jun 27 12:21:06 volumio volumio[28612]: info: Loading i18n strings for locale fr
Jun 27 12:21:06 volumio kernel: EXT4-fs warning (device mmcblk0p3): htree_dirblock_to_tree:1082: inode #393595: lblock 0: comm node: error -5 reading directory block
Jun 27 12:21:06 volumio volumio[28612]: error: Plugin fusiondsp failed to start! Error: EIO: i/o error, scandir '/data/plugins/audio_interface/fusiondsp/i18n'
Jun 27 12:21:06 volumio volumio[28612]: info: Volumio Calling Home
Jun 27 12:21:06 volumio volumio[28612]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/system_controller/system/config.json'
Jun 27 12:21:06 volumio volumio[28612]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/plugins.json'
Jun 27 12:21:06 volumio volumio[28612]: error: Failed to write spotify config file: Error: EROFS: read-only file system, open '/data/go-librespot/config.yml'
Jun 27 12:21:06 volumio volumio[28612]: error: Error initializing go-librespot daemon: Error: EROFS: read-only file system, open '/data/go-librespot/config.yml'
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::volumioGetState
Jun 27 12:21:06 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:06 volumio volumio[28612]: info: [ASDebug] CurState: stop PrevState: na
Jun 27 12:21:06 volumio volumio[28612]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Jun 27 12:21:06 volumio volumio[28612]: info: [ASDebug] CurState: stop PrevState: na
Jun 27 12:21:06 volumio volumio[28612]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Jun 27 12:21:06 volumio volumio[28612]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:aaaa/block/mmcblk0/mmcblk0p1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/mmc-SD32G_0x5952a17f-part1 /dev/disk/by-label/boot /dev/disk/by-partuuid/d5471645-01 /dev/disk/by-path/platform-3f202000.mmc-part1 /dev/disk/by-uuid/7883-9333","DEVNAME":"/dev/mmcblk0p1","DEVPATH":"/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:aaaa/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":"7883-9333","ID_FS_UUID_ENC":"7883-9333","ID_FS_VERSION":"FAT16","ID_NAME":"SD32G","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":"d5471645-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"d5471645","ID_PATH":"platform-3f202000.mmc","ID_PATH_TAG":"platform-3f202000_mmc","ID_SERIAL":"0x5952a17f","MAJOR":"179","MINOR":"1","PARTN":"1","SEQNUM":"1826","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"4473176"}
Jun 27 12:21:06 volumio volumio[28612]: verbose: New Socket.io Connection to 192.168.1.33 from 192.168.1.30 UA: Mozilla/5.0 (Linux; Android 16; Pixel 8 Build/BP2A.250605.031.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Jun 27 12:21:06 volumio volumio[28612]: info: MPD Permissions set
Jun 27 12:21:06 volumio volumio[28612]: info: MPD Permissions set
Jun 27 12:21:06 volumio volumio[28612]: info: Upmpdcli Daemon Started
Jun 27 12:21:06 volumio volumio[28612]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:aaaa/block/mmcblk0/mmcblk0p2","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-3f202000.mmc-part2 /dev/disk/by-partuuid/d5471645-02 /dev/disk/by-label/volumio /dev/disk/by-id/mmc-SD32G_0x5952a17f-part2 /dev/disk/by-uuid/9b6a8fd4-d1e0-41c3-90e3-655c7141a81c","DEVNAME":"/dev/mmcblk0p2","DEVPATH":"/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:aaaa/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":"9b6a8fd4-d1e0-41c3-90e3-655c7141a81c","ID_FS_UUID_ENC":"9b6a8fd4-d1e0-41c3-90e3-655c7141a81c","ID_FS_VERSION":"1.0","ID_NAME":"SD32G","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":"d5471645-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"d5471645","ID_PATH":"platform-3f202000.mmc","ID_PATH_TAG":"platform-3f202000_mmc","ID_SERIAL":"0x5952a17f","MAJOR":"179","MINOR":"2","PARTN":"2","SEQNUM":"1827","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"4534036"}
Jun 27 12:21:06 volumio volumio[28612]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:aaaa/block/mmcblk0/mmcblk0p3","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-3f202000.mmc-part3 /dev/disk/by-id/mmc-SD32G_0x5952a17f-part3 /dev/disk/by-partuuid/d5471645-03 /dev/disk/by-label/volumio_data /dev/disk/by-uuid/c75be7bf-cb40-4f2c-bd96-b2f0a9a321fe","DEVNAME":"/dev/mmcblk0p3","DEVPATH":"/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:aaaa/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":"c75be7bf-cb40-4f2c-bd96-b2f0a9a321fe","ID_FS_UUID_ENC":"c75be7bf-cb40-4f2c-bd96-b2f0a9a321fe","ID_FS_VERSION":"1.0","ID_NAME":"SD32G","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":"d5471645-03","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"d5471645","ID_PATH":"platform-3f202000.mmc","ID_PATH_TAG":"platform-3f202000_mmc","ID_SERIAL":"0x5952a17f","MAJOR":"179","MINOR":"3","PARTN":"3","SEQNUM":"1828","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"4473410"}
Jun 27 12:21:06 volumio volumio[28612]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jun 27 12:21:06 volumio volumio[28612]: info: Volumio called home
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 12:21:06 volumio volumio[28612]: info: No need to fix Spotify hosts
Jun 27 12:21:06 volumio volumio[28612]: info: Could not write mpd.conf:Error: EROFS: read-only file system, open '/etc/mpd.conf'
Jun 27 12:21:06 volumio volumio[28612]: info: Could not write mpd.conf:Error: EROFS: read-only file system, open '/etc/mpd.conf'
Jun 27 12:21:07 volumio volumio[28612]: info: Starting Shairport Sync
Jun 27 12:21:07 volumio volumio[28612]: info: Starting Shairport Sync
Jun 27 12:21:07 volumio volumio[28612]: info: Starting Shairport Sync
Jun 27 12:21:07 volumio winbindd[28839]: [2025/06/27 12:21:07.153678, 0] ../source3/lib/util.c:493(reinit_after_fork)
Jun 27 12:21:07 volumio winbindd[28839]: [2025/06/27 12:21:07.154790, 0] ../lib/util/fault.c:79(fault_report)
Jun 27 12:21:07 volumio winbindd[28839]: ===============================================================
Jun 27 12:21:07 volumio winbindd[28839]: [2025/06/27 12:21:07.155132, 0] ../lib/util/fault.c:80(fault_report)
Jun 27 12:21:07 volumio winbindd[28839]: INTERNAL ERROR: Signal 7 in pid 28839 (4.9.5-Debian)
Jun 27 12:21:07 volumio winbindd[28839]: Please read the Trouble-Shooting section of the Samba HOWTO
Jun 27 12:21:07 volumio winbindd[28839]: [2025/06/27 12:21:07.155492, 0] ../lib/util/fault.c:82(fault_report)
Jun 27 12:21:07 volumio winbindd[28839]: ===============================================================
Jun 27 12:21:07 volumio winbindd[28839]: [2025/06/27 12:21:07.155761, 0] ../source3/lib/util.c:816(smb_panic_s3)
Jun 27 12:21:07 volumio winbindd[28839]: PANIC (pid 28839): internal error
Jun 27 12:21:07 volumio kernel: SQUASHFS error: Unable to read data cache entry [14f17f9e]
Jun 27 12:21:07 volumio kernel: SQUASHFS error: Unable to read page, block 14f17f9e, size 8931
Jun 27 12:21:07 volumio kernel: SQUASHFS error: Unable to read data cache entry [14f17f9e]
Jun 27 12:21:07 volumio kernel: SQUASHFS error: Unable to read page, block 14f17f9e, size 8931
Jun 27 12:21:07 volumio winbindd[28839]: [2025/06/27 12:21:07.159646, 0] ../lib/util/fault.c:261(log_stack_trace)
Jun 27 12:21:07 volumio winbindd[28839]: BACKTRACE: 0 stack frames:
Jun 27 12:21:07 volumio winbindd[28839]: [2025/06/27 12:21:07.160186, 0] ../source3/lib/dumpcore.c:315(dump_core)
Jun 27 12:21:07 volumio winbindd[28839]: dumping core in /var/log/samba/cores/winbindd
Jun 27 12:21:07 volumio winbindd[28839]:
Jun 27 12:21:07 volumio sudo[28837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 27 12:21:07 volumio sudo[28837]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:21:07 volumio sudo[28840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 27 12:21:07 volumio sudo[28840]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:21:07 volumio volumio[28612]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------
Jun 27 12:21:07 volumio volumio[28612]: SPOTIFY: BQB_hMSksR8zM58O00qZLQK6ow_rf8I6UDvTsFqkD9fuJHYE_3nkqFviooA1cFRzSMHBYtaeiOP_rcnJbRP4gsd43xHQjxLDmxyo1I85Oa6ZTQaarQkVdk5eQQCyA6NZj5iSIesRqm6X8zK6aXvxuA4X_BZyZ57FlCp6YhiBw2wWrNVYvk5kIEPz_5CLG1Vb_NnXB5XPv25_WCzXqdP4Mxfa_wwBiTFwQ-W11CwiqZ8EKtRX6R4fH_Tjve9QYYFYHMySOrb3Tu9QPaSsyRsfnfITN8iTq9AWhP3fIB8adwPyMd78Z_o
Jun 27 12:21:07 volumio volumio[28612]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------
Jun 27 12:21:07 volumio volumio[28612]: info: New Spotify access token = BQB_hMSksR8zM58O00qZLQK6ow_rf8I6UDvTsFqkD9fuJHYE_3nkqFviooA1cFRzSMHBYtaeiOP_rcnJbRP4gsd43xHQjxLDmxyo1I85Oa6ZTQaarQkVdk5eQQCyA6NZj5iSIesRqm6X8zK6aXvxuA4X_BZyZ57FlCp6YhiBw2wWrNVYvk5kIEPz_5CLG1Vb_NnXB5XPv25_WCzXqdP4Mxfa_wwBiTFwQ-W11CwiqZ8EKtRX6R4fH_Tjve9QYYFYHMySOrb3Tu9QPaSsyRsfnfITN8iTq9AWhP3fIB8adwPyMd78Z_o
Jun 27 12:21:07 volumio volumio[28612]: info: Spotify credentials grant success - running version from March 24, 2019
Jun 27 12:21:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 27 12:21:07 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 27 12:21:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 27 12:21:07 volumio sudo[28844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 27 12:21:07 volumio sudo[28844]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 12:21:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 27 12:21:07 volumio sudo[28837]: pam_unix(sudo:session): session closed for user root
Jun 27 12:21:07 volumio volumio[28612]: info: CoreCommandRouter::volumioGetState
Jun 27 12:21:07 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 27 12:21:07 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 27 12:21:07 volumio volumio[28612]: info: [ASDebug] Pulsing GPIO for 500ms
Jun 27 12:21:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 27 12:21:07 volumio volumio[28612]: info: [ASDebug] Togle GPIO: ON
Jun 27 12:21:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 27 12:21:07 volumio sudo[28844]: pam_unix(sudo:session): session closed for user root
Jun 27 12:21:07 volumio sudo[28840]: pam_unix(sudo:session): session closed for user root
Jun 27 12:21:07 volumio volumio[28612]: info: Shairport-Sync Started
Jun 27 12:21:07 volumio volumio[28612]: Error adding Membership: Error: addMembership EINVAL
Jun 27 12:21:07 volumio volumio[28612]: info: Shairport-Sync Started
Jun 27 12:21:07 volumio volumio[28612]: info: Shairport-Sync Started
Jun 27 12:21:08 volumio volumio[28612]: info: [ASDebug] Togle GPIO: OFF
Jun 27 12:21:08 volumio volumio[28612]: SPOTIFY: User informations: {"country":"ES","display_name":"Mig","email":"vicanamig@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/317t7exsgicohwbrdqpckzmgzjum"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/317t7exsgicohwbrdqpckzmgzjum","id":"317t7exsgicohwbrdqpckzmgzjum","images":[],"product":"premium","type":"user","uri":"spotify:user:317t7exsgicohwbrdqpckzmgzjum"}
Jun 27 12:21:08 volumio volumio[28612]: info: Spotify Successfully logged in
Jun 27 12:21:08 volumio volumio[28612]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 27 12:21:08 volumio volumio[28612]: info: [1751019668141] CoreMusicLibrary::Adding element Spotify
Jun 27 12:21:08 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 12:21:08 volumio volumio[28612]: Cannot find translation for source Calm Radio
Jun 27 12:21:08 volumio volumio[28612]: Cannot find translation for source Spotify
Jun 27 12:21:08 volumio volumio[28612]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/music_service/spop/config.json'
Jun 27 12:21:08 volumio mpd[28809]: Jun 27 12:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 27 12:21:08 volumio systemd[1]: Started Music Player Daemon.
Jun 27 12:21:08 volumio sudo[28745]: pam_unix(sudo:session): session closed for user root
Jun 27 12:21:08 volumio sudo[28783]: pam_unix(sudo:session): session closed for user root
Jun 27 12:21:08 volumio volumio[28612]: info: Completed starting Core Plugins
Jun 27 12:21:08 volumio volumio[28612]: info: -------------------------------------------
Jun 27 12:21:08 volumio volumio[28612]: info: ----- MyVolumio plugins startup ----
Jun 27 12:21:08 volumio volumio[28612]: info: -------------------------------------------
Jun 27 12:21:08 volumio volumio[28612]: info: [MyVolumio PluginManager] Fetching plans data....
Jun 27 12:21:08 volumio volumio[28612]: error: MPD error: The expression evaluated to a falsy value:
Jun 27 12:21:08 volumio volumio[28612]: assert.ok(self.idling)
Jun 27 12:21:08 volumio volumio[28612]: error: The expression evaluated to a falsy value:
Jun 27 12:21:08 volumio volumio[28612]: assert.ok(self.idling)
Jun 27 12:21:08 volumio volumio[28612]: error: updateQueue error: null
Jun 27 12:21:08 volumio volumio[28612]: info: MPD running with PID28809
Jun 27 12:21:08 volumio volumio[28612]: ,establishing connection
Jun 27 12:21:08 volumio volumio[28612]: error: updateQueue error: null
Jun 27 12:21:09 volumio volumio[28612]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/plugins.json'
Jun 27 12:21:10 volumio nmbd[28858]: [2025/06/27 12:21:10.527664, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database)
Jun 27 12:21:10 volumio nmbd[28858]: wins_write_database: Can't open /var/lib/samba/wins.dat.28858: Read-only file system
Jun 27 12:21:10 volumio kernel: EXT4-fs error: 16 callbacks suppressed
Jun 27 12:21:10 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #393269: comm nmbd: reading directory lblock 0
Jun 27 12:21:10 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #393269: comm nmbd: reading directory lblock 0
Jun 27 12:21:10 volumio nmbd[28857]: [2025/06/27 12:21:10.549123, 0] ../source3/lib/util.c:493(reinit_after_fork)
Jun 27 12:21:10 volumio nmbd[28857]: [2025/06/27 12:21:10.549896, 0] ../lib/util/fault.c:79(fault_report)
Jun 27 12:21:10 volumio nmbd[28857]: ===============================================================
Jun 27 12:21:10 volumio kernel: SQUASHFS error: Unable to read data cache entry [14f17f9e]
Jun 27 12:21:10 volumio kernel: SQUASHFS error: Unable to read page, block 14f17f9e, size 8931
Jun 27 12:21:10 volumio kernel: SQUASHFS error: Unable to read data cache entry [14f17f9e]
Jun 27 12:21:10 volumio kernel: SQUASHFS error: Unable to read page, block 14f17f9e, size 8931
Jun 27 12:21:10 volumio nmbd[28857]: [2025/06/27 12:21:10.550125, 0] ../lib/util/fault.c:80(fault_report)
Jun 27 12:21:10 volumio nmbd[28857]: INTERNAL ERROR: Signal 7 in pid 28857 (4.9.5-Debian)
Jun 27 12:21:10 volumio nmbd[28857]: Please read the Trouble-Shooting section of the Samba HOWTO
Jun 27 12:21:10 volumio nmbd[28857]: [2025/06/27 12:21:10.550328, 0] ../lib/util/fault.c:82(fault_report)
Jun 27 12:21:10 volumio nmbd[28857]: ===============================================================
Jun 27 12:21:10 volumio nmbd[28857]: [2025/06/27 12:21:10.550478, 0] ../source3/lib/util.c:816(smb_panic_s3)
Jun 27 12:21:10 volumio nmbd[28857]: PANIC (pid 28857): internal error
Jun 27 12:21:10 volumio nmbd[28857]: [2025/06/27 12:21:10.554160, 0] ../lib/util/fault.c:261(log_stack_trace)
Jun 27 12:21:10 volumio nmbd[28857]: BACKTRACE: 0 stack frames:
Jun 27 12:21:10 volumio nmbd[28857]: [2025/06/27 12:21:10.554636, 0] ../source3/lib/dumpcore.c:315(dump_core)
Jun 27 12:21:10 volumio nmbd[28857]: dumping core in /var/log/samba/cores/nmbd
Jun 27 12:21:10 volumio nmbd[28857]:
Jun 27 12:21:11 volumio volumio[28612]: verbose: New Socket.io Connection to 192.168.1.33 from 192.168.1.30 UA: Mozilla/5.0 (Linux; Android 16; Pixel 8 Build/BP2A.250605.031.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Jun 27 12:21:11 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 27 12:21:11 volumio volumio[28612]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 27 12:21:11 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 12:21:11 volumio volumio[28612]: info: CoreCommandRouter::volumioGetState
Jun 27 12:21:11 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:11 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 27 12:21:11 volumio volumio[28612]: info: CoreCommandRouter::volumioGetQueue
Jun 27 12:21:11 volumio volumio[28612]: info: CoreStateMachine::getQueue
Jun 27 12:21:11 volumio volumio[28612]: info: CorePlayQueue::getQueue
Jun 27 12:21:11 volumio volumio[28612]: info: Listing playlists
Jun 27 12:21:11 volumio kernel: EXT4-fs warning (device mmcblk0p3): htree_dirblock_to_tree:1082: inode #393386: lblock 0: comm node: error -5 reading directory block
Jun 27 12:21:11 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 27 12:21:11 volumio volumio[28612]: info: Received Get System Info
Jun 27 12:21:11 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 27 12:21:11 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 27 12:21:11 volumio volumio[28612]: info: Discovery: Getting this device information
Jun 27 12:21:11 volumio volumio[28612]: info: CoreCommandRouter::volumioGetState
Jun 27 12:21:11 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:11 volumio volumio[28612]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 27 12:21:11 volumio volumio[28612]: info: CoreCommandRouter::volumioGetState
Jun 27 12:21:11 volumio volumio[28612]: info: CorePlayQueue::getTrack 0
Jun 27 12:21:11 volumio volumio[28612]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 27 12:21:11 volumio kernel: EXT4-fs warning (device mmcblk0p3): htree_dirblock_to_tree:1082: inode #393333: lblock 0: comm node: error -5 reading directory block
Jun 27 12:21:11 volumio volumio[28612]: Error: EIO: i/o error, scandir '/data/plugins/'
Jun 27 12:21:11 volumio volumio[28612]: at Object.readdirSync (fs.js:1021:3)
Jun 27 12:21:11 volumio volumio[28612]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1627:30)
Jun 27 12:21:11 volumio volumio[28612]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1521:29)
Jun 27 12:21:11 volumio volumio[28612]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1328:45)
Jun 27 12:21:11 volumio volumio[28612]: at Socket.emit (events.js:315:20)
Jun 27 12:21:11 volumio volumio[28612]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Jun 27 12:21:11 volumio volumio[28612]: at processTicksAndRejections (internal/process/task_queues.js:75:11) {
Jun 27 12:21:11 volumio volumio[28612]: errno: -5,
Jun 27 12:21:11 volumio volumio[28612]: syscall: 'scandir',
Jun 27 12:21:11 volumio volumio[28612]: code: 'EIO',
Jun 27 12:21:11 volumio volumio[28612]: path: '/data/plugins/'
Jun 27 12:21:11 volumio volumio[28612]: }
Jun 27 12:21:11 volumio volumio[28612]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 27 12:21:12 volumio sudo[28868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-27 12:20
Jun 27 12:21:12 volumio sudo[28868]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST"
VOLUMIO_VERSION="3.742"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"