-- Logs begin at Thu 2019-02-14 07:11:58 -03, end at Thu 2025-12-25 13:51:11 -03. --
Dec 25 13:50:00 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Dec 25 13:50:00 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9
Dec 25 13:50:00 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:01 volumio volumio[1014]: info: peppy_screensaver: Start PeppyMeter
Dec 25 13:50:05 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Dec 25 13:50:05 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9
Dec 25 13:50:05 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:07 volumio go-librespot[1592]: time="2025-12-25T13:50:07-03:00" level=debug msg="fetched chunk 11/14, size: 524288" uri="spotify:track:1oERlssLrpssCAY6Yqqs6c"
Dec 25 13:50:07 volumio volumio[1014]: info: peppy_screensaver: Start PeppyMeter
Dec 25 13:50:09 volumio volumio[1014]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 25 13:50:09 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Dec 25 13:50:09 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Dec 25 13:50:09 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Dec 25 13:50:09 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
Dec 25 13:50:09 volumio volumio[1014]: info: Received Get System Version
Dec 25 13:50:09 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 25 13:50:10 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Dec 25 13:50:11 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9
Dec 25 13:50:11 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:13 volumio go-librespot[1592]: time="2025-12-25T13:50:13-03:00" level=debug msg="fetched chunk 14/14, size: 224064" uri="spotify:track:1oERlssLrpssCAY6Yqqs6c"
Dec 25 13:50:13 volumio volumio[1014]: info: peppy_screensaver: Start PeppyMeter
Dec 25 13:50:15 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Dec 25 13:50:15 volumio volumio[1014]: info: peppy_screensaver: Start PeppyMeter
Dec 25 13:50:16 volumio go-librespot[1592]: time="2025-12-25T13:50:16-03:00" level=trace msg="sent dealer ping"
Dec 25 13:50:16 volumio go-librespot[1592]: time="2025-12-25T13:50:16-03:00" level=trace msg="received dealer pong"
Dec 25 13:50:20 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Dec 25 13:50:20 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9
Dec 25 13:50:21 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:21 volumio ntpd[796]: Soliciting pool server 2606:4700:f1::1
Dec 25 13:50:22 volumio volumio[1014]: info: peppy_screensaver: Start PeppyMeter
Dec 25 13:50:25 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Dec 25 13:50:26 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9
Dec 25 13:50:26 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:26 volumio volumio[1014]: info: peppy_screensaver: Start PeppyMeter
Dec 25 13:50:28 volumio volumio-remote-updater[2270]: No test mode
Dec 25 13:50:28 volumio volumio-remote-updater[2270]: No alpha test mode
Dec 25 13:50:29 volumio volumio[1014]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Fix TIDAL low quality (AAC) playback
- Fix for DLNA Server discovery
- Fix for Plugins installation
NEW ADDITIONS
- BLE-based onboarding setup
- Update TIDAL SDK
","title":"Update v3.886","updateavailable":true}
Dec 25 13:50:29 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Dec 25 13:50:30 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Dec 25 13:50:31 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9
Dec 25 13:50:31 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:32 volumio volumio[1014]: info: peppy_screensaver: Start PeppyMeter
Dec 25 13:50:35 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Dec 25 13:50:36 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9
Dec 25 13:50:36 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:36 volumio go-librespot[1592]: time="2025-12-25T13:50:36-03:00" level=debug msg="prefetching next track" uri="spotify:track:7suB6D6uKX5DfPukdGaz0W"
Dec 25 13:50:36 volumio go-librespot[1592]: time="2025-12-25T13:50:36-03:00" level=debug msg="selected format OGG_VORBIS_320 (d95d8945cb2f3dce4f42abfaf03f639f4b95b017)" uri="spotify:track:7suB6D6uKX5DfPukdGaz0W"
Dec 25 13:50:36 volumio go-librespot[1592]: time="2025-12-25T13:50:36-03:00" level=debug msg="requested aes key for file d95d8945cb2f3dce4f42abfaf03f639f4b95b017, gid: 7suB6D6uKX5DfPukdGaz0W"
Dec 25 13:50:36 volumio go-librespot[1592]: time="2025-12-25T13:50:36-03:00" level=trace msg="found 2 cdn urls" uri="spotify:track:7suB6D6uKX5DfPukdGaz0W"
Dec 25 13:50:36 volumio go-librespot[1592]: time="2025-12-25T13:50:36-03:00" level=debug msg="fetched first chunk of 16, total size is 8280420 bytes" uri="spotify:track:7suB6D6uKX5DfPukdGaz0W"
Dec 25 13:50:37 volumio volumio[1014]: info: peppy_screensaver: Start PeppyMeter
Dec 25 13:50:37 volumio go-librespot[1592]: time="2025-12-25T13:50:37-03:00" level=debug msg="fetched chunk 1/15, size: 524288" uri="spotify:track:7suB6D6uKX5DfPukdGaz0W"
Dec 25 13:50:37 volumio go-librespot[1592]: time="2025-12-25T13:50:37-03:00" level=debug msg="fetched chunk 3/15, size: 524288" uri="spotify:track:7suB6D6uKX5DfPukdGaz0W"
Dec 25 13:50:37 volumio go-librespot[1592]: time="2025-12-25T13:50:37-03:00" level=debug msg="fetched chunk 2/15, size: 524288" uri="spotify:track:7suB6D6uKX5DfPukdGaz0W"
Dec 25 13:50:40 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Dec 25 13:50:40 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9
Dec 25 13:50:40 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:41 volumio volumio[1014]: info: peppy_screensaver: Start PeppyMeter
Dec 25 13:50:42 volumio volumio[1014]: info: CoreCommandRouter::Close All Modals sent
Dec 25 13:50:45 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Dec 25 13:50:45 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9
Dec 25 13:50:45 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:46 volumio go-librespot[1592]: time="2025-12-25T13:50:46-03:00" level=trace msg="sent dealer ping"
Dec 25 13:50:46 volumio go-librespot[1592]: time="2025-12-25T13:50:46-03:00" level=trace msg="received dealer pong"
Dec 25 13:50:50 volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.1.61:3000 from 192.168.1.23 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 25 13:50:50 volumio volumio[1014]: info: Discovery: Getting this device information
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 25 13:50:50 volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.1.61:3000 from 192.168.1.23 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 25 13:50:50 volumio volumio[1014]: info: Discovery: Getting this device information
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 25 13:50:50 volumio volumio[1014]: info: Discovery: Getting this device information
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 25 13:50:50 volumio volumio[1014]: info: Discovery: Getting this device information
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Dec 25 13:50:50 volumio sudo[7009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Dec 25 13:50:50 volumio sudo[7009]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 25 13:50:50 volumio sudo[7009]: pam_unix(sudo:session): session closed for user root
Dec 25 13:50:50 volumio sudo[7015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 25 13:50:50 volumio sudo[7015]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 25 13:50:50 volumio sudo[7015]: pam_unix(sudo:session): session closed for user root
Dec 25 13:50:50 volumio sudo[7023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 25 13:50:50 volumio sudo[7023]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 25 13:50:50 volumio sudo[7023]: pam_unix(sudo:session): session closed for user root
Dec 25 13:50:50 volumio sudo[7028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 25 13:50:50 volumio sudo[7028]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 25 13:50:50 volumio sudo[7028]: pam_unix(sudo:session): session closed for user root
Dec 25 13:50:50 volumio sudo[7034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 25 13:50:50 volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.1.61:3000 from 192.168.1.23 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11
Dec 25 13:50:50 volumio sudo[7034]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 25 13:50:50 volumio sudo[7034]: pam_unix(sudo:session): session closed for user root
Dec 25 13:50:50 volumio sudo[7037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 25 13:50:50 volumio sudo[7037]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 25 13:50:50 volumio sudo[7037]: pam_unix(sudo:session): session closed for user root
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 25 13:50:50 volumio volumio[1014]: info: Discovery: Getting this device information
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 25 13:50:50 volumio volumio[1014]: info: Discovery: Getting this device information
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:50 volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.1.61:3000 from 192.168.1.23 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 25 13:50:50 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 25 13:50:51 volumio wpa_supplicant[894]: wlan0: Associated with 22:53:83:d0:09:58
Dec 25 13:50:51 volumio dhcpcd[906]: wlan0: carrier lost
Dec 25 13:50:51 volumio wpa_supplicant[894]: wlan0: CTRL-EVENT-CONNECTED - Connection to 22:53:83:d0:09:58 completed [id=0 id_str=]
Dec 25 13:50:51 volumio wpa_supplicant[894]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Dec 25 13:50:51 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 25 13:50:51 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 25 13:50:51 volumio avahi-daemon[611]: Withdrawing address record for 192.168.1.61 on wlan0.
Dec 25 13:50:51 volumio avahi-daemon[611]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.61.
Dec 25 13:50:51 volumio dhcpcd[906]: wlan0: deleting route to 192.168.1.0/24
Dec 25 13:50:51 volumio dhcpcd[906]: wlan0: deleting default route via 192.168.1.1
Dec 25 13:50:51 volumio avahi-daemon[611]: Interface wlan0.IPv4 no longer relevant for mDNS.
Dec 25 13:50:51 volumio volumio[1014]: info: Discovery: A device disappeared from network
Dec 25 13:50:51 volumio volumio[1014]: info: Discovery: Device volumio disappeared from network
Dec 25 13:50:51 volumio dhcpcd[906]: wlan0: carrier acquired
Dec 25 13:50:51 volumio dhcpcd[906]: wlan0: IAID dd:21:ef:d9
Dec 25 13:50:52 volumio dhcpcd[906]: wlan0: rebinding lease of 192.168.1.61
Dec 25 13:50:52 volumio dhcpcd[906]: wlan0: probing address 192.168.1.61/24
Dec 25 13:50:52 volumio dhcpcd[906]: wlan0: soliciting an IPv6 router
Dec 25 13:50:53 volumio ntpd[796]: Deleting interface #19 wlan0, 192.168.1.61#123, interface stats: received=4, sent=4, dropped=0, active_time=59 secs
Dec 25 13:50:53 volumio ntpd[796]: 162.159.200.123 local addr 192.168.1.61 ->
Dec 25 13:50:53 volumio ntpd[796]: 170.210.222.10 local addr 192.168.1.61 ->
Dec 25 13:50:53 volumio ntpd[796]: 168.96.251.195 local addr 192.168.1.61 ->
Dec 25 13:50:53 volumio ntpd[796]: 162.159.200.1 local addr 192.168.1.61 ->
Dec 25 13:50:55 volumio volumio[1014]: info: Volumio Network Manager: Network status updated: 0
Dec 25 13:50:57 volumio dhcpcd[906]: wlan0: leased 192.168.1.61 for 86400 seconds
Dec 25 13:50:57 volumio avahi-daemon[611]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.61.
Dec 25 13:50:57 volumio dhcpcd[906]: wlan0: adding route to 192.168.1.0/24
Dec 25 13:50:57 volumio dhcpcd[906]: wlan0: adding default route via 192.168.1.1
Dec 25 13:50:57 volumio avahi-daemon[611]: New relevant interface wlan0.IPv4 for mDNS.
Dec 25 13:50:57 volumio avahi-daemon[611]: Registering new address record for 192.168.1.61 on wlan0.IPv4.
Dec 25 13:50:57 volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.1.61:3000 from 192.168.1.23 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11
Dec 25 13:50:57 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 25 13:50:57 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 25 13:50:57 volumio volumio[1014]: info: Discovery: Getting this device information
Dec 25 13:50:57 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:57 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 25 13:50:58 volumio volumio[1014]: info: Discovery: adding 4b167bfc-67cf-4862-b5bf-9a13a69fb0a7
Dec 25 13:50:58 volumio volumio[1014]: info: Discovery: Found device Volumio
Dec 25 13:50:58 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:58 volumio ntpd[796]: Listen normally on 20 wlan0 192.168.1.61:123
Dec 25 13:50:58 volumio ntpd[796]: new interface(s) found: waking up resolver
Dec 25 13:50:58 volumio sudo[7116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 25 13:50:58 volumio sudo[7116]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 25 13:50:58 volumio sudo[7116]: pam_unix(sudo:session): session closed for user root
Dec 25 13:50:58 volumio sudo[7119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 25 13:50:58 volumio sudo[7119]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 25 13:50:58 volumio sudo[7119]: pam_unix(sudo:session): session closed for user root
Dec 25 13:50:58 volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.1.61 from 192.168.1.23 UA: Mozilla/5.0 (Linux; Android 14; motorola edge 30 fusion Build/U1SJS34.2-92-10-9; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
Dec 25 13:50:58 volumio sudo[7135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 25 13:50:58 volumio sudo[7135]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 25 13:50:58 volumio sudo[7135]: pam_unix(sudo:session): session closed for user root
Dec 25 13:50:58 volumio sudo[7137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 25 13:50:58 volumio sudo[7137]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 25 13:50:58 volumio sudo[7137]: pam_unix(sudo:session): session closed for user root
Dec 25 13:50:58 volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.1.61 from 192.168.1.23 UA: Mozilla/5.0 (Linux; Android 14; motorola edge 30 fusion Build/U1SJS34.2-92-10-9; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12
Dec 25 13:50:58 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 25 13:50:58 volumio volumio[1014]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 25 13:50:58 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 25 13:50:58 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:58 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Dec 25 13:50:58 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 25 13:50:58 volumio volumio[1014]: info: Received Get System Info
Dec 25 13:50:58 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 25 13:50:58 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 25 13:50:58 volumio volumio[1014]: info: Discovery: Getting this device information
Dec 25 13:50:58 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:58 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 25 13:50:58 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:50:59 volumio volumio[1014]: info: Listing playlists
Dec 25 13:50:59 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 25 13:50:59 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 25 13:50:59 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Dec 25 13:51:00 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 25 13:51:00 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 25 13:51:00 volumio volumio[1014]: info: Discovery: Getting this device information
Dec 25 13:51:00 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:51:00 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 25 13:51:00 volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.1.61:3000 from 192.168.1.23 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 13
Dec 25 13:51:00 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 25 13:51:00 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 25 13:51:00 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Dec 25 13:51:00 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 25 13:51:00 volumio volumio[1014]: info: Received Get System Info
Dec 25 13:51:00 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 25 13:51:00 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 25 13:51:00 volumio volumio[1014]: info: Discovery: Getting this device information
Dec 25 13:51:00 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:51:00 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 25 13:51:01 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 25 13:51:01 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 25 13:51:02 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 25 13:51:02 volumio volumio[1014]: info: Received Get System Info
Dec 25 13:51:02 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 25 13:51:02 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 25 13:51:02 volumio volumio[1014]: info: Discovery: Getting this device information
Dec 25 13:51:02 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:51:02 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 25 13:51:04 volumio wpa_supplicant[894]: wlan0: Associated with 22:53:83:d0:09:54
Dec 25 13:51:04 volumio dhcpcd[906]: wlan0: carrier lost
Dec 25 13:51:04 volumio wpa_supplicant[894]: wlan0: CTRL-EVENT-CONNECTED - Connection to 22:53:83:d0:09:54 completed [id=0 id_str=]
Dec 25 13:51:04 volumio wpa_supplicant[894]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Dec 25 13:51:04 volumio avahi-daemon[611]: Withdrawing address record for 192.168.1.61 on wlan0.
Dec 25 13:51:04 volumio avahi-daemon[611]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.61.
Dec 25 13:51:04 volumio dhcpcd[906]: wlan0: deleting route to 192.168.1.0/24
Dec 25 13:51:04 volumio dhcpcd[906]: wlan0: deleting default route via 192.168.1.1
Dec 25 13:51:04 volumio avahi-daemon[611]: Interface wlan0.IPv4 no longer relevant for mDNS.
Dec 25 13:51:04 volumio volumio[1014]: info: Discovery: A device disappeared from network
Dec 25 13:51:04 volumio volumio[1014]: info: Discovery: Device volumio disappeared from network
Dec 25 13:51:04 volumio dhcpcd[906]: wlan0: carrier acquired
Dec 25 13:51:04 volumio dhcpcd[906]: wlan0: IAID dd:21:ef:d9
Dec 25 13:51:04 volumio dhcpcd[906]: wlan0: soliciting an IPv6 router
Dec 25 13:51:04 volumio dhcpcd[906]: wlan0: rebinding lease of 192.168.1.61
Dec 25 13:51:04 volumio dhcpcd[906]: wlan0: probing address 192.168.1.61/24
Dec 25 13:51:05 volumio ntpd[796]: Deleting interface #20 wlan0, 192.168.1.61#123, interface stats: received=4, sent=4, dropped=0, active_time=7 secs
Dec 25 13:51:05 volumio ntpd[796]: 162.159.200.123 local addr 192.168.1.61 ->
Dec 25 13:51:05 volumio ntpd[796]: 170.210.222.10 local addr 192.168.1.61 ->
Dec 25 13:51:05 volumio ntpd[796]: 168.96.251.195 local addr 192.168.1.61 ->
Dec 25 13:51:05 volumio ntpd[796]: 162.159.200.1 local addr 192.168.1.61 ->
Dec 25 13:51:09 volumio dhcpcd[906]: wlan0: leased 192.168.1.61 for 86400 seconds
Dec 25 13:51:09 volumio avahi-daemon[611]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.61.
Dec 25 13:51:09 volumio avahi-daemon[611]: New relevant interface wlan0.IPv4 for mDNS.
Dec 25 13:51:09 volumio avahi-daemon[611]: Registering new address record for 192.168.1.61 on wlan0.IPv4.
Dec 25 13:51:09 volumio dhcpcd[906]: wlan0: adding route to 192.168.1.0/24
Dec 25 13:51:09 volumio dhcpcd[906]: wlan0: adding default route via 192.168.1.1
Dec 25 13:51:10 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Dec 25 13:51:10 volumio go-librespot[1592]: time="2025-12-25T13:51:10-03:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF"
Dec 25 13:51:10 volumio volumio[1014]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify
Dec 25 13:51:10 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 25 13:51:10 volumio volumio[1014]: info: Disabling plugin spop
Dec 25 13:51:10 volumio volumio[1014]: info: Done.
Dec 25 13:51:10 volumio volumio[1014]: info: Connection to go-librespot Websocket closed
Dec 25 13:51:10 volumio sudo[7232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop go-librespot-daemon.service
Dec 25 13:51:10 volumio sudo[7232]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 25 13:51:10 volumio systemd[1]: Stopping go-librespot Daemon...
Dec 25 13:51:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Dec 25 13:51:10 volumio systemd[1]: go-librespot-daemon.service: Succeeded.
Dec 25 13:51:10 volumio systemd[1]: Stopped go-librespot Daemon.
Dec 25 13:51:10 volumio sudo[7232]: pam_unix(sudo:session): session closed for user root
Dec 25 13:51:10 volumio volumio[1014]: info: Discovery: adding 4b167bfc-67cf-4862-b5bf-9a13a69fb0a7
Dec 25 13:51:10 volumio volumio[1014]: info: Discovery: Found device Volumio
Dec 25 13:51:10 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState
Dec 25 13:51:11 volumio volumio[1014]: info: CoreStateMachine::stop
Dec 25 13:51:11 volumio volumio[1014]: info: CoreStateMachine::serviceStop
Dec 25 13:51:11 volumio volumio[1014]: info: CoreCommandRouter::serviceStop
Dec 25 13:51:11 volumio volumio[1014]: error: WARNING: No stop method for service spop
Dec 25 13:51:11 volumio volumio[1014]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 25 13:51:11 volumio volumio[1014]: TypeError: Cannot read property 'then' of undefined
Dec 25 13:51:11 volumio volumio[1014]: at peppyScreensaver.onStop (/data/plugins/user_interface/peppy_screensaver/index.js:243:43)
Dec 25 13:51:11 volumio volumio[1014]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Dec 25 13:51:11 volumio volumio[1014]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8)
Dec 25 13:51:11 volumio volumio[1014]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29)
Dec 25 13:51:11 volumio volumio[1014]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1412:47)
Dec 25 13:51:11 volumio volumio[1014]: at Socket.emit (events.js:315:20)
Dec 25 13:51:11 volumio volumio[1014]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Dec 25 13:51:11 volumio volumio[1014]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Dec 25 13:51:11 volumio volumio[1014]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 25 13:51:11 volumio ntpd[796]: Listen normally on 21 wlan0 192.168.1.61:123
Dec 25 13:51:11 volumio ntpd[796]: new interface(s) found: waking up resolver
Dec 25 13:51:11 volumio sudo[7247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-25 13:50
Dec 25 13:51:11 volumio sudo[7247]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET"
VOLUMIO_VERSION="3.874"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"