-- Logs begin at Mon 2025-09-22 17:24:46 UTC, end at Mon 2025-12-08 15:35:56 UTC. -- Dec 08 15:34:57 volumiow systemd[1]: Starting Daily apt download activities... Dec 08 15:34:58 volumiow systemd[1]: apt-daily.service: Succeeded. Dec 08 15:34:58 volumiow systemd[1]: Started Daily apt download activities. Dec 08 15:34:58 volumiow systemd[1]: Starting Daily apt upgrade and clean activities... Dec 08 15:34:58 volumiow systemd[1]: apt-daily-upgrade.service: Succeeded. Dec 08 15:34:58 volumiow systemd[1]: Started Daily apt upgrade and clean activities. Dec 08 15:34:59 volumiow volumio[897]: info: Getting Spotify volume Dec 08 15:34:59 volumiow volumio[897]: (node:897) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 15:34:59 volumiow volumio[897]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Dec 08 15:34:59 volumiow volumio[897]: (Use `node --trace-warnings ...` to show where the warning was created) Dec 08 15:34:59 volumiow volumio[897]: (node:897) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 2) Dec 08 15:34:59 volumiow volumio[897]: (node:897) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Dec 08 15:34:59 volumiow volumio[897]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Dec 08 15:34:59 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:34:59 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:34:59 volumiow volumio[897]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Dec 08 15:34:59 volumiow volumio[897]: SPOTIFY: SPOTIFY VOLUME undefined Dec 08 15:34:59 volumiow volumio[897]: SPOTIFY: VOLUMIO VOLUME 48 Dec 08 15:34:59 volumiow volumio[897]: info: Aligning Spotify Volume to Volumio Volume Dec 08 15:34:59 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:34:59 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:34:59 volumiow volumio[897]: info: Setting Spotify Volume from Volumio: 48 Dec 08 15:34:59 volumiow volumio[897]: info: Initializing connection to go-librespot Websocket Dec 08 15:34:59 volumiow volumio[897]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 15:35:00 volumiow systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 08 15:35:00 volumiow systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12. Dec 08 15:35:00 volumiow systemd[1]: Stopped go-librespot Daemon. Dec 08 15:35:00 volumiow systemd[1]: Started go-librespot Daemon. Dec 08 15:35:00 volumiow go-librespot[1243]: Librespot-go daemon starting... Dec 08 15:35:00 volumiow go-librespot[1243]: time="2025-12-08T15:35:00Z" level=info msg="generated new device id: c9fc7cb7a5accd5467e083490fc5d5c176b3d21d" Dec 08 15:35:00 volumiow go-librespot[1243]: time="2025-12-08T15:35:00Z" level=debug msg="stored credentials found for 7d0ril3to69yizprke08v8z2p" Dec 08 15:35:00 volumiow go-librespot[1243]: time="2025-12-08T15:35:00Z" level=debug msg="obtained new client token: AAB/UWmDFEgHDnjLKzoafDv/H/JPBbMOsLjGGba0ljB0Qif3OJ15qjeXojNZbshuA+kOBIWrmn3YIcCM+ypbqafhGkqisXTcX6SxWMB85wOTC3AcU8hcSmWQX7EFM74jVCXW/noV67plar2beGX57Wj5MryD987uUDKevNye3WIBxMt0NEGOUZRCvuGWPvRBO9yBEYXADP5gDXqWvEWWmuum+PSsAqGr6Y/ywnKaOBuwfQfNo08W9PoAOxQtDQ==" Dec 08 15:35:00 volumiow go-librespot[1243]: time="2025-12-08T15:35:00Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Dec 08 15:35:00 volumiow go-librespot[1243]: time="2025-12-08T15:35:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed performing keyexchange: failed reading APResponseMessage message: failed reading message length: read tcp 192.168.2.82:55302->34.158.1.133:4070: read: connection reset by peer" Dec 08 15:35:00 volumiow systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 15:35:00 volumiow systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 15:35:00 volumiow volumio[897]: info: Discovery: A device disappeared from network Dec 08 15:35:00 volumiow volumio[897]: info: Discovery: Device volumiow disappeared from network Dec 08 15:35:00 volumiow wpa_supplicant[769]: wlan0: Failed to initiate sched scan Dec 08 15:35:00 volumiow volumio[897]: info: Discovery: adding 6f0374ab-c5a0-4b49-988a-8c37cd489b30 Dec 08 15:35:00 volumiow volumio[897]: info: Discovery: Found device Volumiow Dec 08 15:35:00 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:00 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 08 15:35:01 volumiow volumio[897]: info: Adding plugin bluetooth to MyMusic Plugins Dec 08 15:35:01 volumiow volumio[897]: info: Adding plugin multiroom to MyMusic Plugins Dec 08 15:35:01 volumiow volumio[897]: info: Adding plugin metavolumio to MyMusic Plugins Dec 08 15:35:01 volumiow volumio[897]: info: Adding plugin cd_controller to MyMusic Plugins Dec 08 15:35:01 volumiow volumio[897]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 08 15:35:01 volumiow volumio[897]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 08 15:35:01 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:01 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:01 volumiow volumio[897]: info: Starting MyVolumio Remote Streaming Endpoints Dec 08 15:35:01 volumiow volumio[897]: info: MyVolumio login type: Token Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 08 15:35:01 volumiow volumio[897]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 08 15:35:02 volumiow volumio[897]: info: Starting Streaming Service Transparent Proxy Dec 08 15:35:02 volumiow volumio[897]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 08 15:35:02 volumiow volumio[897]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 08 15:35:02 volumiow volumio[897]: info: Streaming services startup Dec 08 15:35:02 volumiow volumio[897]: info: Starting Streaming Daemon Dec 08 15:35:02 volumiow sudo[1261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 08 15:35:02 volumiow sudo[1261]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 15:35:02 volumiow volumio[897]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Dec 08 15:35:02 volumiow sudo[1261]: pam_unix(sudo:session): session closed for user root Dec 08 15:35:03 volumiow volumio[897]: SPOTIFY: SETTING SPOTIFY VOLUME 48 Dec 08 15:35:03 volumiow volumio[897]: info: Sending Spotify command with payload to local API: /player/volume Dec 08 15:35:03 volumiow volumio[897]: info: Initializing connection to go-librespot Websocket Dec 08 15:35:03 volumiow volumio[897]: error: Failed to send command to Spotify local API: /player/volume: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 15:35:03 volumiow volumio[897]: error: Cannot start Volumio Streaming Daemon Dec 08 15:35:03 volumiow volumio[897]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 08 15:35:03 volumiow volumio[897]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 08 15:35:03 volumiow volumio[897]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 15:35:03 volumiow volumio[897]: error: MyVolumio Custom Token format not valid, refreshing it Dec 08 15:35:03 volumiow systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 08 15:35:03 volumiow systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13. Dec 08 15:35:03 volumiow systemd[1]: Stopped go-librespot Daemon. Dec 08 15:35:03 volumiow systemd[1]: Started go-librespot Daemon. Dec 08 15:35:03 volumiow volumio[897]: STREAMING PROXY: Starting server on port 3245 Dec 08 15:35:03 volumiow volumio[897]: Node JS runtime: 14 Dec 08 15:35:03 volumiow go-librespot[1268]: Librespot-go daemon starting... Dec 08 15:35:03 volumiow go-librespot[1268]: time="2025-12-08T15:35:03Z" level=info msg="generated new device id: 9437c07106b77f8b07917e371e44379f22b6d810" Dec 08 15:35:03 volumiow go-librespot[1268]: time="2025-12-08T15:35:03Z" level=debug msg="stored credentials found for 7d0ril3to69yizprke08v8z2p" Dec 08 15:35:03 volumiow go-librespot[1268]: time="2025-12-08T15:35:03Z" level=debug msg="obtained new client token: AAAJUExmbev64vHoq7kvIJmWY+ZIRuAp9mAx4JKoWyxYG4mUVwrzqQyRoGY3OuZu61wpp/QfW0zyrh/haB+FKwbua4Oy5rvVG1brRsjWGSmPMdlIsRkMBn0pSLa6PyMt8dX0u82xndcnxs/ZYUFbQ0G5K/94wFq93qXK1uVgL3KrgxmkPGwHROjR40SxyWniSlr4NCQtSq+gXXwufy/GPP6/tsqLM3rfpxlcDbKPWDSw5YTxgpMbgbU16aMu9xw3" Dec 08 15:35:03 volumiow go-librespot[1268]: time="2025-12-08T15:35:03Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Dec 08 15:35:03 volumiow go-librespot[1268]: time="2025-12-08T15:35:03Z" level=fatal msg="failed running with username and spotify token" error="failed initializing accesspoint: failed dialing accesspoint: dial tcp 34.158.1.133:4070: connect: connection refused" Dec 08 15:35:03 volumiow systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 15:35:03 volumiow systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 15:35:04 volumiow volumio[897]: info: MyVolumio login type: Token Dec 08 15:35:04 volumiow volumio[897]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 08 15:35:04 volumiow volumio[897]: info: MYVOLUMIO: Adding device Dec 08 15:35:04 volumiow volumio[897]: info: MYVOLUMIO: Evaluating Server Dec 08 15:35:04 volumiow volumio[897]: info: MyVolumio Plan changed: premium Dec 08 15:35:04 volumiow volumio[897]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Dec 08 15:35:04 volumiow volumio[897]: info: Removing browser output: myVolumio user plan is not superstar Dec 08 15:35:04 volumiow volumio[897]: info: Removing audio output: Dec 08 15:35:04 volumiow volumio[897]: info: MYVOLUMIO: Adding device Dec 08 15:35:04 volumiow volumio[897]: info: MYVOLUMIO: Evaluating Server Dec 08 15:35:04 volumiow volumio[897]: info: Remote config written successfully Dec 08 15:35:04 volumiow volumio[897]: info: Starting Tunnel 1 Dec 08 15:35:04 volumiow volumio[897]: info: Starting Tunnel Connection Checker Dec 08 15:35:05 volumiow volumio[897]: info: MYVolumio Device enabled Dec 08 15:35:05 volumiow volumio[897]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Dec 08 15:35:05 volumiow volumio[897]: info: MyVolumio status changed Dec 08 15:35:05 volumiow volumio[897]: info: Streaming services startup Dec 08 15:35:05 volumiow volumio[897]: info: Starting Streaming Daemon Dec 08 15:35:05 volumiow sudo[1313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 08 15:35:05 volumiow sudo[1313]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 15:35:05 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Dec 08 15:35:05 volumiow volumio[897]: error: [MyVolumio PluginManager] Cache data is invalid! Dec 08 15:35:05 volumiow sudo[1313]: pam_unix(sudo:session): session closed for user root Dec 08 15:35:05 volumiow volumio[897]: error: Cannot start Volumio Streaming Daemon Dec 08 15:35:05 volumiow volumio[897]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 08 15:35:05 volumiow volumio[897]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 08 15:35:05 volumiow volumio[897]: error: [MyVolumio PluginManager] Could not fetch plugin keys: {"success":false,"error":{"message":"Unauthenticated"}} Dec 08 15:35:06 volumiow volumio[897]: info: Initializing connection to go-librespot Websocket Dec 08 15:35:06 volumiow volumio[897]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 15:35:07 volumiow systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 08 15:35:07 volumiow systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14. Dec 08 15:35:07 volumiow systemd[1]: Stopped go-librespot Daemon. Dec 08 15:35:07 volumiow systemd[1]: Started go-librespot Daemon. Dec 08 15:35:07 volumiow go-librespot[1319]: Librespot-go daemon starting... Dec 08 15:35:07 volumiow go-librespot[1319]: time="2025-12-08T15:35:07Z" level=info msg="generated new device id: 426fd3d336286afaf0f843991ea2936c46b02ff9" Dec 08 15:35:07 volumiow go-librespot[1319]: time="2025-12-08T15:35:07Z" level=debug msg="stored credentials found for 7d0ril3to69yizprke08v8z2p" Dec 08 15:35:07 volumiow go-librespot[1319]: time="2025-12-08T15:35:07Z" level=debug msg="obtained new client token: AAAT+tGs+T/WQEj9PB52OKmYsZ+Spe1LGnJgcbsqRgZIcYJIheyZQ5YrHS+nCHcP43h0ZYUFehRoXgnYmXnuziTF6/tk0tcAlFpaDtdsiWB2PDmYJrafgAP3DZrF5Mp9ETp5Y8wd6QxeLz6cEnOJD8ZpnXONvsdX4wTW1Qn9KkwBhf8mDWLnGqnl3ou7hu2gLkHP/CUFYKeJaKid6RyOqsqHwuhvYUxM9OfPbxkF0AXWQw0C287crMSrh20DjA==" Dec 08 15:35:07 volumiow go-librespot[1319]: time="2025-12-08T15:35:07Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Dec 08 15:35:07 volumiow go-librespot[1319]: time="2025-12-08T15:35:07Z" level=debug msg="completed keyexchange" Dec 08 15:35:07 volumiow go-librespot[1319]: time="2025-12-08T15:35:07Z" level=debug msg="completed challenge" Dec 08 15:35:07 volumiow go-librespot[1319]: time="2025-12-08T15:35:07Z" level=debug msg="authenticated as 7d0ril3to69yizprke08v8z2p" Dec 08 15:35:08 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 08 15:35:08 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 08 15:35:08 volumiow volumio[897]: info: Discovery: Getting this device information Dec 08 15:35:08 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:08 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:08 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 08 15:35:08 volumiow volumio[897]: verbose: New Socket.io Connection to 192.168.2.82:3000 from 192.168.2.109 UA: Dart/3.9 (dart:io) Total Clients: 4 Dec 08 15:35:08 volumiow go-librespot[1319]: time="2025-12-08T15:35:08Z" level=debug msg="authenticated as 7d0ril3to69yizprke08v8z2p" Dec 08 15:35:08 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 08 15:35:08 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 08 15:35:08 volumiow go-librespot[1319]: time="2025-12-08T15:35:08Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Dec 08 15:35:08 volumiow volumio[897]: verbose: New Socket.io Connection to 192.168.2.82:3000 from 192.168.2.109 UA: Dart/3.9 (dart:io) Total Clients: 4 Dec 08 15:35:08 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 08 15:35:08 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 08 15:35:08 volumiow volumio[897]: info: Discovery: Getting this device information Dec 08 15:35:08 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:08 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:08 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 08 15:35:08 volumiow go-librespot[1319]: time="2025-12-08T15:35:08Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Dec 08 15:35:08 volumiow go-librespot[1319]: time="2025-12-08T15:35:08Z" level=debug msg="dealer connection opened" Dec 08 15:35:08 volumiow go-librespot[1319]: time="2025-12-08T15:35:08Z" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Dec 08 15:35:08 volumiow go-librespot[1319]: time="2025-12-08T15:35:08Z" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Dec 08 15:35:08 volumiow go-librespot[1319]: time="2025-12-08T15:35:08Z" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Dec 08 15:35:08 volumiow go-librespot[1319]: time="2025-12-08T15:35:08Z" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Dec 08 15:35:08 volumiow go-librespot[1319]: time="2025-12-08T15:35:08Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Dec 08 15:35:08 volumiow go-librespot[1319]: time="2025-12-08T15:35:08Z" level=debug msg="received connection id: NThlOTE0ZDYtZWJlOS00MmNlLTk4OWYtYWI4MGRlMTRkNjY3K2RlYWxlcit0Y3A6Ly8wYWIxNTBiYi5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArN0I5NDk0OTk1RUNFNjhDQzNGMjQ0RjhENTA5RkMzNkI4RUYzMEJGNzI2QjA1QzBEQjAyRDE2NUQwNUZCNEY1Ng==" Dec 08 15:35:08 volumiow wpa_supplicant[769]: wlan0: Failed to initiate sched scan Dec 08 15:35:08 volumiow go-librespot[1319]: time="2025-12-08T15:35:08Z" level=debug msg="put connect state because NEW_DEVICE" Dec 08 15:35:09 volumiow volumio[897]: info: Initializing connection to go-librespot Websocket Dec 08 15:35:09 volumiow go-librespot[1319]: time="2025-12-08T15:35:09Z" level=debug msg="new websocket client" Dec 08 15:35:09 volumiow volumio[897]: info: Connection to go-librespot Websocket established Dec 08 15:35:09 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 08 15:35:09 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 08 15:35:09 volumiow volumio[897]: info: Discovery: Getting this device information Dec 08 15:35:09 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:09 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:09 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 08 15:35:09 volumiow volumio[897]: verbose: New Socket.io Connection to 192.168.2.82:3000 from 192.168.2.109 UA: Dart/3.9 (dart:io) Total Clients: 5 Dec 08 15:35:09 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 08 15:35:09 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 08 15:35:10 volumiow sudo[1332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Dec 08 15:35:10 volumiow sudo[1332]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 15:35:10 volumiow systemd[1]: Started MyVolumio SSH Tunnel. Dec 08 15:35:10 volumiow sudo[1332]: pam_unix(sudo:session): session closed for user root Dec 08 15:35:10 volumiow volumio[897]: info: Remote SSH Started Dec 08 15:35:10 volumiow autossh[1335]: port set to 0, monitoring disabled Dec 08 15:35:10 volumiow autossh[1335]: starting ssh (count 1) Dec 08 15:35:10 volumiow autossh[1335]: ssh child pid is 1338 Dec 08 15:35:10 volumiow volumio[897]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5 Dec 08 15:35:10 volumiow volumio[897]: info: Setting Geolocation for MyVolumio to eu11 Dec 08 15:35:10 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:10 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:10 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:10 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:10 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:10 volumiow volumiossh-tunnel[1334]: Warning: Permanently added '[eu1.myvolumio.org]:2222,[68.183.69.189]:2222' (RSA) to the list of known hosts. Dec 08 15:35:10 volumiow volumio[897]: info: Setting Geolocation for MyVolumio to eu6 Dec 08 15:35:10 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:10 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:10 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:10 volumiow volumio[897]: info: Successfully Added MyVolumio device Dec 08 15:35:11 volumiow volumio[897]: info: Successfully Added MyVolumio device Dec 08 15:35:11 volumiow volumio[897]: info: Updating MyVolumio device info Dec 08 15:35:11 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:11 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:11 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:11 volumiow volumio[897]: info: Updating MyVolumio device info Dec 08 15:35:11 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:11 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:11 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 15:35:11 volumiow volumio[897]: info: Successfully Updated MyVolumio device Dec 08 15:35:12 volumiow volumio[897]: info: Getting Spotify volume Dec 08 15:35:12 volumiow volumio[897]: info: Successfully Updated MyVolumio device Dec 08 15:35:12 volumiow volumio[897]: info: Spotify volume: 100 Dec 08 15:35:12 volumiow volumio[897]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6 Dec 08 15:35:12 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:12 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:12 volumiow volumio[897]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Dec 08 15:35:12 volumiow volumio[897]: SPOTIFY: SPOTIFY VOLUME 100 Dec 08 15:35:12 volumiow volumio[897]: SPOTIFY: VOLUMIO VOLUME 48 Dec 08 15:35:12 volumiow volumio[897]: SPOTIFY: DELTA VOLUME ENOUGH: true Dec 08 15:35:12 volumiow volumio[897]: info: Setting Spotify Volume from Volumio: 48 Dec 08 15:35:13 volumiow volumio[897]: SPOTIFY: SETTING SPOTIFY VOLUME 48 Dec 08 15:35:13 volumiow volumio[897]: info: Sending Spotify command with payload to local API: /player/volume Dec 08 15:35:13 volumiow go-librespot[1319]: time="2025-12-08T15:35:13Z" level=debug msg="update volume to 31456/65535" Dec 08 15:35:13 volumiow go-librespot[1319]: time="2025-12-08T15:35:13Z" level=debug msg="put connect state because VOLUME_CHANGED" Dec 08 15:35:13 volumiow go-librespot[1319]: time="2025-12-08T15:35:13Z" level=trace msg="emitting websocket event: volume" Dec 08 15:35:13 volumiow volumio[897]: SPOTIFY: received: {"type":"volume","data":{"value":48,"max":100}} Dec 08 15:35:13 volumiow volumio[897]: SPOTIFY: RECEIVED SPOTIFY VOLUME 48 Dec 08 15:35:15 volumiow wpa_supplicant[769]: wlan0: Failed to initiate sched scan Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 08 15:35:16 volumiow volumio[897]: info: Discovery: Getting this device information Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:16 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 08 15:35:16 volumiow sudo[1340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 08 15:35:16 volumiow sudo[1340]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 15:35:16 volumiow sudo[1345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 08 15:35:16 volumiow sudo[1340]: pam_unix(sudo:session): session closed for user root Dec 08 15:35:16 volumiow sudo[1345]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 15:35:16 volumiow sudo[1345]: pam_unix(sudo:session): session closed for user root Dec 08 15:35:16 volumiow sudo[1354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 08 15:35:16 volumiow sudo[1354]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 15:35:16 volumiow sudo[1354]: pam_unix(sudo:session): session closed for user root Dec 08 15:35:16 volumiow sudo[1359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 08 15:35:16 volumiow sudo[1359]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 15:35:16 volumiow sudo[1359]: pam_unix(sudo:session): session closed for user root Dec 08 15:35:16 volumiow sudo[1365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 08 15:35:16 volumiow sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 15:35:16 volumiow sudo[1365]: pam_unix(sudo:session): session closed for user root Dec 08 15:35:16 volumiow sudo[1369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 08 15:35:16 volumiow sudo[1369]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 15:35:16 volumiow sudo[1369]: pam_unix(sudo:session): session closed for user root Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 08 15:35:16 volumiow volumio[897]: info: Discovery: Getting this device information Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:16 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 08 15:35:16 volumiow volumio[897]: info: Discovery: Getting this device information Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:16 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:16 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:16 volumiow volumio[897]: verbose: New Socket.io Connection to 192.168.2.82:3000 from 192.168.2.109 UA: Dart/3.9 (dart:io) Total Clients: 6 Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 08 15:35:16 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 08 15:35:16 volumiow volumio[897]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6 Dec 08 15:35:17 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:17 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:17 volumiow sudo[1372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 08 15:35:17 volumiow sudo[1372]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 15:35:17 volumiow sudo[1372]: pam_unix(sudo:session): session closed for user root Dec 08 15:35:17 volumiow sudo[1375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 08 15:35:17 volumiow sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 15:35:17 volumiow sudo[1375]: pam_unix(sudo:session): session closed for user root Dec 08 15:35:17 volumiow volumio[897]: verbose: New Socket.io Connection to 192.168.2.82 from 192.168.2.109 UA: Mozilla/5.0 (Linux; Android 16; Pixel 8a Build/BP3A.251105.015; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.171 Mobile Safari/537.36 Total Clients: 7 Dec 08 15:35:18 volumiow sudo[1378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 08 15:35:18 volumiow sudo[1378]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 15:35:18 volumiow sudo[1378]: pam_unix(sudo:session): session closed for user root Dec 08 15:35:18 volumiow sudo[1381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 08 15:35:18 volumiow sudo[1381]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 15:35:18 volumiow sudo[1381]: pam_unix(sudo:session): session closed for user root Dec 08 15:35:18 volumiow volumio[897]: verbose: New Socket.io Connection to 192.168.2.82 from 192.168.2.109 UA: Mozilla/5.0 (Linux; Android 16; Pixel 8a Build/BP3A.251105.015; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.171 Mobile Safari/537.36 Total Clients: 8 Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::volumioGetVisibleSources Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:18 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 08 15:35:18 volumiow volumio[897]: info: Received Get System Info Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 08 15:35:18 volumiow volumio[897]: info: Discovery: Getting this device information Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:18 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:18 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:18 volumiow volumio[897]: info: Listing playlists Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 08 15:35:18 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 08 15:35:20 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 08 15:35:20 volumiow volumio[897]: info: Received Get System Info Dec 08 15:35:20 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 08 15:35:20 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 08 15:35:20 volumiow volumio[897]: info: Discovery: Getting this device information Dec 08 15:35:20 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:20 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:20 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 08 15:35:20 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 08 15:35:21 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 15:35:21 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 15:35:21 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Dec 08 15:35:21 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Dec 08 15:35:21 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 08 15:35:21 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 08 15:35:21 volumiow volumio[897]: info: CoreCommandRouter::volumioGetBrowseSources Dec 08 15:35:21 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 08 15:35:23 volumiow wpa_supplicant[769]: wlan0: Failed to initiate sched scan Dec 08 15:35:24 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 08 15:35:24 volumiow volumio[897]: info: Received Get System Info Dec 08 15:35:24 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 08 15:35:24 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 08 15:35:24 volumiow volumio[897]: info: Discovery: Getting this device information Dec 08 15:35:24 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:24 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:24 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 08 15:35:29 volumiow volumio[897]: info: CoreCommandRouter::volumioGetQueue Dec 08 15:35:29 volumiow volumio[897]: info: CoreStateMachine::getQueue Dec 08 15:35:29 volumiow volumio[897]: info: CorePlayQueue::getQueue Dec 08 15:35:31 volumiow wpa_supplicant[769]: wlan0: Failed to initiate sched scan Dec 08 15:35:36 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 08 15:35:36 volumiow volumio[897]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 08 15:35:36 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 08 15:35:36 volumiow volumio[897]: info: Received Get System Version Dec 08 15:35:36 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 08 15:35:36 volumiow volumio[897]: info: Received Get System Info Dec 08 15:35:36 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 08 15:35:36 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 08 15:35:36 volumiow volumio[897]: info: Discovery: Getting this device information Dec 08 15:35:36 volumiow volumio[897]: info: CoreCommandRouter::volumioGetState Dec 08 15:35:36 volumiow volumio[897]: info: CorePlayQueue::getTrack 0 Dec 08 15:35:36 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 08 15:35:38 volumiow wpa_supplicant[769]: wlan0: Failed to initiate sched scan Dec 08 15:35:46 volumiow wpa_supplicant[769]: wlan0: Failed to initiate sched scan Dec 08 15:35:53 volumiow wpa_supplicant[769]: wlan0: Failed to initiate sched scan Dec 08 15:35:56 volumiow volumio[897]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Dec 08 15:35:56 volumiow volumio[897]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 08 15:35:56 volumiow volumio[897]: TypeError: Cannot read property 'then' of undefined Dec 08 15:35:56 volumiow volumio[897]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:470:20) Dec 08 15:35:56 volumiow volumio[897]: at Socket.emit (events.js:315:20) Dec 08 15:35:56 volumiow volumio[897]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 08 15:35:56 volumiow volumio[897]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Dec 08 15:35:56 volumiow volumio[897]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 08 15:35:56 volumiow sudo[1393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-08 15:34 Dec 08 15:35:56 volumiow sudo[1393]: 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="cd8cf34b47ce852e70b71e6f7b6e0265f7fdb695" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="8f88153f9a18f312d56050e6613b45a852ac819a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 27 Sep 2023 11:35:49 AM CEST" VOLUMIO_VERSION="3.546" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6823c0d83061ff736b7e0dd4481bc496"