Oct 13 18:22:00 volumio-kali volumio[1237]: info: Applying required configuration parameters for plugin autostart Oct 13 18:22:00 volumio-kali volumio[1237]: info: AutoStart - onVolumioStart - read config.json Oct 13 18:22:00 volumio-kali volumio[1237]: info: Loading plugin "gpio-buttons"... Oct 13 18:22:01 volumio-kali volumio[1237]: gpiox_arm32 V2.2.1 Oct 13 18:22:02 volumio-kali volumio[1237]: info: gpio-buttons: Initialized Oct 13 18:22:02 volumio-kali volumio[1237]: info: Loading plugin "gpio_button_led"... Oct 13 18:22:02 volumio-kali volumio[1237]: gpiox_arm32 V2.2.1 Oct 13 18:22:03 volumio-kali volumio[1237]: info: Loading plugin "outputs"... Oct 13 18:22:03 volumio-kali volumio[1237]: info: Loading plugin "albumart"... Oct 13 18:22:03 volumio-kali volumio[1237]: info: Plugin example_plugin is not enabled Oct 13 18:22:03 volumio-kali volumio[1237]: info: Loading plugin "inputs"... Oct 13 18:22:03 volumio-kali volumio[1237]: info: Loading plugin "updater_comm"... Oct 13 18:22:04 volumio-kali volumio[1237]: info: Plugin mpdemulation is not enabled Oct 13 18:22:04 volumio-kali volumio[1237]: info: Loading plugin "rest_api"... Oct 13 18:22:04 volumio-kali volumio[1237]: info: Loading plugin "websocket"... Oct 13 18:22:04 volumio-kali volumio[1237]: info: Starting Socket.io Server version 1.7.4 Oct 13 18:22:04 volumio-kali volumio[1237]: info: Loading i18n strings for locale it Oct 13 18:22:04 volumio-kali volumio[1237]: Updating browse sources language Oct 13 18:22:04 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 18:22:05 volumio-kali systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Oct 13 18:22:05 volumio-kali systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 18:22:05 volumio-kali systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 18:22:05 volumio-kali upmpdcli[1378]: Could not open config: /tmp/upmpdcli.conf Oct 13 18:22:05 volumio-kali systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 13 18:22:05 volumio-kali systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 13 18:22:05 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 18:22:05 volumio-kali volumio[1237]: info: CoreCommandRouter::initPlayerControls Oct 13 18:22:05 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:05 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:05 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:05 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:05 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:05 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:05 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:05 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:06 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 18:22:06 volumio-kali volumio[1237]: Express server listening on port 3000 Oct 13 18:22:06 volumio-kali volumio[1237]: [Metrics] WebUI: 24s 325.48ms Oct 13 18:22:06 volumio-kali volumio-remote-updater[681]: [2026-10-13 18:22:06] [connect] Successful connection Oct 13 18:22:06 volumio-kali volumio[1237]: info: CoreStateMachine::resetVolumioState Oct 13 18:22:06 volumio-kali volumio[1237]: info: CoreStateMachine::getcurrentVolume Oct 13 18:22:06 volumio-kali volumio[1237]: info: CoreCommandRouter::volumioRetrievevolume Oct 13 18:22:06 volumio-kali volumio[1237]: info: CoreStateMachine::pushState Oct 13 18:22:06 volumio-kali volumio[1237]: info: CorePlayQueue::getTrack 0 Oct 13 18:22:06 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:22:06 volumio-kali volumio[1237]: info: CoreCommandRouter::volumioPushState Oct 13 18:22:06 volumio-kali sudo[1385]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 18:22:06 volumio-kali sudo[1385]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:06 volumio-kali sudo[1385]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:06 volumio-kali sudo[1383]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 18:22:06 volumio-kali sudo[1383]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:06 volumio-kali sudo[1383]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:06 volumio-kali volumio[1237]: info: Volumio Network Manager: Network status updated: 1 Oct 13 18:22:07 volumio-kali volumio[1368]: Forking 3 albumart workers Oct 13 18:22:07 volumio-kali volumio-remote-updater[681]: [2026-10-13 18:22:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1791908526 101 Oct 13 18:22:08 volumio-kali volumio[1237]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 1 Oct 13 18:22:08 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 18:22:08 volumio-kali volumio[1237]: info: Executing start script for DAC BassMantis-uHAT with I2S Mic Oct 13 18:22:08 volumio-kali volumio[1237]: info: Reloading queue from file Oct 13 18:22:09 volumio-kali volumio[1237]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Oct 13 18:22:09 volumio-kali sudo[1424]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x00 0xAA55 w Oct 13 18:22:09 volumio-kali sudo[1424]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:09 volumio-kali volumio[1237]: info: CoreStateMachine::setRepeat true single undefined Oct 13 18:22:09 volumio-kali sudo[1424]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:09 volumio-kali volumio[1237]: info: CoreStateMachine::pushState Oct 13 18:22:09 volumio-kali volumio[1237]: info: CorePlayQueue::getTrack 0 Oct 13 18:22:09 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:22:09 volumio-kali volumio[1237]: info: CoreCommandRouter::volumioPushState Oct 13 18:22:09 volumio-kali volumio[1237]: info: CoreStateMachine::setRandom null Oct 13 18:22:09 volumio-kali volumio[1237]: info: CoreStateMachine::pushState Oct 13 18:22:09 volumio-kali volumio[1237]: info: CorePlayQueue::getTrack 0 Oct 13 18:22:09 volumio-kali volumio[1237]: info: CoreCommandRouter::volumioPushState Oct 13 18:22:09 volumio-kali volumio[1237]: info: Setting Device type: Raspberry PI Oct 13 18:22:09 volumio-kali sudo[1429]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x00 0xAA55 w Oct 13 18:22:09 volumio-kali sudo[1429]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:09 volumio-kali sudo[1429]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:10 volumio-kali sudo[1433]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x04 0x4400 w Oct 13 18:22:10 volumio-kali sudo[1433]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:10 volumio-kali sudo[1433]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:10 volumio-kali sudo[1435]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x04 0x4400 w Oct 13 18:22:10 volumio-kali sudo[1435]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:10 volumio-kali sudo[1435]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:10 volumio-kali volumio[1237]: info: Discovery: adding 04135292-3f45-4e02-b5c9-55717680aac2 Oct 13 18:22:10 volumio-kali volumio[1237]: info: Discovery: Found device Volumio Kali Oct 13 18:22:10 volumio-kali volumio[1237]: info: CoreCommandRouter::volumioGetState Oct 13 18:22:10 volumio-kali volumio[1237]: info: CorePlayQueue::getTrack 0 Oct 13 18:22:10 volumio-kali sudo[1437]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 13 18:22:10 volumio-kali sudo[1437]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:11 volumio-kali volumio[1237]: info: Discovery: this is already registered, 04135292-3f45-4e02-b5c9-55717680aac2 Oct 13 18:22:11 volumio-kali volumio[1237]: info: Discovery: Found device Volumio Kali Oct 13 18:22:11 volumio-kali volumio[1237]: info: CoreCommandRouter::volumioGetState Oct 13 18:22:11 volumio-kali volumio[1237]: info: CorePlayQueue::getTrack 0 Oct 13 18:22:11 volumio-kali sudo[1439]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x05 0xE724 w Oct 13 18:22:11 volumio-kali sudo[1439]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:11 volumio-kali sudo[1439]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:11 volumio-kali sudo[1446]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x05 0xE728 w Oct 13 18:22:11 volumio-kali sudo[1446]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:11 volumio-kali sudo[1446]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:11 volumio-kali sudo[1458]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x09 0x4A42 w Oct 13 18:22:11 volumio-kali sudo[1458]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:11 volumio-kali sudo[1458]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:11 volumio-kali volumio[1237]: info: gpio-buttons: Socket connected to Volumio Oct 13 18:22:12 volumio-kali sudo[1460]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x09 0x4A42 w Oct 13 18:22:12 volumio-kali sudo[1460]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:12 volumio-kali sudo[1460]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:12 volumio-kali sudo[1462]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x0A 0xC203 w Oct 13 18:22:12 volumio-kali sudo[1462]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:12 volumio-kali sudo[1462]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:13 volumio-kali sudo[1464]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x0A 0xC203 w Oct 13 18:22:13 volumio-kali sudo[1464]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:13 volumio-kali sudo[1464]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:13 volumio-kali sudo[1466]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x0B 0xC203 w Oct 13 18:22:13 volumio-kali sudo[1466]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:13 volumio-kali sudo[1466]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:13 volumio-kali sudo[1468]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x0B 0xC203 w Oct 13 18:22:13 volumio-kali sudo[1468]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:13 volumio-kali sudo[1468]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:14 volumio-kali sudo[1470]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x0C 0x0770 w Oct 13 18:22:14 volumio-kali sudo[1470]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:14 volumio-kali sudo[1470]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:14 volumio-kali sudo[1472]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x0C 0x0770 w Oct 13 18:22:14 volumio-kali sudo[1472]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:14 volumio-kali sudo[1472]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:14 volumio-kali sudo[1474]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x0D 0x1B00 w Oct 13 18:22:14 volumio-kali sudo[1474]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:14 volumio-kali sudo[1474]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:15 volumio-kali sudo[1476]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x0D 0x1B00 w Oct 13 18:22:15 volumio-kali sudo[1476]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:15 volumio-kali sudo[1476]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:15 volumio-kali sudo[1478]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x0E 0x2903 w Oct 13 18:22:15 volumio-kali sudo[1478]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:15 volumio-kali sudo[1478]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:16 volumio-kali sudo[1480]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x0E 0x2903 w Oct 13 18:22:16 volumio-kali sudo[1480]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:16 volumio-kali sudo[1480]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:16 volumio-kali sudo[1482]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x20 0x0100 w Oct 13 18:22:16 volumio-kali sudo[1482]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:16 volumio-kali sudo[1482]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:17 volumio-kali sudo[1484]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x20 0x0100 w Oct 13 18:22:17 volumio-kali sudo[1484]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:17 volumio-kali sudo[1484]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:17 volumio-kali sudo[1486]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x60 0x841C w Oct 13 18:22:17 volumio-kali sudo[1486]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:17 volumio-kali sudo[1486]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:17 volumio-kali sudo[1488]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x60 0x841C w Oct 13 18:22:17 volumio-kali sudo[1488]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:17 volumio-kali sudo[1488]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:18 volumio-kali sudo[1490]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x61 0x0E0F w Oct 13 18:22:18 volumio-kali sudo[1490]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:18 volumio-kali sudo[1490]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:18 volumio-kali sudo[1492]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x61 0x0E0F w Oct 13 18:22:18 volumio-kali sudo[1492]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:18 volumio-kali sudo[1492]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:19 volumio-kali sudo[1494]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x62 0x8EF5 w Oct 13 18:22:19 volumio-kali sudo[1494]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:19 volumio-kali sudo[1494]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:19 volumio-kali sudo[1496]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x62 0x8EF5 w Oct 13 18:22:19 volumio-kali sudo[1496]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:19 volumio-kali sudo[1496]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:19 volumio-kali sudo[1498]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x63 0x7F30 w Oct 13 18:22:19 volumio-kali sudo[1498]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:19 volumio-kali sudo[1498]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:20 volumio-kali sudo[1500]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x63 0x7F30 w Oct 13 18:22:20 volumio-kali sudo[1500]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:20 volumio-kali sudo[1500]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:20 volumio-kali sudo[1502]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x67 0x7C00 w Oct 13 18:22:20 volumio-kali sudo[1502]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:20 volumio-kali sudo[1502]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:20 volumio-kali systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4. Oct 13 18:22:20 volumio-kali systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 18:22:20 volumio-kali systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 18:22:21 volumio-kali sudo[1437]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:21 volumio-kali volumio[1237]: info: Upmpdcli Daemon Started Oct 13 18:22:21 volumio-kali sudo[1504]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x67 0x7C00 w Oct 13 18:22:21 volumio-kali sudo[1504]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:21 volumio-kali volumio[1237]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 13 18:22:21 volumio-kali sudo[1504]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:21 volumio-kali sudo[1517]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x69 0x4102 w Oct 13 18:22:21 volumio-kali sudo[1517]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:21 volumio-kali sudo[1517]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:22 volumio-kali sudo[1537]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x69 0x4102 w Oct 13 18:22:22 volumio-kali sudo[1537]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:22 volumio-kali sudo[1537]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:22 volumio-kali sudo[1540]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x34 0x08 0x0E20 w Oct 13 18:22:22 volumio-kali sudo[1540]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:22 volumio-kali sudo[1540]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:22 volumio-kali systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 13 18:22:22 volumio-kali systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 13 18:22:22 volumio-kali systemd[1]: setdatetime-helper.service: Consumed 2.016s CPU time. Oct 13 18:22:22 volumio-kali sudo[1546]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -y 1 0x35 0x08 0x0E20 w Oct 13 18:22:22 volumio-kali sudo[1546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:22 volumio-kali sudo[1546]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:22 volumio-kali volumio[1237]: info: DAC script executed Oct 13 18:22:22 volumio-kali volumio[1237]: info: Completed loading Core Plugins Oct 13 18:22:22 volumio-kali volumio[1237]: info: Preparing to generate the ALSA configuration file Oct 13 18:22:23 volumio-kali volumio[1237]: info: Asound.conf file unchanged, so no further update is needed Oct 13 18:22:23 volumio-kali volumio[1237]: info: Output device has changed, restarting MPD Oct 13 18:22:23 volumio-kali volumio[1237]: info: Output device has changed, restarting Shairport Sync Oct 13 18:22:23 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:23 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 18:22:23 volumio-kali sudo[1549]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 13 18:22:23 volumio-kali sudo[1549]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:23 volumio-kali sudo[1549]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:24 volumio-kali volumio[1237]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 13 18:22:24 volumio-kali sudo[1551]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 13 18:22:24 volumio-kali volumio[1237]: info: ___________ START PLUGINS ___________ Oct 13 18:22:24 volumio-kali sudo[1551]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:24 volumio-kali volumio[1237]: info: ControllerMpd::onStart: Initializing MPD Oct 13 18:22:24 volumio-kali volumio[1237]: info: Creating MPD Configuration file Oct 13 18:22:24 volumio-kali systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 13 18:22:24 volumio-kali systemd[1]: Starting mpd.service - Music Player Daemon... Oct 13 18:22:24 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 18:22:24 volumio-kali volumio[1237]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 18:22:24 volumio-kali volumio[1237]: info: [1791908544645] CoreMusicLibrary::Adding element Server multimediali Oct 13 18:22:24 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 18:22:24 volumio-kali sudo[1561]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 13 18:22:24 volumio-kali sudo[1561]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:24 volumio-kali sudo[1559]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Oct 13 18:22:25 volumio-kali sudo[1567]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 13 18:22:25 volumio-kali volumio[1237]: info: UPNP Browser: Client initialized successfully Oct 13 18:22:24 volumio-kali sudo[1559]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:25 volumio-kali sudo[1565]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 13 18:22:25 volumio-kali sudo[1564]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 13 18:22:25 volumio-kali sudo[1565]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 13 18:22:25 volumio-kali sudo[1564]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:25 volumio-kali sudo[1565]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:25 volumio-kali sudo[1561]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:25 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:25 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 18:22:25 volumio-kali systemd[1]: mpd.service: Deactivated successfully. Oct 13 18:22:25 volumio-kali systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 13 18:22:25 volumio-kali systemd[1]: mpd.socket: Deactivated successfully. Oct 13 18:22:25 volumio-kali systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 13 18:22:25 volumio-kali systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 13 18:22:25 volumio-kali volumio[1237]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 13 18:22:25 volumio-kali systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 13 18:22:25 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:25 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 18:22:25 volumio-kali systemd[1]: Starting mpd.service - Music Player Daemon... Oct 13 18:22:25 volumio-kali systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 18:22:25 volumio-kali sudo[1559]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:26 volumio-kali sudo[1576]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 13 18:22:26 volumio-kali sudo[1576]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 13 18:22:26 volumio-kali sudo[1582]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 13 18:22:26 volumio-kali sudo[1576]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:26 volumio-kali volumio[1237]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 13 18:22:26 volumio-kali volumio[1237]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 18:22:26 volumio-kali volumio[1237]: info: [1791908546251] CoreMusicLibrary::Adding element Last_100 Oct 13 18:22:26 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 18:22:26 volumio-kali volumio[1237]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 18:22:26 volumio-kali volumio[1237]: info: [1791908546257] CoreMusicLibrary::Adding element Webradio Oct 13 18:22:26 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 18:22:26 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 18:22:26 volumio-kali volumio[1237]: info: Initializing BBC Radios Oct 13 18:22:26 volumio-kali volumio[1390]: Starting albumart workers Oct 13 18:22:26 volumio-kali volumio[1389]: Starting albumart workers Oct 13 18:22:27 volumio-kali volumio[1391]: Starting albumart workers Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: zlib decompression failed, data probably corrupt Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Failed to read block 0x694e05c: -5 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: unexpected fault address 0x271ee4 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: fatal error: fault Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: [signal SIGBUS: bus error code=0x2 addr=0x271ee4 pc=0x271ee4] Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: goroutine 1 gp=0x1c02128 m=0 mp=0x10b27f0 [running, locked to thread]: Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.throw({0x9f0f76, 0x5}) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/panic.go:1101 +0x34 fp=0x1c50e58 sp=0x1c50e44 pc=0x98e5c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.sigpanic() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/signal_unix.go:922 +0x104 fp=0x1c50e88 sp=0x1c50e58 pc=0x9b0d4 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: github.com/VolumioTeam/proto-repo/streaming-common/gen/go/streaming/common/v1.init() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: :1 fp=0x1c50e8c sp=0x1c50e8c pc=0x271ee4 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.doInit1(0x104b9d8) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/proc.go:7410 +0xcc fp=0x1c50fa8 sp=0x1c50e8c pc=0x7051c Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: zlib decompression failed, data probably corrupt Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Failed to read block 0x694e05c: -5 Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.doInit(...) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/proc.go:7377 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.main() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/proc.go:254 +0x3ec fp=0x1c50fec sp=0x1c50fa8 pc=0x5f9dc Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.goexit({}) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x1c50fec sp=0x1c50fec pc=0xa0370 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: goroutine 18 gp=0x1c82248 m=nil [force gc (idle)]: Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.gopark(0xa3875c, 0x10afc08, 0x11, 0xa, 0x1) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x1c3e7d4 sp=0x1c3e7c0 pc=0x98f9c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.goparkunlock(...) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.forcegchelper() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/proc.go:348 +0xe4 fp=0x1c3e7ec sp=0x1c3e7d4 pc=0x5fd48 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.goexit({}) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x1c3e7ec sp=0x1c3e7ec pc=0xa0370 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: created by runtime.init.6 in goroutine 1 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/proc.go:336 +0x1c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: goroutine 19 gp=0x1c82368 m=nil [GC sweep wait]: Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.gopark(0xa3875c, 0x10b06a0, 0xc, 0x9, 0x1) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x1c3efc4 sp=0x1c3efb0 pc=0x98f9c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.goparkunlock(...) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.bgsweep(0x1c92000) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/mgcsweep.go:276 +0xa8 fp=0x1c3efe4 sp=0x1c3efc4 pc=0x486bc Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.gcenable.gowrap1() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x1c3efec sp=0x1c3efe4 pc=0x38238 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.goexit({}) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x1c3efec sp=0x1c3efec pc=0xa0370 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: created by runtime.gcenable in goroutine 1 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/mgc.go:204 +0x74 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: goroutine 20 gp=0x1c82488 m=nil [GC scavenge wait]: Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.gopark(0xa3875c, 0x10b12a8, 0xd, 0xa, 0x2) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x1c3f7b4 sp=0x1c3f7a0 pc=0x98f9c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.goparkunlock(...) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.(*scavengerState).park(0x10b12a8) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x1c3f7c8 sp=0x1c3f7b4 pc=0x45acc Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.bgscavenge(0x1c92000) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/mgcscavenge.go:653 +0x3c fp=0x1c3f7e4 sp=0x1c3f7c8 pc=0x461d8 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.gcenable.gowrap2() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/mgc.go:205 +0x28 fp=0x1c3f7ec sp=0x1c3f7e4 pc=0x381e4 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.goexit({}) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x1c3f7ec sp=0x1c3f7ec pc=0xa0370 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: created by runtime.gcenable in goroutine 1 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/mgc.go:205 +0xbc Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: goroutine 2 gp=0x1c02c68 m=nil [finalizer wait]: Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.gopark(0xa38608, 0x10bca60, 0x10, 0xa, 0x1) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x1c42f90 sp=0x1c42f7c pc=0x98f9c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.runfinq() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/mfinal.go:196 +0x110 fp=0x1c42fec sp=0x1c42f90 pc=0x36f4c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: runtime.goexit({}) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x1c42fec sp=0x1c42fec pc=0xa0370 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: created by runtime.createfing in goroutine 1 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1579]: /usr/local/go/src/runtime/mfinal.go:166 +0x5c Oct 13 18:22:27 volumio-kali systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Oct 13 18:22:27 volumio-kali systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 13 18:22:27 volumio-kali systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Oct 13 18:22:27 volumio-kali systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 18:22:27 volumio-kali systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: unexpected fault address 0x271ee4 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: fatal error: fault Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: [signal SIGBUS: bus error code=0x2 addr=0x271ee4 pc=0x271ee4] Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: goroutine 1 gp=0x2802128 m=0 mp=0x10b27f0 [running, locked to thread]: Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.throw({0x9f0f76, 0x5}) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/panic.go:1101 +0x34 fp=0x2850e58 sp=0x2850e44 pc=0x98e5c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.sigpanic() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/signal_unix.go:922 +0x104 fp=0x2850e88 sp=0x2850e58 pc=0x9b0d4 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: github.com/VolumioTeam/proto-repo/streaming-common/gen/go/streaming/common/v1.init() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: :1 fp=0x2850e8c sp=0x2850e8c pc=0x271ee4 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.doInit1(0x104b9d8) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/proc.go:7410 +0xcc fp=0x2850fa8 sp=0x2850e8c pc=0x7051c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.doInit(...) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/proc.go:7377 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.main() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/proc.go:254 +0x3ec fp=0x2850fec sp=0x2850fa8 pc=0x5f9dc Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.goexit({}) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x2850fec sp=0x2850fec pc=0xa0370 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: goroutine 2 gp=0x28027e8 m=nil [force gc (idle)]: Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.gopark(0xa3875c, 0x10afc08, 0x11, 0xa, 0x1) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x2842fd4 sp=0x2842fc0 pc=0x98f9c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.goparkunlock(...) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.forcegchelper() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/proc.go:348 +0xe4 fp=0x2842fec sp=0x2842fd4 pc=0x5fd48 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.goexit({}) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x2842fec sp=0x2842fec pc=0xa0370 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: created by runtime.init.6 in goroutine 1 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/proc.go:336 +0x1c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: goroutine 18 gp=0x2882248 m=nil [GC sweep wait]: Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.gopark(0xa3875c, 0x10b06a0, 0xc, 0x9, 0x1) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x283e7c4 sp=0x283e7b0 pc=0x98f9c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.goparkunlock(...) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.bgsweep(0x2890000) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/mgcsweep.go:276 +0xa8 fp=0x283e7e4 sp=0x283e7c4 pc=0x486bc Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.gcenable.gowrap1() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x283e7ec sp=0x283e7e4 pc=0x38238 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.goexit({}) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x283e7ec sp=0x283e7ec pc=0xa0370 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: created by runtime.gcenable in goroutine 1 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/mgc.go:204 +0x74 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: goroutine 19 gp=0x2882368 m=nil [GC scavenge wait]: Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.gopark(0xa3875c, 0x10b12a8, 0xd, 0xa, 0x2) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x283efb4 sp=0x283efa0 pc=0x98f9c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.goparkunlock(...) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.(*scavengerState).park(0x10b12a8) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x283efc8 sp=0x283efb4 pc=0x45acc Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.bgscavenge(0x2890000) Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:27 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:27 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 18:22:27 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 18:22:27 volumio-kali systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/mgcscavenge.go:653 +0x3c fp=0x283efe4 sp=0x283efc8 pc=0x461d8 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.gcenable.gowrap2() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/mgc.go:205 +0x28 fp=0x283efec sp=0x283efe4 pc=0x381e4 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.goexit({}) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x283efec sp=0x283efec pc=0xa0370 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: created by runtime.gcenable in goroutine 1 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/mgc.go:205 +0xbc Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: goroutine 20 gp=0x28826c8 m=nil [finalizer wait]: Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.gopark(0xa38608, 0x10bca60, 0x10, 0xa, 0x1) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x283f790 sp=0x283f77c pc=0x98f9c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.runfinq() Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/mfinal.go:196 +0x110 fp=0x283f7ec sp=0x283f790 pc=0x36f4c Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: runtime.goexit({}) Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x283f7ec sp=0x283f7ec pc=0xa0370 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: created by runtime.createfing in goroutine 1 Oct 13 18:22:27 volumio-kali volumio5-onboarding[1600]: /usr/local/go/src/runtime/mfinal.go:166 +0x5c Oct 13 18:22:27 volumio-kali systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 13 18:22:27 volumio-kali volumio[1237]: info: AutoStart - onStart - waiting for system ready state Oct 13 18:22:27 volumio-kali volumio[1237]: info: AutoStart - Polling config: interval=5000ms, maxAttempts=60 Oct 13 18:22:27 volumio-kali volumio[1237]: info: AutoStart - Maximum wait time: 300 seconds Oct 13 18:22:27 volumio-kali volumio[1237]: info: AutoStart - Startup volume disabled Oct 13 18:22:27 volumio-kali volumio[1237]: info: AutoStart - Check #1/60 - VOLUMIO_SYSTEM_STATUS = starting Oct 13 18:22:27 volumio-kali volumio[1237]: info: gpio-buttons: Creating GPIO triggers... Oct 13 18:22:27 volumio-kali volumio[1237]: info: gpio-buttons: GPIO3 configured: button6 -> shutdown Oct 13 18:22:27 volumio-kali volumio[1237]: info: GPIOButtonLED: Starting plugin Oct 13 18:22:27 volumio-kali systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 2. Oct 13 18:22:27 volumio-kali systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 18:22:27 volumio-kali volumio[1237]: info: Volumio Calling Home Oct 13 18:22:28 volumio-kali systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: unexpected fault address 0x271ee4 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: fatal error: fault Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: [signal SIGBUS: bus error code=0x2 addr=0x271ee4 pc=0x271ee4] Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: goroutine 1 gp=0x2802128 m=0 mp=0x10b27f0 [running, locked to thread]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.throw({0x9f0f76, 0x5}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/panic.go:1101 +0x34 fp=0x2850e58 sp=0x2850e44 pc=0x98e5c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.sigpanic() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/signal_unix.go:922 +0x104 fp=0x2850e88 sp=0x2850e58 pc=0x9b0d4 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: github.com/VolumioTeam/proto-repo/streaming-common/gen/go/streaming/common/v1.init() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: :1 fp=0x2850e8c sp=0x2850e8c pc=0x271ee4 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.doInit1(0x104b9d8) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/proc.go:7410 +0xcc fp=0x2850fa8 sp=0x2850e8c pc=0x7051c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.doInit(...) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/proc.go:7377 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.main() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/proc.go:254 +0x3ec fp=0x2850fec sp=0x2850fa8 pc=0x5f9dc Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x2850fec sp=0x2850fec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: goroutine 2 gp=0x28027e8 m=nil [force gc (idle)]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.gopark(0xa3875c, 0x10afc08, 0x11, 0xa, 0x1) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x2842fd4 sp=0x2842fc0 pc=0x98f9c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.goparkunlock(...) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.forcegchelper() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/proc.go:348 +0xe4 fp=0x2842fec sp=0x2842fd4 pc=0x5fd48 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x2842fec sp=0x2842fec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: created by runtime.init.6 in goroutine 1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/proc.go:336 +0x1c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: goroutine 3 gp=0x2802b48 m=nil [GC sweep wait]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.gopark(0xa3875c, 0x10b06a0, 0xc, 0x9, 0x1) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x28437c4 sp=0x28437b0 pc=0x98f9c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.goparkunlock(...) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.bgsweep(0x2868000) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/mgcsweep.go:276 +0xa8 fp=0x28437e4 sp=0x28437c4 pc=0x486bc Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.gcenable.gowrap1() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x28437ec sp=0x28437e4 pc=0x38238 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x28437ec sp=0x28437ec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: created by runtime.gcenable in goroutine 1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/mgc.go:204 +0x74 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: goroutine 4 gp=0x2802c68 m=nil [GC scavenge wait]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.gopark(0xa3875c, 0x10b12a8, 0xd, 0xa, 0x2) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x2843fb4 sp=0x2843fa0 pc=0x98f9c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.goparkunlock(...) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.(*scavengerState).park(0x10b12a8) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x2843fc8 sp=0x2843fb4 pc=0x45acc Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.bgscavenge(0x2868000) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/mgcscavenge.go:653 +0x3c fp=0x2843fe4 sp=0x2843fc8 pc=0x461d8 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.gcenable.gowrap2() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/mgc.go:205 +0x28 fp=0x2843fec sp=0x2843fe4 pc=0x381e4 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x2843fec sp=0x2843fec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: created by runtime.gcenable in goroutine 1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/mgc.go:205 +0xbc Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: goroutine 18 gp=0x2882488 m=nil [finalizer wait]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.gopark(0xa38608, 0x10bca60, 0x10, 0xa, 0x1) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x283e790 sp=0x283e77c pc=0x98f9c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.runfinq() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/mfinal.go:196 +0x110 fp=0x283e7ec sp=0x283e790 pc=0x36f4c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x283e7ec sp=0x283e7ec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: created by runtime.createfing in goroutine 1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1609]: /usr/local/go/src/runtime/mfinal.go:166 +0x5c Oct 13 18:22:28 volumio-kali systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Oct 13 18:22:28 volumio-kali systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 13 18:22:28 volumio-kali systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 3. Oct 13 18:22:28 volumio-kali systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 18:22:28 volumio-kali systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: unexpected fault address 0x271ee4 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: fatal error: fault Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: [signal SIGBUS: bus error code=0x2 addr=0x271ee4 pc=0x271ee4] Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: goroutine 1 gp=0x3402128 m=0 mp=0x10b27f0 [running, locked to thread]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.throw({0x9f0f76, 0x5}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/panic.go:1101 +0x34 fp=0x3450e58 sp=0x3450e44 pc=0x98e5c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.sigpanic() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/signal_unix.go:922 +0x104 fp=0x3450e88 sp=0x3450e58 pc=0x9b0d4 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: github.com/VolumioTeam/proto-repo/streaming-common/gen/go/streaming/common/v1.init() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: :1 fp=0x3450e8c sp=0x3450e8c pc=0x271ee4 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.doInit1(0x104b9d8) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/proc.go:7410 +0xcc fp=0x3450fa8 sp=0x3450e8c pc=0x7051c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.doInit(...) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/proc.go:7377 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.main() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/proc.go:254 +0x3ec fp=0x3450fec sp=0x3450fa8 pc=0x5f9dc Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x3450fec sp=0x3450fec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: goroutine 2 gp=0x34027e8 m=nil [force gc (idle)]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.gopark(0xa3875c, 0x10afc08, 0x11, 0xa, 0x1) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x3442fd4 sp=0x3442fc0 pc=0x98f9c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.goparkunlock(...) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.forcegchelper() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/proc.go:348 +0xe4 fp=0x3442fec sp=0x3442fd4 pc=0x5fd48 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x3442fec sp=0x3442fec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: created by runtime.init.6 in goroutine 1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/proc.go:336 +0x1c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: goroutine 3 gp=0x3402b48 m=nil [GC sweep wait]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.gopark(0xa3875c, 0x10b06a0, 0xc, 0x9, 0x1) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x34437c4 sp=0x34437b0 pc=0x98f9c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.goparkunlock(...) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.bgsweep(0x3468000) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/mgcsweep.go:276 +0xa8 fp=0x34437e4 sp=0x34437c4 pc=0x486bc Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.gcenable.gowrap1() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x34437ec sp=0x34437e4 pc=0x38238 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x34437ec sp=0x34437ec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: created by runtime.gcenable in goroutine 1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/mgc.go:204 +0x74 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: goroutine 4 gp=0x3402c68 m=nil [GC scavenge wait]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.gopark(0xa3875c, 0x10b12a8, 0xd, 0xa, 0x2) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x3443fb4 sp=0x3443fa0 pc=0x98f9c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.goparkunlock(...) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.(*scavengerState).park(0x10b12a8) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x3443fc8 sp=0x3443fb4 pc=0x45acc Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.bgscavenge(0x3468000) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/mgcscavenge.go:653 +0x3c fp=0x3443fe4 sp=0x3443fc8 pc=0x461d8 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.gcenable.gowrap2() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/mgc.go:205 +0x28 fp=0x3443fec sp=0x3443fe4 pc=0x381e4 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x3443fec sp=0x3443fec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: created by runtime.gcenable in goroutine 1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/mgc.go:205 +0xbc Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: goroutine 18 gp=0x3482488 m=nil [finalizer wait]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.gopark(0xa38608, 0x10bca60, 0x10, 0xa, 0x1) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x343e790 sp=0x343e77c pc=0x98f9c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.runfinq() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/mfinal.go:196 +0x110 fp=0x343e7ec sp=0x343e790 pc=0x36f4c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x343e7ec sp=0x343e7ec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: created by runtime.createfing in goroutine 1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1617]: /usr/local/go/src/runtime/mfinal.go:166 +0x5c Oct 13 18:22:28 volumio-kali systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Oct 13 18:22:28 volumio-kali systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 13 18:22:28 volumio-kali systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 4. Oct 13 18:22:28 volumio-kali systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 18:22:28 volumio-kali systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: unexpected fault address 0x271ee4 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: fatal error: fault Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: [signal SIGBUS: bus error code=0x2 addr=0x271ee4 pc=0x271ee4] Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: goroutine 1 gp=0x2c02128 m=0 mp=0x10b27f0 [running, locked to thread]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.throw({0x9f0f76, 0x5}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/panic.go:1101 +0x34 fp=0x2c50e58 sp=0x2c50e44 pc=0x98e5c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.sigpanic() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/signal_unix.go:922 +0x104 fp=0x2c50e88 sp=0x2c50e58 pc=0x9b0d4 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: github.com/VolumioTeam/proto-repo/streaming-common/gen/go/streaming/common/v1.init() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: :1 fp=0x2c50e8c sp=0x2c50e8c pc=0x271ee4 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.doInit1(0x104b9d8) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/proc.go:7410 +0xcc fp=0x2c50fa8 sp=0x2c50e8c pc=0x7051c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.doInit(...) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/proc.go:7377 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.main() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/proc.go:254 +0x3ec fp=0x2c50fec sp=0x2c50fa8 pc=0x5f9dc Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x2c50fec sp=0x2c50fec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: goroutine 2 gp=0x2c027e8 m=nil [force gc (idle)]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.gopark(0xa3875c, 0x10afc08, 0x11, 0xa, 0x1) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x2c42fd4 sp=0x2c42fc0 pc=0x98f9c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.goparkunlock(...) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.forcegchelper() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/proc.go:348 +0xe4 fp=0x2c42fec sp=0x2c42fd4 pc=0x5fd48 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x2c42fec sp=0x2c42fec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: created by runtime.init.6 in goroutine 1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/proc.go:336 +0x1c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: goroutine 3 gp=0x2c02b48 m=nil [GC sweep wait]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.gopark(0xa3875c, 0x10b06a0, 0xc, 0x9, 0x1) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x2c437c4 sp=0x2c437b0 pc=0x98f9c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.goparkunlock(...) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.bgsweep(0x2c68000) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/mgcsweep.go:276 +0xa8 fp=0x2c437e4 sp=0x2c437c4 pc=0x486bc Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.gcenable.gowrap1() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x2c437ec sp=0x2c437e4 pc=0x38238 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x2c437ec sp=0x2c437ec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: created by runtime.gcenable in goroutine 1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/mgc.go:204 +0x74 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: goroutine 4 gp=0x2c02c68 m=nil [GC scavenge wait]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.gopark(0xa3875c, 0x10b12a8, 0xd, 0xa, 0x2) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x2c43fb4 sp=0x2c43fa0 pc=0x98f9c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.goparkunlock(...) Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read data cache entry [694e05c] Oct 13 18:22:28 volumio-kali kernel: SQUASHFS error: Unable to read page, block 694e05c, size 59b1 Oct 13 18:22:28 volumio-kali systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/proc.go:441 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.(*scavengerState).park(0x10b12a8) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x2c43fc8 sp=0x2c43fb4 pc=0x45acc Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.bgscavenge(0x2c68000) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/mgcscavenge.go:653 +0x3c fp=0x2c43fe4 sp=0x2c43fc8 pc=0x461d8 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.gcenable.gowrap2() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/mgc.go:205 +0x28 fp=0x2c43fec sp=0x2c43fe4 pc=0x381e4 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x2c43fec sp=0x2c43fec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: created by runtime.gcenable in goroutine 1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/mgc.go:205 +0xbc Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: goroutine 18 gp=0x2d06248 m=nil [finalizer wait]: Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.gopark(0xa38608, 0x10bca60, 0x10, 0xa, 0x1) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/proc.go:435 +0x104 fp=0x2c3e790 sp=0x2c3e77c pc=0x98f9c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.runfinq() Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/mfinal.go:196 +0x110 fp=0x2c3e7ec sp=0x2c3e790 pc=0x36f4c Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: runtime.goexit({}) Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 fp=0x2c3e7ec sp=0x2c3e7ec pc=0xa0370 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: created by runtime.createfing in goroutine 1 Oct 13 18:22:28 volumio-kali volumio5-onboarding[1623]: /usr/local/go/src/runtime/mfinal.go:166 +0x5c Oct 13 18:22:28 volumio-kali systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 13 18:22:29 volumio-kali systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 5. Oct 13 18:22:29 volumio-kali systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 18:22:29 volumio-kali systemd[1]: volumio5-onboarding.service: Start request repeated too quickly. Oct 13 18:22:29 volumio-kali systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 13 18:22:29 volumio-kali systemd[1]: Failed to start volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 18:22:29 volumio-kali volumio[1237]: info: gpio-buttons: Started successfully Oct 13 18:22:39 volumio-kali mpd[1584]: 2026-10-13T18:22:39 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 13 18:22:39 volumio-kali volumio[1237]: info: AutoStart - Check #2/60 - VOLUMIO_SYSTEM_STATUS = starting Oct 13 18:22:39 volumio-kali systemd[1]: Started mpd.service - Music Player Daemon. Oct 13 18:22:39 volumio-kali sudo[1551]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:39 volumio-kali sudo[1564]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:39 volumio-kali volumio[1237]: info: MPD Permissions set Oct 13 18:22:39 volumio-kali volumio[1237]: info: MPD Permissions set Oct 13 18:22:40 volumio-kali volumio[1237]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 13 18:22:40 volumio-kali volumio[1237]: info: GPIOButtonLED: dtoverlay already correct Oct 13 18:22:40 volumio-kali volumio[1237]: info: GPIOButtonLED: LED+ on GPIO 22 Oct 13 18:22:40 volumio-kali volumio[1237]: info: GPIOButtonLED: LED- on GPIO 4 Oct 13 18:22:40 volumio-kali volumio[1237]: info: GPIOButtonLED: LED polarity = normal Oct 13 18:22:40 volumio-kali volumio[1237]: info: GPIOButtonLED: LED blink slow Oct 13 18:22:40 volumio-kali volumio[1237]: info: Completed starting Core Plugins Oct 13 18:22:40 volumio-kali volumio[1237]: info: ------------------------------------------- Oct 13 18:22:40 volumio-kali volumio[1237]: info: ----- MyVolumio plugins startup ---- Oct 13 18:22:40 volumio-kali volumio[1237]: info: ------------------------------------------- Oct 13 18:22:40 volumio-kali volumio[1237]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:40 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:41 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 18:22:41 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:22:41 volumio-kali volumio[1237]: error: MPD error: The expression evaluated to a falsy value: Oct 13 18:22:41 volumio-kali volumio[1237]: assert.ok(self.idling) Oct 13 18:22:41 volumio-kali volumio[1237]: error: The expression evaluated to a falsy value: Oct 13 18:22:41 volumio-kali volumio[1237]: assert.ok(self.idling) Oct 13 18:22:42 volumio-kali volumio[1237]: error: updateQueue error: null Oct 13 18:22:43 volumio-kali volumio[1237]: info: Volumio called home Oct 13 18:22:43 volumio-kali volumio[1237]: info: MPD running with PID1584 Oct 13 18:22:43 volumio-kali volumio[1237]: ,establishing connection Oct 13 18:22:43 volumio-kali volumio[1237]: info: GPIOButtonLED: Boot complete - LED solid Oct 13 18:22:44 volumio-kali volumio[1237]: info: Starting Shairport Sync Oct 13 18:22:44 volumio-kali volumio[1237]: info: Starting Shairport Sync Oct 13 18:22:44 volumio-kali volumio[1237]: info: Starting Shairport Sync Oct 13 18:22:44 volumio-kali sudo[1695]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 13 18:22:44 volumio-kali sudo[1695]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:44 volumio-kali volumio[1237]: error: updateQueue error: null Oct 13 18:22:44 volumio-kali sudo[1697]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 13 18:22:44 volumio-kali sudo[1697]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:44 volumio-kali sudo[1699]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 13 18:22:44 volumio-kali systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 13 18:22:44 volumio-kali systemd[1]: shairport-sync.service: Deactivated successfully. Oct 13 18:22:44 volumio-kali systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 13 18:22:44 volumio-kali systemd[1]: shairport-sync.service: Consumed 2.999s CPU time. Oct 13 18:22:44 volumio-kali sudo[1699]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 18:22:44 volumio-kali volumio[1237]: info: AutoStart - Check #3/60 - VOLUMIO_SYSTEM_STATUS = starting Oct 13 18:22:44 volumio-kali systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 13 18:22:44 volumio-kali sudo[1695]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:44 volumio-kali systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 13 18:22:44 volumio-kali systemd[1]: shairport-sync.service: Deactivated successfully. Oct 13 18:22:44 volumio-kali systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 13 18:22:45 volumio-kali systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 13 18:22:45 volumio-kali volumio[1237]: info: Shairport-Sync Started Oct 13 18:22:45 volumio-kali volumio[1237]: Error adding Membership: Error: addMembership EINVAL Oct 13 18:22:45 volumio-kali sudo[1697]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:45 volumio-kali systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 13 18:22:45 volumio-kali systemd[1]: shairport-sync.service: Deactivated successfully. Oct 13 18:22:45 volumio-kali systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 13 18:22:45 volumio-kali volumio[1237]: info: CoreCommandRouter::volumioGetState Oct 13 18:22:45 volumio-kali volumio[1237]: info: CorePlayQueue::getTrack 0 Oct 13 18:22:45 volumio-kali volumio[1237]: info: Shairport-Sync Started Oct 13 18:22:45 volumio-kali systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 13 18:22:45 volumio-kali sudo[1699]: pam_unix(sudo:session): session closed for user root Oct 13 18:22:45 volumio-kali volumio[1237]: info: Shairport-Sync Started Oct 13 18:22:53 volumio-kali volumio[1237]: info: AutoStart - Check #4/60 - VOLUMIO_SYSTEM_STATUS = starting Oct 13 18:23:09 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 18:23:09 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 18:23:09 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 13 18:23:10 volumio-kali volumio[1237]: info: AutoStart - Check #5/60 - VOLUMIO_SYSTEM_STATUS = starting Oct 13 18:23:10 volumio-kali volumio[1237]: error: MyVolumio Plugin failed to start in a timely fashion Oct 13 18:23:10 volumio-kali volumio[1237]: [Metrics] CommandRouter: 86s 371.57ms Oct 13 18:23:10 volumio-kali volumio[1237]: info: CoreCommandRouter::volumiosetStartupVolume Oct 13 18:23:10 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 18:23:10 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 18:23:10 volumio-kali volumio[1237]: info: CoreCommandRouter::Close All Modals sent Oct 13 18:23:10 volumio-kali volumio[1237]: info: CoreCommandRouter::Close All Modals sent Oct 13 18:23:11 volumio-kali kernel: voicehat-codec voicehat-codec: Enabling audio amp... Oct 13 18:23:16 volumio-kali kernel: voicehat-codec voicehat-codec: Disabling audio amp... Oct 13 18:23:17 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 13 18:23:17 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 13 18:23:17 volumio-kali volumio[1237]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 13 18:23:17 volumio-kali volumio[1237]: info: AutoStart - Check #6/60 - VOLUMIO_SYSTEM_STATUS = starting Oct 13 18:23:17 volumio-kali volumio[1237]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 18:23:17 volumio-kali volumio[1237]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals. Oct 13 18:23:17 volumio-kali volumio[1237]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues Oct 13 18:23:17 volumio-kali volumio[1237]: at new NodeError (node:internal/errors:405:5) Oct 13 18:23:17 volumio-kali volumio[1237]: at assert (node:internal/assert:14:11) Oct 13 18:23:17 volumio-kali volumio[1237]: at internalConnectMultiple (node:net:1118:3) Oct 13 18:23:17 volumio-kali volumio[1237]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Oct 13 18:23:17 volumio-kali volumio[1237]: at listOnTimeout (node:internal/timers:575:11) Oct 13 18:23:17 volumio-kali volumio[1237]: at process.processTimers (node:internal/timers:514:7) { Oct 13 18:23:17 volumio-kali volumio[1237]: code: 'ERR_INTERNAL_ASSERTION' Oct 13 18:23:17 volumio-kali volumio[1237]: } Oct 13 18:23:17 volumio-kali volumio[1237]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 18:23:28 volumio-kali sudo[1809]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 18:22' Oct 13 18:23:28 volumio-kali sudo[1809]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"