-- Logs begin at Thu 2019-02-14 17:11:59 +07, end at Sat 2025-06-21 19:38:42 +07. -- Jun 21 19:37:46 tu-mnnn systemd-timedated[1083]: Changed local time to Sat Jun 21 19:37:46 2025 Jun 21 19:37:46 tu-mnnn sudo[1081]: pam_unix(sudo:session): session closed for user root Jun 21 19:37:46 tu-mnnn volumio-time-update[493]: volumio-time-update-util: System time updated successfully. Jun 21 19:37:46 tu-mnnn volumio[827]: info: Discovery: A device disappeared from network Jun 21 19:37:46 tu-mnnn systemd[1]: Starting Daily apt download activities... Jun 21 19:37:46 tu-mnnn systemd[1]: Started Volumio Time Update Utility. Jun 21 19:37:46 tu-mnnn systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 19:37:46 tu-mnnn systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Jun 21 19:37:46 tu-mnnn systemd[1]: Stopped go-librespot Daemon. Jun 21 19:37:46 tu-mnnn systemd[1]: Started go-librespot Daemon. Jun 21 19:37:46 tu-mnnn systemd[1]: Reached target Multi-User System. Jun 21 19:37:46 tu-mnnn systemd[1]: Reached target Graphical Interface. Jun 21 19:37:46 tu-mnnn systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 21 19:37:46 tu-mnnn go-librespot[1086]: go-librespot daemon starting... Jun 21 19:37:46 tu-mnnn systemd[1]: Started Auto Shutdown on Low Battery. Jun 21 19:37:46 tu-mnnn go-librespot[1086]: time="2025-06-21T19:37:46+07:00" level=info msg="running go-librespot 0.2.0" Jun 21 19:37:46 tu-mnnn go-librespot[1086]: time="2025-06-21T19:37:46+07:00" level=debug msg="app state loaded" Jun 21 19:37:46 tu-mnnn systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 21 19:37:46 tu-mnnn systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 21 19:37:46 tu-mnnn go-librespot[1086]: time="2025-06-21T19:37:46+07:00" level=fatal msg="failed creating api server" error="failed starting api listener: listen tcp: lookup localhost: device or resource busy" Jun 21 19:37:46 tu-mnnn systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 19:37:46 tu-mnnn systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 19:37:46 tu-mnnn volumio[827]: info: Discovery: adding 46e2c356-0a40-49bf-acaf-600c3652359d Jun 21 19:37:46 tu-mnnn volumio[827]: info: Discovery: Found device Tuệ Mẫnnn Jun 21 19:37:46 tu-mnnn volumio[827]: info: CoreCommandRouter::volumioGetState Jun 21 19:37:46 tu-mnnn volumio[827]: info: CorePlayQueue::getTrack 0 Jun 21 19:37:46 tu-mnnn nmbd[631]: [2025/06/21 19:37:46.725392, 0] ../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Jun 21 19:37:46 tu-mnnn nmbd[631]: register_name_response: Answer name <00> differs from question name <00>. Jun 21 19:37:46 tu-mnnn nmbd[631]: [2025/06/21 19:37:46.726098, 0] ../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Jun 21 19:37:46 tu-mnnn nmbd[631]: register_name_response: Answer name <03> differs from question name <03>. Jun 21 19:37:46 tu-mnnn nmbd[631]: [2025/06/21 19:37:46.726785, 0] ../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Jun 21 19:37:46 tu-mnnn nmbd[631]: register_name_response: Answer name <20> differs from question name <20>. Jun 21 19:37:48 tu-mnnn volumio[827]: info: Initializing connection to go-librespot Websocket Jun 21 19:37:48 tu-mnnn volumio[827]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 21 19:37:48 tu-mnnn volumio[827]: SPOTIFY: User informations: {"country":"VN","display_name":"Mẫn Spotify","email":"huyhoang45636@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31cjvu4vq7fw7kumdldlg4t7323m"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/31cjvu4vq7fw7kumdldlg4t7323m","id":"31cjvu4vq7fw7kumdldlg4t7323m","images":[{"height":300,"url":"https://i.scdn.co/image/ab6775700000ee854ff0ad37d5e8b422183f65a1","width":300},{"height":64,"url":"https://i.scdn.co/image/ab67757000003b824ff0ad37d5e8b422183f65a1","width":64}],"product":"premium","type":"user","uri":"spotify:user:31cjvu4vq7fw7kumdldlg4t7323m"} Jun 21 19:37:48 tu-mnnn volumio[827]: info: Spotify Successfully logged in Jun 21 19:37:48 tu-mnnn volumio[827]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 21 19:37:48 tu-mnnn volumio[827]: info: [1750509468801] CoreMusicLibrary::Adding element Spotify Jun 21 19:37:48 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 21 19:37:48 tu-mnnn volumio[827]: Cannot find translation for source Spotify Jun 21 19:37:49 tu-mnnn systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 19:37:49 tu-mnnn systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Jun 21 19:37:49 tu-mnnn systemd[1]: Stopped go-librespot Daemon. Jun 21 19:37:49 tu-mnnn systemd[1]: Started go-librespot Daemon. Jun 21 19:37:49 tu-mnnn go-librespot[1115]: go-librespot daemon starting... Jun 21 19:37:49 tu-mnnn go-librespot[1115]: time="2025-06-21T19:37:49+07:00" level=info msg="running go-librespot 0.2.0" Jun 21 19:37:49 tu-mnnn go-librespot[1115]: time="2025-06-21T19:37:49+07:00" level=debug msg="app state loaded" Jun 21 19:37:49 tu-mnnn go-librespot[1115]: time="2025-06-21T19:37:49+07:00" level=fatal msg="failed creating api server" error="failed starting api listener: listen tcp: lookup localhost: device or resource busy" Jun 21 19:37:49 tu-mnnn systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 19:37:49 tu-mnnn systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 19:37:49 tu-mnnn systemd[1]: apt-daily.service: Succeeded. Jun 21 19:37:49 tu-mnnn systemd[1]: Started Daily apt download activities. Jun 21 19:37:49 tu-mnnn systemd[1]: Starting Daily apt upgrade and clean activities... Jun 21 19:37:50 tu-mnnn volumio[1076]: Generating RSA private key, 4096 bit long modulus (2 primes) Jun 21 19:37:52 tu-mnnn systemd[1]: apt-daily-upgrade.service: Succeeded. Jun 21 19:37:52 tu-mnnn systemd[1]: Started Daily apt upgrade and clean activities. Jun 21 19:37:52 tu-mnnn systemd[1]: Startup finished in 13.544s (kernel) + 44.861s (userspace) = 58.406s. Jun 21 19:37:52 tu-mnnn systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 19:37:52 tu-mnnn systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Jun 21 19:37:52 tu-mnnn systemd[1]: Stopped go-librespot Daemon. Jun 21 19:37:52 tu-mnnn systemd[1]: Started go-librespot Daemon. Jun 21 19:37:52 tu-mnnn go-librespot[1214]: go-librespot daemon starting... Jun 21 19:37:52 tu-mnnn go-librespot[1214]: time="2025-06-21T19:37:52+07:00" level=info msg="running go-librespot 0.2.0" Jun 21 19:37:52 tu-mnnn go-librespot[1214]: time="2025-06-21T19:37:52+07:00" level=debug msg="app state loaded" Jun 21 19:37:53 tu-mnnn volumio[827]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 19:37:55 tu-mnnn volumio[827]: info: New access token = BQCJd3PfX5WQhCD0BAsNdz1-RXtVGZo_q-_gf_wli80LRdeFcDQAamuqTmVVm24VQ3ijtJpLHQcbL040vF1SM24bHoV9XZoIuLQxGEUIfSFmMqlb8IiRtSsQdq-fUME52zEFB0qxicRuqpE0pn0Weck0mHRXX7AIW-Mlq2PNilppJLahRply52uV3X-Pc73kC0pXRIQYzU8oDLKYbrmneQ90gAVWYSxk_aKpfXdR7AXm6gj3HkCKT8j7E5SOT0csg_pzANMfcOFXLg3Tg9P31IlxNqsJcMD8Kz50SBlC_AYhEMng2XA Jun 21 19:37:55 tu-mnnn volumio[827]: info: New access token = BQBQGLgTBxHmrq_dWAJQTgfghrDNyL2pNrb2TlhOshGMpSnR9eWE5uM3Kirb96NyJnzmq3Zv02WsSb-FF-E6Rk3GeYi6g5yjsolAq4P-GDWe4-RUlVeFp1HWbcLBgdXrVkC7ltjkZkehjKhsJonj57TgZt72fYhE6j_Fxcrdv_b6ol8Tv8j-GgAkQnZgwrwcZS7SHe2PQSQnyUuzVYsOrCwBPlnNWWtUf66lNxQIzV9YSBiRDKOKhZxD_TxOuIEdsQ5y8FWSAb01IduZ8GzGF76kT1tI-Z6auVXQNxvZlU_sbxqJi1E Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 21 19:37:56 tu-mnnn volumio[827]: info: Adding plugin bluetooth to MyMusic Plugins Jun 21 19:37:56 tu-mnnn volumio[827]: info: Adding plugin multiroom to MyMusic Plugins Jun 21 19:37:56 tu-mnnn volumio[827]: info: Adding plugin metavolumio to MyMusic Plugins Jun 21 19:37:56 tu-mnnn volumio[827]: info: Adding plugin cd_controller to MyMusic Plugins Jun 21 19:37:56 tu-mnnn volumio[827]: info: Adding plugin qobuzconnect to MyMusic Plugins Jun 21 19:37:56 tu-mnnn volumio[827]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 21 19:37:56 tu-mnnn volumio[827]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 21 19:37:56 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 21 19:37:57 tu-mnnn go-librespot[1214]: time="2025-06-21T19:37:57+07:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 19:37:58 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 21 19:37:58 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 21 19:37:58 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:37:58 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:37:58 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:37:58 tu-mnnn volumio[827]: info: Starting MyVolumio Remote Streaming Endpoints Jun 21 19:37:58 tu-mnnn volumio[827]: info: MyVolumio login type: Token Jun 21 19:37:58 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 21 19:37:58 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 21 19:37:58 tu-mnnn volumio[1076]: ..................................................++++ Jun 21 19:37:59 tu-mnnn volumio[827]: info: Starting Streaming Service Transparent Proxy Jun 21 19:37:59 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 21 19:37:59 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 21 19:37:59 tu-mnnn volumio[827]: info: Streaming services startup Jun 21 19:37:59 tu-mnnn volumio[827]: info: Starting Streaming Daemon Jun 21 19:38:00 tu-mnnn sudo[1245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 21 19:38:00 tu-mnnn sudo[1245]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 19:38:00 tu-mnnn volumio[827]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 21 19:38:00 tu-mnnn volumio[827]: info: Initializing connection to go-librespot Websocket Jun 21 19:38:00 tu-mnnn sudo[1245]: pam_unix(sudo:session): session closed for user root Jun 21 19:38:00 tu-mnnn volumio[827]: error: Cannot start Volumio Streaming Daemon Jun 21 19:38:00 tu-mnnn volumio[827]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 21 19:38:00 tu-mnnn volumio[827]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 21 19:38:00 tu-mnnn volumio[827]: info: Error connecting to go-librespot Websocket: Error: getaddrinfo ENOTFOUND localhost Jun 21 19:38:00 tu-mnnn volumio[1076]: ........++++ Jun 21 19:38:00 tu-mnnn volumio[1076]: e is 65537 (0x010001) Jun 21 19:38:00 tu-mnnn volumio[1076]: writing RSA key Jun 21 19:38:02 tu-mnnn volumio[827]: STREAMING PROXY: Starting server on port 3245 Jun 21 19:38:02 tu-mnnn volumio[827]: Node JS runtime: 14 Jun 21 19:38:03 tu-mnnn volumio[827]: info: Initializing connection to go-librespot Websocket Jun 21 19:38:06 tu-mnnn volumio[827]: error: MyVolumio Custom Token format not valid, refreshing it Jun 21 19:38:07 tu-mnnn volumio[827]: info: New access token = BQAGpz26xiDSh8o7-AFUzjePoQ0n5VjdepFrHLwY1x-D0ZshkGzOFCXijGqbjH3quvwRZUWSS1ror4FGWQxCZHLDjutKkkG_E7St38eJUBZAO25A55-b3iuWykH3VUrBcAuRYBhiirAU1loIdo6Fx7nG0THYPOtIPpXAglH94krFdCsVMdEg0SenFh9ZR1Q0GU6yaL6zGS7Cp_yx7_GUqrFKFvu6-PLWmrSf3uWyH7-a5bc3JENvfN9eeyfXV3RQgINWA2Ssq8sH_ngjlcRm6QxcCPvWsolFoMeCqfzSKEbuI4-qOr4 Jun 21 19:38:08 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:08+07:00" level=debug msg="new websocket client" Jun 21 19:38:08 tu-mnnn volumio[827]: info: Connection to go-librespot Websocket established Jun 21 19:38:11 tu-mnnn volumio[827]: info: Getting Spotify volume Jun 21 19:38:11 tu-mnnn volumio[827]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 21 19:38:11 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:11 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 21 19:38:11 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:11 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 21 19:38:12 tu-mnnn volumiologrotate[506]: ls: cannot access '/var/log/samba/log.wb-TUỆ': No such file or directory Jun 21 19:38:12 tu-mnnn volumiologrotate[506]: ls: cannot access 'MẪNNN': No such file or directory Jun 21 19:38:13 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 21 19:38:13 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 21 19:38:13 tu-mnnn volumio-remote-updater[492]: No test mode Jun 21 19:38:13 tu-mnnn volumio-remote-updater[492]: No alpha test mode Jun 21 19:38:13 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:13+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Jun 21 19:38:13 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:13+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Jun 21 19:38:13 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:13+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Jun 21 19:38:13 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:13+07:00" level=info msg="zeroconf server listening on port 37471" Jun 21 19:38:14 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:14+07:00" level=debug msg="obtained new client token: AABKcE5AVQ752jI38dDXVNcuPmfUWvVQ3cgdGpQkNNAaeo3s9p/IC1ANaQGrhUPvnRJRO823Q+a3r5WeC6Ezw1p9Idy/DUK5yciF0VrMiW5kpYqHXX1gnlCadSiCNlrAy+b/G8iVMDy5b0u/+a4Fm2g7PWoM2noCYtAqMxt96LJvXnzYbJDAtk+vsOwHcyJr2xeGFptp3uLrSLLqCGA6UNQY64x4MQxPztmaD5m3vdvvAg+erGmEV+c=" Jun 21 19:38:14 tu-mnnn volumio[827]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 21 19:38:14 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 21 19:38:16 tu-mnnn systemd[1]: systemd-timedated.service: Succeeded. Jun 21 19:38:18 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 19:38:18 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 19:38:18 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 21 19:38:18 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 21 19:38:18 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 21 19:38:18 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 21 19:38:18 tu-mnnn volumio[827]: info: CoreCommandRouter::volumioGetBrowseSources Jun 21 19:38:18 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 21 19:38:19 tu-mnnn volumio[827]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jun 21 19:38:19 tu-mnnn volumio[827]: info: MyVolumio login type: Token Jun 21 19:38:20 tu-mnnn volumio[827]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jun 21 19:38:20 tu-mnnn volumio[827]: info: Completed starting MyVolumio Plugin Jun 21 19:38:20 tu-mnnn volumio[827]: [Metrics] CommandRouter: 49s 208.14ms Jun 21 19:38:20 tu-mnnn volumio[827]: info: CoreCommandRouter::volumiosetStartupVolume Jun 21 19:38:20 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 19:38:20 tu-mnnn volumio[827]: info: VolumeController:: Setting startup Volume 5 Jun 21 19:38:20 tu-mnnn volumio[827]: info: VolumeController::SetAlsaVolume5 Jun 21 19:38:20 tu-mnnn ntpd[633]: Soliciting pool server 103.188.82.179 Jun 21 19:38:20 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:20 tu-mnnn volumio[827]: info: CoreCommandRouter::Close All Modals sent Jun 21 19:38:20 tu-mnnn volumio[827]: info: CoreCommandRouter::Close All Modals sent Jun 21 19:38:20 tu-mnnn volumio[827]: info: CoreStateMachine::pushState Jun 21 19:38:20 tu-mnnn volumio[827]: info: CorePlayQueue::getTrack 0 Jun 21 19:38:20 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 19:38:20 tu-mnnn volumio[827]: info: CoreCommandRouter::volumioPushState Jun 21 19:38:20 tu-mnnn ntpd[633]: Soliciting pool server 103.184.124.254 Jun 21 19:38:21 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 21 19:38:21 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 21 19:38:21 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 21 19:38:21 tu-mnnn ntpd[633]: Soliciting pool server 103.70.115.65 Jun 21 19:38:22 tu-mnnn ntpd[633]: Soliciting pool server 103.184.124.254 Jun 21 19:38:24 tu-mnnn volumio[827]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 21 19:38:24 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:24+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Jun 21 19:38:24 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:24+07:00" level=debug msg="completed keyexchange" Jun 21 19:38:24 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:24+07:00" level=debug msg="completed challenge" Jun 21 19:38:24 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:24+07:00" level=info msg="authenticated AP as 31cjvu4vq7fw7kumdldlg4t7323m" Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=info msg="authenticated Login5 as 31cjvu4vq7fw7kumdldlg4t7323m" Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=debug msg="initializing zeroconf session, username: 31cjvu4vq7fw7kumdldlg4t7323m" Jun 21 19:38:25 tu-mnnn volumio[827]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=debug msg="dealer connection opened" Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=trace msg="starting accesspoint recv loop" Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=trace msg="starting dealer recv loop" Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=trace msg="received accesspoint ping" Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=debug msg="received connection id: YjYxNmZhZWUtYjcyZC00ZWU4LWJhMzUtMTVjNDczMDRjMjBmK2RlYWxlcit0Y3A6Ly8wYWM5NDg5YS5pcC5nYWUyLnNwb3RpZnkubmV0OjU3MDArOERFRUI5RTQ0QzUxMkNFNzE4ODZFN0VFRDAxMjZDQUU4RjkwMkVDOTEyQTU4MTIxMDgwMUNFOTI2NkZENjBFOQ==" Jun 21 19:38:25 tu-mnnn volumio[827]: info: Spotify volume: 100 Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=trace msg="received accesspoint pong ack" Jun 21 19:38:25 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:25+07:00" level=debug msg="put connect state because NEW_DEVICE" Jun 21 19:38:26 tu-mnnn volumio[827]: info: MyVolumio token set successfully Jun 21 19:38:26 tu-mnnn volumio[827]: info: MYVOLUMIO: Adding device Jun 21 19:38:26 tu-mnnn volumio[827]: info: MYVOLUMIO: Evaluating Server Jun 21 19:38:26 tu-mnnn volumio[827]: info: MyVolumio status changed Jun 21 19:38:26 tu-mnnn volumio[827]: info: Streaming services startup Jun 21 19:38:26 tu-mnnn volumio[827]: info: Starting Streaming Daemon Jun 21 19:38:27 tu-mnnn volumio[827]: info: Removing browser output: myVolumio user plan is not superstar Jun 21 19:38:27 tu-mnnn volumio[827]: info: Removing audio output: Jun 21 19:38:27 tu-mnnn volumio[827]: info: Stoppping Tunnel 1 Jun 21 19:38:27 tu-mnnn volumio[827]: info: BOOT COMPLETED Jun 21 19:38:27 tu-mnnn sudo[1395]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 21 19:38:27 tu-mnnn sudo[1397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jun 21 19:38:27 tu-mnnn sudo[1395]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 19:38:27 tu-mnnn sudo[1397]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 19:38:27 tu-mnnn sudo[1395]: pam_unix(sudo:session): session closed for user root Jun 21 19:38:27 tu-mnnn volumio[827]: error: Cannot start Volumio Streaming Daemon Jun 21 19:38:27 tu-mnnn volumio[827]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 21 19:38:27 tu-mnnn volumio[827]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 21 19:38:27 tu-mnnn volumio[827]: info: Setting Geolocation for MyVolumio to as1 Jun 21 19:38:27 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:27 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:27 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:27 tu-mnnn sudo[1397]: pam_unix(sudo:session): session closed for user root Jun 21 19:38:27 tu-mnnn volumio[827]: info: Remote SSH Stopped Jun 21 19:38:27 tu-mnnn volumio[827]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jun 21 19:38:28 tu-mnnn ntpd[633]: Soliciting pool server 27.71.27.209 Jun 21 19:38:29 tu-mnnn ntpd[633]: Soliciting pool server 115.165.161.155 Jun 21 19:38:29 tu-mnnn volumio[827]: info: Updating MyVolumio device info Jun 21 19:38:29 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:29 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:29 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:29 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:29 tu-mnnn volumio[827]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jun 21 19:38:29 tu-mnnn ntpd[633]: Soliciting pool server 103.199.19.135 Jun 21 19:38:32 tu-mnnn volumio[827]: info: MYVOLUMIO: Adding device Jun 21 19:38:32 tu-mnnn volumio[827]: info: MYVOLUMIO: Evaluating Server Jun 21 19:38:33 tu-mnnn volumio[827]: info: Setting Geolocation for MyVolumio to as1 Jun 21 19:38:33 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:33 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:33 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:33 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:34 tu-mnnn volumio[827]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jun 21 19:38:34 tu-mnnn volumio[827]: info: Updating MyVolumio device info Jun 21 19:38:34 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:34 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:34 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:34 tu-mnnn volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 19:38:34 tu-mnnn volumio[827]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jun 21 19:38:38 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:38+07:00" level=debug msg="handling transfer player command from 5f143e1c5ddcf5051c24ad5cb461168eb1341060" Jun 21 19:38:38 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:38+07:00" level=debug msg="resolved context of track" uri="spotify:album:6QiKfiJYI3BY4y5zZBV8tq" Jun 21 19:38:38 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:38+07:00" level=trace msg="fetched new page 0 with 3 items (list: 3)" uri="spotify:album:6QiKfiJYI3BY4y5zZBV8tq" Jun 21 19:38:38 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:38+07:00" level=debug msg="loading track (paused: true, position: 122793ms)" uri="spotify:track:7ouOcOLiD2Ts80DEmKSx7l" Jun 21 19:38:38 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:38+07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 21 19:38:38 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:38+07:00" level=trace msg="emitting websocket event: will_play" Jun 21 19:38:38 tu-mnnn volumio[827]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:7ouOcOLiD2Ts80DEmKSx7l","play_origin":"album"}} Jun 21 19:38:38 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:38+07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Jun 21 19:38:38 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:38+07:00" level=debug msg="selected format OGG_VORBIS_320 (c9dbe76de88b3da1f19289842be33783b8372aa6)" uri="spotify:track:7ouOcOLiD2Ts80DEmKSx7l" Jun 21 19:38:38 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:38+07:00" level=debug msg="requested aes key for file c9dbe76de88b3da1f19289842be33783b8372aa6, gid: 7ouOcOLiD2Ts80DEmKSx7l" Jun 21 19:38:38 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:38+07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1716" Jun 21 19:38:39 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:39+07:00" level=debug msg="fetched first chunk of 20, total size is 10467933 bytes" uri="spotify:track:7ouOcOLiD2Ts80DEmKSx7l" Jun 21 19:38:39 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:39+07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1305" Jun 21 19:38:39 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:39+07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 159" Jun 21 19:38:40 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:40+07:00" level=debug msg="fetched chunk 1/19, size: 524288" uri="spotify:track:7ouOcOLiD2Ts80DEmKSx7l" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="fetched chunk 9/19, size: 524288" uri="spotify:track:7ouOcOLiD2Ts80DEmKSx7l" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="fetched chunk 10/19, size: 524288" uri="spotify:track:7ouOcOLiD2Ts80DEmKSx7l" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="fetched chunk 3/19, size: 524288" uri="spotify:track:7ouOcOLiD2Ts80DEmKSx7l" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="fetched chunk 2/19, size: 524288" uri="spotify:track:7ouOcOLiD2Ts80DEmKSx7l" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="fetched chunk 8/19, size: 524288" uri="spotify:track:7ouOcOLiD2Ts80DEmKSx7l" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="fetched chunk 11/19, size: 524288" uri="spotify:track:7ouOcOLiD2Ts80DEmKSx7l" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=trace msg="seek to 122793ms (diff: 241ms, samples: 5415171, bytes: 4632065)" uri="spotify:track:7ouOcOLiD2Ts80DEmKSx7l" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="created new output device" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=info msg="loaded track \"hãy cho con chịu đau khổ thay em\" (paused: true, position: 122793ms, duration: 275348ms, prefetched: false)" uri="spotify:track:7ouOcOLiD2Ts80DEmKSx7l" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=trace msg="emitting websocket event: metadata" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=trace msg="emitting websocket event: active" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="sending successful reply for dealer request" Jun 21 19:38:41 tu-mnnn volumio[827]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:7ouOcOLiD2Ts80DEmKSx7l","name":"hãy cho con chịu đau khổ thay em","artist_names":["Lil Liem","Kewwi","KIDDI"],"album_name":"hãy cho con chịu đau khổ thay em","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02b9cdc50a38d454c8e64e1d12","position":122793,"duration":275348,"release_date":"year:2025 month:1 day:1","track_number":1,"disc_number":1}} Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 21 19:38:41 tu-mnnn volumio[827]: SPOTIFY: received: {"type":"active","data":null} Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="skipping dealer message" uri=playback-settings/content-settings-update Jun 21 19:38:41 tu-mnnn volumio[827]: info: Aligning Spotify Volume to Volumio Volume Jun 21 19:38:41 tu-mnnn volumio[827]: info: CoreCommandRouter::volumioGetState Jun 21 19:38:41 tu-mnnn volumio[827]: info: CorePlayQueue::getTrack 0 Jun 21 19:38:41 tu-mnnn volumio[827]: info: Setting Spotify Volume from Volumio: 5 Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 21 19:38:41 tu-mnnn go-librespot[1214]: time="2025-06-21T19:38:41+07:00" level=trace msg="emitting websocket event: paused" Jun 21 19:38:41 tu-mnnn volumio[827]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7ouOcOLiD2Ts80DEmKSx7l","play_origin":"album"}} Jun 21 19:38:41 tu-mnnn volumio[827]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 19:38:41 tu-mnnn volumio[827]: TypeError: Cannot read property 'service' of undefined Jun 21 19:38:41 tu-mnnn volumio[827]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:340:50) Jun 21 19:38:41 tu-mnnn volumio[827]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:274:18) Jun 21 19:38:41 tu-mnnn volumio[827]: at WebSocket.message (/data/plugins/music_service/spop/index.js:193:14) Jun 21 19:38:41 tu-mnnn volumio[827]: at WebSocket.emit (events.js:315:20) Jun 21 19:38:41 tu-mnnn volumio[827]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20) Jun 21 19:38:41 tu-mnnn volumio[827]: at Receiver.emit (events.js:315:20) Jun 21 19:38:41 tu-mnnn volumio[827]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) Jun 21 19:38:41 tu-mnnn volumio[827]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) Jun 21 19:38:41 tu-mnnn volumio[827]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) Jun 21 19:38:41 tu-mnnn volumio[827]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) Jun 21 19:38:41 tu-mnnn volumio[827]: at writeOrBuffer (internal/streams/writable.js:358:12) Jun 21 19:38:41 tu-mnnn volumio[827]: at Receiver.Writable.write (internal/streams/writable.js:303:10) Jun 21 19:38:41 tu-mnnn volumio[827]: at Socket.socketOnData (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1355:35) Jun 21 19:38:41 tu-mnnn volumio[827]: at Socket.emit (events.js:315:20) Jun 21 19:38:41 tu-mnnn volumio[827]: at addChunk (internal/streams/readable.js:309:12) Jun 21 19:38:41 tu-mnnn volumio[827]: at readableAddChunk (internal/streams/readable.js:284:9) Jun 21 19:38:41 tu-mnnn volumio[827]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 19:38:42 tu-mnnn sudo[1441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-21 19:37 Jun 21 19:38:42 tu-mnnn sudo[1441]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"