-- Logs begin at Sun 2025-11-23 17:27:54 UTC, end at Mon 2025-12-15 16:09:09 UTC. -- Dec 15 16:08:55 opera systemd[1]: Time has been changed Dec 15 16:08:56 opera volumio[1290]: info: Loading plugin "volspotconnect2"... Dec 15 16:08:56 opera volumio[1290]: info: Loading plugin "updater_comm"... Dec 15 16:08:56 opera volumio[1290]: info: Plugin mpdemulation is not enabled Dec 15 16:08:56 opera volumio[1290]: info: Loading plugin "rest_api"... Dec 15 16:08:56 opera volumio[1290]: info: Loading plugin "websocket"... Dec 15 16:08:56 opera volumio[1290]: info: Loading plugin "spop"... Dec 15 16:08:57 opera volumio[1290]: info: ___________ START PLUGINS ___________ Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 15 16:08:57 opera volumio[1290]: info: [1765814937533] CoreMusicLibrary::Adding element Media Servers Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 15 16:08:57 opera volumio[1290]: info: Adding METAVOLUMIO REST API Endpoints Dec 15 16:08:57 opera volumio[1290]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Dec 15 16:08:57 opera sudo[1527]: pam_unix(sudo:auth): conversation failed Dec 15 16:08:57 opera sudo[1527]: pam_unix(sudo:auth): auth could not identify password for [volumio] Dec 15 16:08:57 opera volumio[1290]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 15 16:08:57 opera volumio[1290]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 15 16:08:57 opera volumio[1290]: info: Preparing CD Folders Dec 15 16:08:57 opera volumio[1290]: info: Adding CD REST API Endpoints Dec 15 16:08:57 opera volumio[1290]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Dec 15 16:08:57 opera volumio[1290]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Dec 15 16:08:57 opera volumio[1290]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Dec 15 16:08:57 opera volumio[1290]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 15 16:08:57 opera volumio[1290]: info: Detecting CD presence with Flag file Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 15 16:08:57 opera volumio[1290]: info: [1765814937631] CoreMusicLibrary::Adding element Last_100 Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 15 16:08:57 opera volumio[1290]: info: Starting RAAT Plugin Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Dec 15 16:08:57 opera volumio[1290]: info: Additional UI Settings Added for plugin music_service/raat Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: Not Reporting Auto name since its the default one Dec 15 16:08:57 opera volumio[1290]: info: Streaming services startup Dec 15 16:08:57 opera volumio[1290]: info: Starting Streaming Daemon Dec 15 16:08:57 opera sudo[1544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 15 16:08:57 opera sudo[1544]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:08:57 opera systemd[1]: Stopping Volumio Streaming Daemon... Dec 15 16:08:57 opera systemd[1]: Starting Volumio Streaming Daemon... Dec 15 16:08:57 opera systemd[1]: Started Volumio Streaming Daemon. Dec 15 16:08:57 opera sudo[1544]: pam_unix(sudo:session): session closed for user root Dec 15 16:08:57 opera volumio-streaming-daemon[1553]: ############################ Dec 15 16:08:57 opera volumio-streaming-daemon[1553]: # Volumio Streaming Daemon # Dec 15 16:08:57 opera volumio-streaming-daemon[1553]: # Running on port 7777 # Dec 15 16:08:57 opera volumio-streaming-daemon[1553]: ############################ Dec 15 16:08:57 opera volumio-streaming-daemon[1553]: Checking variant in static cache Dec 15 16:08:57 opera volumio-streaming-daemon[1553]: Enabled services: Dec 15 16:08:57 opera volumio-streaming-daemon[1553]: 1) tidal Dec 15 16:08:57 opera volumio-streaming-daemon[1553]: 2) qobuz Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 15 16:08:57 opera volumio[1290]: info: [1765814937724] CoreMusicLibrary::Adding element Webradio Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 15 16:08:57 opera volumio[1290]: error: Hi Res Audio Failed Login: Missing Login Data Dec 15 16:08:57 opera sudo[1566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Dec 15 16:08:57 opera sudo[1566]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:08:57 opera systemd[1]: Starting Volspotconnect2 Daemon... Dec 15 16:08:57 opera systemd[1]: Started Volspotconnect2 Daemon. Dec 15 16:08:57 opera sudo[1566]: pam_unix(sudo:session): session closed for user root Dec 15 16:08:57 opera volumio[1571]: /bin/bash: /tmp/startconnect.sh: No such file or directory Dec 15 16:08:57 opera systemd[1]: volspotconnect2.service: main process exited, code=exited, status=127/n/a Dec 15 16:08:57 opera systemd[1]: Unit volspotconnect2.service entered failed state. Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 15 16:08:57 opera volumio[1290]: [SpotifyConnect] Creating VLS config file Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:08:57 opera volumio[1290]: [SpotifyConnect] Starting metadata listener Dec 15 16:08:57 opera sudo[1578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Dec 15 16:08:57 opera sudo[1578]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:08:57 opera sudo[1578]: pam_unix(sudo:session): session closed for user root Dec 15 16:08:57 opera volumio[1290]: info: Loading i18n strings for locale en Dec 15 16:08:57 opera sudo[1582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Dec 15 16:08:57 opera volumio[1290]: Updating browse sources language Dec 15 16:08:57 opera volumio[1290]: Cannot find translation for sourceMedia Servers Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 15 16:08:57 opera sudo[1582]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:08:57 opera systemd[1]: Starting Volspotconnect2 Daemon... Dec 15 16:08:57 opera systemd[1]: Started Volspotconnect2 Daemon. Dec 15 16:08:57 opera sudo[1582]: pam_unix(sudo:session): session closed for user root Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::initPlayerControls Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 15 16:08:57 opera volumio[1290]: info: BOOT COMPLETED Dec 15 16:08:57 opera volumio[1290]: [Metrics] CommandRouter: 10s 364.27ms Dec 15 16:08:57 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 15 16:08:57 opera volumio[1592]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Dec 15 16:08:57 opera volumio[1592]: Reading Config from "/tmp/volspotify.toml" Dec 15 16:08:57 opera volumio[1592]: Malformed config key: missing field `Authentication` Dec 15 16:08:59 opera dhcpcd[1248]: wlan0: leased 192.168.0.101 for 7200 seconds Dec 15 16:08:59 opera avahi-daemon[1414]: Registering new address record for 192.168.0.101 on wlan0.IPv4. Dec 15 16:08:59 opera avahi-daemon[1414]: Withdrawing address record for 169.254.148.47 on wlan0. Dec 15 16:08:59 opera avahi-daemon[1414]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.148.47. Dec 15 16:08:59 opera avahi-daemon[1414]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.101. Dec 15 16:08:59 opera dhcpcd[1248]: eth0: adding route to 192.168.1.0/24 Dec 15 16:08:59 opera dhcpcd[1248]: eth0: adding default route via 192.168.1.1 Dec 15 16:08:59 opera dhcpcd[1248]: wlan0: adding host route to 192.168.0.101 via 127.0.0.1 Dec 15 16:08:59 opera dhcpcd[1248]: wlan0: adding route to 192.168.0.0/24 Dec 15 16:08:59 opera dhcpcd[1248]: wlan0: adding default route via 192.168.0.1 Dec 15 16:08:59 opera dhcpcd[1248]: wlan0: deleting host route to 169.254.148.47 via 127.0.0.1 Dec 15 16:08:59 opera dhcpcd[1248]: wlan0: deleting route to 169.254.0.0/16 Dec 15 16:08:59 opera dhcpcd[1248]: eth0: removing route to 192.168.1.0/24 Dec 15 16:08:59 opera dhcpcd[1248]: eth0: removing default route via 192.168.1.1 Dec 15 16:09:00 opera systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Dec 15 16:09:00 opera systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Dec 15 16:09:00 opera systemd[1]: Stopping Volspotconnect2 Daemon... Dec 15 16:09:00 opera systemd[1]: Starting Volspotconnect2 Daemon... Dec 15 16:09:00 opera systemd[1]: Started Volspotconnect2 Daemon. Dec 15 16:09:00 opera systemd[1]: Stopping Volspotconnect2 Daemon... Dec 15 16:09:00 opera systemd[1]: Starting Volspotconnect2 Daemon... Dec 15 16:09:00 opera systemd[1]: Started Volspotconnect2 Daemon. Dec 15 16:09:00 opera volumio[1626]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Dec 15 16:09:00 opera volumio[1626]: Reading Config from "/tmp/volspotify.toml" Dec 15 16:09:00 opera volumio[1625]: /bin/bash: /tmp/startconnect.sh: No such file or directory Dec 15 16:09:00 opera volumio[1626]: Malformed config key: missing field `Authentication` Dec 15 16:09:00 opera systemd[1]: volspotconnect2.service: main process exited, code=exited, status=127/n/a Dec 15 16:09:00 opera systemd[1]: Unit volspotconnect2.service entered failed state. Dec 15 16:09:00 opera ntpd[794]: Listen normally on 5 wlan0 192.168.0.101 UDP 123 Dec 15 16:09:00 opera ntpd[794]: Deleting interface #4 wlan0, 169.254.148.47#123, interface stats: received=0, sent=0, dropped=0, active_time=14 secs Dec 15 16:09:00 opera ntpd[794]: peers refreshed Dec 15 16:09:00 opera nmbd[1001]: [2025/12/15 16:09:00.763924, 0] ../source3/libsmb/nmblib.c:873(send_udp) Dec 15 16:09:00 opera nmbd[1001]: Packet send failed to 169.254.255.255(138) ERRNO=Invalid argument Dec 15 16:09:02 opera systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Dec 15 16:09:02 opera systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Dec 15 16:09:02 opera systemd[1]: Stopping Volspotconnect2 Daemon... Dec 15 16:09:02 opera systemd[1]: Starting Volspotconnect2 Daemon... Dec 15 16:09:02 opera systemd[1]: Started Volspotconnect2 Daemon. Dec 15 16:09:02 opera systemd[1]: Stopping Volspotconnect2 Daemon... Dec 15 16:09:02 opera systemd[1]: Starting Volspotconnect2 Daemon... Dec 15 16:09:02 opera systemd[1]: Started Volspotconnect2 Daemon. Dec 15 16:09:02 opera volumio[1633]: /bin/bash: /tmp/startconnect.sh: No such file or directory Dec 15 16:09:02 opera systemd[1]: volspotconnect2.service: main process exited, code=exited, status=127/n/a Dec 15 16:09:02 opera systemd[1]: Unit volspotconnect2.service entered failed state. Dec 15 16:09:02 opera volumio[1632]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Dec 15 16:09:02 opera volumio[1632]: Reading Config from "/tmp/volspotify.toml" Dec 15 16:09:02 opera volumio[1632]: Malformed config key: missing field `Authentication` Dec 15 16:09:03 opera volumio[1290]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 15 16:09:03 opera volumio[1290]: info: CoreCommandRouter::Close All Modals sent Dec 15 16:09:03 opera volumio[1290]: info: CoreCommandRouter::Close All Modals sent Dec 15 16:09:03 opera volumio[1290]: Express server listening on port 3000 Dec 15 16:09:03 opera volumio[1290]: [Metrics] WebUI: 16s 384.61ms Dec 15 16:09:03 opera volumio[1290]: Volumio Calling Home Dec 15 16:09:03 opera volumio[1290]: info: CoreStateMachine::resetVolumioState Dec 15 16:09:03 opera volumio[1290]: info: CoreStateMachine::getcurrentVolume Dec 15 16:09:03 opera volumio[1290]: info: CoreCommandRouter::volumioRetrievevolume Dec 15 16:09:03 opera volumio[1290]: info: Stopping AccessToken refresher cron for QOBUZ Dec 15 16:09:03 opera volumio[1290]: info: AccessToken refresher cron started for QOBUZ Dec 15 16:09:03 opera volumio[1290]: info: Stopping AccessToken refresher cron Dec 15 16:09:03 opera volumio[1290]: info: AccessToken refresher cron started Dec 15 16:09:03 opera volumio[1290]: info: CoreStateMachine::pushState Dec 15 16:09:03 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:03 opera volumio[1290]: info: CoreCommandRouter::volumioPushState Dec 15 16:09:03 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 16:09:03 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 15 16:09:03 opera sudo[1647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 15 16:09:03 opera sudo[1647]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:09:03 opera sudo[1647]: pam_unix(sudo:session): session closed for user root Dec 15 16:09:03 opera sudo[1649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 15 16:09:03 opera sudo[1649]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:09:03 opera sudo[1649]: pam_unix(sudo:session): session closed for user root Dec 15 16:09:03 opera sudo[1659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Dec 15 16:09:03 opera sudo[1659]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:09:03 opera systemd[1]: Configuration file /lib/systemd/system/volumiobt.service is marked executable. Please remove executable permission bits. Proceeding anyway. Dec 15 16:09:03 opera systemd[1]: Starting Volumio Bluetooth Module... Dec 15 16:09:03 opera systemd[1]: Started Volumio Bluetooth Module. Dec 15 16:09:03 opera volumio[1290]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 15 16:09:03 opera sudo[1659]: pam_unix(sudo:session): session closed for user root Dec 15 16:09:03 opera sudo[1675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Dec 15 16:09:03 opera sudo[1675]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:09:03 opera volumiobt[1670]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Dec 15 16:09:03 opera sudo[1675]: pam_unix(sudo:session): session closed for user root Dec 15 16:09:03 opera volumio[1290]: info: Setting Device type: Tinkerboard Dec 15 16:09:03 opera volumio[1290]: [SpotifyConnect] Vollibrespot Daemon service started! Dec 15 16:09:03 opera volumio[1290]: [Metrics] SpotifyConnect: 5s 905.63ms Dec 15 16:09:03 opera volumio[1290]: [SpotifyConnect] Vollibrespot Daemon Started Dec 15 16:09:03 opera volumio[1290]: [SpotifyConnect] Starting metadata listener Dec 15 16:09:03 opera volumio[1290]: [SpotifyConnect] FE => [ 1, [length]: 1 ] Dec 15 16:09:03 opera volumio[1290]: [SpotifyConnect] Error: bind EADDRINUSE 0.0.0.0:5030 Dec 15 16:09:03 opera volumio[1290]: at Object._errnoException (util.js:1022:11) Dec 15 16:09:03 opera volumio[1290]: at _exceptionWithHostPort (util.js:1044:20) Dec 15 16:09:03 opera volumio[1290]: at _handle.lookup (dgram.js:266:18) Dec 15 16:09:03 opera volumio[1290]: at _combinedTickCallback (internal/process/next_tick.js:141:11) Dec 15 16:09:03 opera volumio[1290]: at process._tickCallback (internal/process/next_tick.js:180:9) Dec 15 16:09:03 opera volumio[1290]: [SpotifyConnect] Error [ERR_SOCKET_CANNOT_SEND]: Unable to send data Dec 15 16:09:03 opera volumio[1290]: at Socket.onListenError (dgram.js:362:22) Dec 15 16:09:03 opera volumio[1290]: at Object.onceWrapper (events.js:315:30) Dec 15 16:09:03 opera volumio[1290]: at emitOne (events.js:121:20) Dec 15 16:09:03 opera volumio[1290]: at Socket.emit (events.js:211:7) Dec 15 16:09:03 opera volumio[1290]: at _handle.lookup (dgram.js:267:14) Dec 15 16:09:03 opera volumio[1290]: at _combinedTickCallback (internal/process/next_tick.js:141:11) Dec 15 16:09:03 opera volumio[1290]: at process._tickCallback (internal/process/next_tick.js:180:9) Dec 15 16:09:03 opera volumio[1290]: info: RAAT Albumart path created successfully Dec 15 16:09:03 opera volumio[1290]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'Opera' Dec 15 16:09:03 opera volumio[1290]: sudo: no tty present and no askpass program specified Dec 15 16:09:03 opera volumio[1290]: info: MPD running with PID694 Dec 15 16:09:03 opera volumio[1290]: ,establishing connection Dec 15 16:09:03 opera sudo[1685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Dec 15 16:09:03 opera sudo[1685]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:09:03 opera sudo[1685]: pam_unix(sudo:session): session closed for user root Dec 15 16:09:03 opera volumio[1290]: info: Volumio BT Module successfully started Dec 15 16:09:03 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 15 16:09:03 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Dec 15 16:09:03 opera volumio[1290]: No protocol specified Dec 15 16:09:03 opera volumio[1290]: xcb_connection_has_error() returned true Dec 15 16:09:03 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:09:03 opera volumio[1290]: info: CoreCommandRouter::volumioGetState Dec 15 16:09:03 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:03 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 16:09:03 opera volumio[1290]: info: Reloading queue from file Dec 15 16:09:03 opera sudo[1699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Dec 15 16:09:03 opera volumio[1290]: error: updateQueue error: null Dec 15 16:09:03 opera volumio[1290]: verbose: ControllerMpd::sendMpdCommand update Dec 15 16:09:03 opera sudo[1699]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:09:03 opera systemd[1]: Starting RAAT DAEMON... Dec 15 16:09:03 opera systemd[1]: Started RAAT DAEMON. Dec 15 16:09:03 opera sudo[1699]: pam_unix(sudo:session): session closed for user root Dec 15 16:09:03 opera volumio[1290]: info: CoreStateMachine::setRepeat true single undefined Dec 15 16:09:03 opera volumio[1290]: info: CoreStateMachine::pushState Dec 15 16:09:03 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:03 opera volumio[1290]: info: CoreCommandRouter::volumioPushState Dec 15 16:09:03 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 16:09:03 opera volumio[1290]: info: CoreStateMachine::setRandom false Dec 15 16:09:03 opera volumio[1290]: info: CoreStateMachine::pushState Dec 15 16:09:04 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:04 opera volumio[1290]: info: CoreCommandRouter::volumioPushState Dec 15 16:09:04 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 16:09:04 opera volumio[1290]: info: Raat Daemon started successfully Dec 15 16:09:04 opera volumio[1290]: info: Starting Shairport Sync Dec 15 16:09:04 opera volumio[1290]: info: Starting Shairport Sync Dec 15 16:09:04 opera sudo[1721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 15 16:09:04 opera sudo[1721]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:09:04 opera sudo[1723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 15 16:09:04 opera sudo[1723]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:09:04 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 15 16:09:04 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 15 16:09:04 opera sudo[1731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 15 16:09:04 opera sudo[1721]: pam_unix(sudo:session): session closed for user root Dec 15 16:09:04 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 15 16:09:04 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 15 16:09:04 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 15 16:09:04 opera sudo[1723]: pam_unix(sudo:session): session closed for user root Dec 15 16:09:04 opera sudo[1731]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:09:04 opera volumio[1290]: info: Executing endpoint restartRAATSocket Dec 15 16:09:04 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Dec 15 16:09:04 opera systemd[1]: Starting UPnP Renderer front-end to MPD... Dec 15 16:09:04 opera systemd[1]: Started UPnP Renderer front-end to MPD. Dec 15 16:09:04 opera sudo[1731]: pam_unix(sudo:session): session closed for user root Dec 15 16:09:04 opera volumio-remote-updater[669]: [2025-12-15 16:09:04] [connect] Successful connection Dec 15 16:09:04 opera volumio[1290]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 15 16:09:04 opera volumio[1290]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 15 16:09:04 opera volumio[1290]: info: Shairport-Sync Started Dec 15 16:09:04 opera volumio[1290]: Error adding Membership: Error: addMembership EINVAL Dec 15 16:09:04 opera volumio[1290]: info: Shairport-Sync Started Dec 15 16:09:04 opera volumio[1290]: info: Volumio called home Dec 15 16:09:04 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:04 opera volumio[1290]: info: Upmpdcli Daemon Started Dec 15 16:09:04 opera volumio-remote-updater[669]: [2025-12-15 16:09:04] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1765814944 101 Dec 15 16:09:04 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 15 16:09:04 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 15 16:09:04 opera volumio[1290]: No protocol specified Dec 15 16:09:04 opera volumio[1290]: xcb_connection_has_error() returned true Dec 15 16:09:04 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 15 16:09:04 opera systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Dec 15 16:09:04 opera systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Dec 15 16:09:04 opera systemd[1]: Stopping Volspotconnect2 Daemon... Dec 15 16:09:04 opera systemd[1]: Starting Volspotconnect2 Daemon... Dec 15 16:09:04 opera systemd[1]: Started Volspotconnect2 Daemon. Dec 15 16:09:04 opera systemd[1]: Stopping Volspotconnect2 Daemon... Dec 15 16:09:04 opera systemd[1]: Starting Volspotconnect2 Daemon... Dec 15 16:09:04 opera systemd[1]: Started Volspotconnect2 Daemon. Dec 15 16:09:04 opera volumio[1771]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Dec 15 16:09:04 opera volumio[1771]: Reading Config from "/tmp/volspotify.toml" Dec 15 16:09:04 opera volumio[1771]: [Vollibrespot] : Using Alsa backend with device: plughw:5 Dec 15 16:09:04 opera volumio[1772]: vollibrespot v0.1.9 c98fd5d 2019-11-08 (librespot 4674946 2019-11-08) -- Built On 2019-11-08 Dec 15 16:09:04 opera volumio[1771]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Dec 15 16:09:04 opera sudo[1780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Dec 15 16:09:04 opera volumio[1772]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Dec 15 16:09:04 opera sudo[1780]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 15 16:09:04 opera volumiobt[1670]: pulseaudio: no process found Dec 15 16:09:04 opera sudo[1780]: pam_unix(sudo:session): session closed for user root Dec 15 16:09:04 opera dbus[700]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Dec 15 16:09:04 opera systemd[1]: Starting RealtimeKit Scheduling Policy Service... Dec 15 16:09:04 opera kernel: IPVS: Creating netns size=1496 id=2 Dec 15 16:09:04 opera kernel: IPVS: ftp: loaded support on port[0] = 21 Dec 15 16:09:04 opera dbus[700]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Dec 15 16:09:04 opera systemd[1]: Started RealtimeKit Scheduling Policy Service. Dec 15 16:09:04 opera rtkit-daemon[1791]: Successfully called chroot. Dec 15 16:09:04 opera rtkit-daemon[1791]: Successfully dropped privileges. Dec 15 16:09:04 opera rtkit-daemon[1791]: Successfully limited resources. Dec 15 16:09:04 opera rtkit-daemon[1791]: Running. Dec 15 16:09:04 opera rtkit-daemon[1791]: Watchdog thread running. Dec 15 16:09:04 opera rtkit-daemon[1791]: Canary thread running. Dec 15 16:09:04 opera volumio[1290]: info: CoreCommandRouter::volumioGetState Dec 15 16:09:04 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:04 opera volumio[1290]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 15 16:09:05 opera pulseaudio[1790]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Dec 15 16:09:05 opera pulseaudio[1790]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Dec 15 16:09:05 opera pulseaudio[1790]: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist Dec 15 16:09:05 opera bluetoothd[871]: Endpoint registered: sender=:1.20 path=/MediaEndpoint/A2DPSource Dec 15 16:09:05 opera bluetoothd[871]: Endpoint registered: sender=:1.20 path=/MediaEndpoint/A2DPSink Dec 15 16:09:05 opera volumiobt[1670]: Applying permissions Dec 15 16:09:05 opera volumiobt[1670]: Setting BT discoverable and pairable Dec 15 16:09:05 opera volumiobt[1670]: [103B blob data] Dec 15 16:09:05 opera volumiobt[1670]: [84B blob data] Dec 15 16:09:05 opera volumiobt[1670]: [86B blob data] Dec 15 16:09:05 opera volumiobt[1670]: [91B blob data] Dec 15 16:09:05 opera volumiobt[1670]: [bluetooth]# -e power on Dec 15 16:09:05 opera volumiobt[1670]: Invalid command Dec 15 16:09:05 opera volumiobt[1670]: [bluetooth]# agent on Dec 15 16:09:05 opera volumiobt[1670]: [bluetooth]# discoverable on Dec 15 16:09:05 opera volumiobt[1670]: [bluetooth]# pairable on Dec 15 16:09:05 opera volumiobt[1670]: [bluetooth]# agent NoInputNoOutput Dec 15 16:09:05 opera volumiobt[1670]: Failed to register agent object Dec 15 16:09:05 opera volumiobt[1670]: [bluetooth]# default-agent Dec 15 16:09:05 opera volumiobt[1670]: No agent is registered Dec 15 16:09:05 opera volumiobt[1670]: [bluetooth]# quit Dec 15 16:09:05 opera volumiobt[1670]: [61B blob data] Dec 15 16:09:05 opera volumiobt[1670]: [89B blob data] Dec 15 16:09:05 opera volumiobt[1670]: [62B blob data] Dec 15 16:09:05 opera volumio[1290]: verbose: ControllerMpd::sendMpdCommand status Dec 15 16:09:05 opera volumio[1290]: info: Dec 15 16:09:05 opera volumio[1290]: ---------------------------- MPD announces state update: update Dec 15 16:09:05 opera volumio[1290]: info: sendMpdCommand update took 1631 milliseconds Dec 15 16:09:05 opera volumio[1290]: info: ControllerMpd::getState Dec 15 16:09:05 opera volumio[1290]: verbose: ControllerMpd::sendMpdCommand status Dec 15 16:09:05 opera volumio[1290]: info: MPD Database updated - AlbumList cache refreshed Dec 15 16:09:05 opera volumio[1290]: info: Dec 15 16:09:05 opera volumio[1290]: ---------------------------- MPD announces state update: database Dec 15 16:09:05 opera volumio[1290]: verbose: ControllerMpd::sendMpdCommand status Dec 15 16:09:05 opera volumio[1290]: info: Dec 15 16:09:05 opera volumio[1290]: ---------------------------- MPD announces state update: update Dec 15 16:09:05 opera volumio[1290]: info: ControllerMpd::getState Dec 15 16:09:05 opera volumio[1290]: verbose: ControllerMpd::sendMpdCommand status Dec 15 16:09:05 opera volumio[1290]: info: ControllerMpd::getState Dec 15 16:09:05 opera volumio[1290]: verbose: ControllerMpd::sendMpdCommand status Dec 15 16:09:05 opera volumio[1290]: info: sendMpdCommand status took 139 milliseconds Dec 15 16:09:05 opera volumio[1290]: info: sendMpdCommand status took 134 milliseconds Dec 15 16:09:05 opera volumio[1290]: verbose: ControllerMpd::parseState Dec 15 16:09:05 opera volumio[1290]: info: Command Router : Notfying DB Updatefalse Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::Close All Modals sent Dec 15 16:09:05 opera volumio[1290]: verbose: ControllerMpd::parseState Dec 15 16:09:05 opera volumio[1290]: info: ControllerMpd::pushState Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::servicePushState Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::pushState Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::volumioPushState Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 15 16:09:05 opera volumio[1290]: verbose: CURRENT POSITION 0 Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::syncState stateService stop Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::syncState currentStatus stop Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::pushState Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::volumioPushState Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 16:09:05 opera volumio[1290]: info: No code Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::pushState Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::volumioPushState Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 16:09:05 opera volumio[1290]: info: ------------------------------ 237ms Dec 15 16:09:05 opera volumio[1290]: info: sendMpdCommand status took 148 milliseconds Dec 15 16:09:05 opera volumio[1290]: info: sendMpdCommand status took 139 milliseconds Dec 15 16:09:05 opera volumio[1290]: info: sendMpdCommand status took 137 milliseconds Dec 15 16:09:05 opera volumio[1290]: verbose: ControllerMpd::parseState Dec 15 16:09:05 opera volumio[1290]: info: Command Router : Notfying DB Updatefalse Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::Close All Modals sent Dec 15 16:09:05 opera volumio[1290]: verbose: ControllerMpd::parseState Dec 15 16:09:05 opera volumio[1290]: verbose: ControllerMpd::parseState Dec 15 16:09:05 opera volumio[1290]: info: ControllerMpd::pushState Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::servicePushState Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::pushState Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::volumioPushState Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 15 16:09:05 opera volumio[1290]: verbose: CURRENT POSITION 0 Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::syncState stateService stop Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::syncState currentStatus stop Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::pushState Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::volumioPushState Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 16:09:05 opera volumio[1290]: info: No code Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::pushState Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::volumioPushState Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 16:09:05 opera volumio[1290]: info: ControllerMpd::pushState Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::servicePushState Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::pushState Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::volumioPushState Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 15 16:09:05 opera volumio[1290]: verbose: CURRENT POSITION 0 Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::syncState stateService stop Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::syncState currentStatus stop Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::pushState Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::volumioPushState Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 16:09:05 opera volumio[1290]: info: No code Dec 15 16:09:05 opera volumio[1290]: info: CoreStateMachine::pushState Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::volumioPushState Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 16:09:05 opera volumio[1290]: info: ------------------------------ 209ms Dec 15 16:09:05 opera volumio[1290]: info: ------------------------------ 207ms Dec 15 16:09:05 opera volumio[1290]: Discovery: adding f58d2561-3b3b-40db-8522-07500e547abb Dec 15 16:09:05 opera volumio[1290]: info: mDNS: Found device Opera Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::volumioGetState Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: error: Could not retrieve plugin audio_interface multiroom Dec 15 16:09:05 opera volumio[1290]: error: Could not retrieve plugin audio_interface multiroom Dec 15 16:09:05 opera volumio[1290]: info: Updating RAAT Signal Path Dec 15 16:09:05 opera volumio[1290]: info: Updating RAAT Signal Path Dec 15 16:09:05 opera volumio[1290]: info: Updating RAAT Signal Path Dec 15 16:09:05 opera volumio[1290]: info: Updating RAAT Signal Path Dec 15 16:09:05 opera volumio[1290]: info: Updating RAAT Signal Path Dec 15 16:09:05 opera volumio[1290]: info: Updating RAAT Signal Path Dec 15 16:09:05 opera volumio[1290]: info: Updating RAAT Signal Path Dec 15 16:09:05 opera volumio[1290]: info: Updating RAAT Signal Path Dec 15 16:09:05 opera volumio[1290]: info: Updating RAAT Signal Path Dec 15 16:09:05 opera volumio[1290]: Discovery: this is already registered, f58d2561-3b3b-40db-8522-07500e547abb Dec 15 16:09:05 opera volumio[1290]: info: mDNS: Found device Opera Dec 15 16:09:05 opera volumio[1290]: info: CoreCommandRouter::volumioGetState Dec 15 16:09:05 opera volumio[1290]: info: CorePlayQueue::getTrack 0 Dec 15 16:09:05 opera volumio[1290]: error: Could not retrieve plugin audio_interface multiroom Dec 15 16:09:05 opera volumio[1290]: error: Could not retrieve plugin audio_interface multiroom Dec 15 16:09:06 opera volumio-streaming-daemon[1553]: Checking variant in static cache Dec 15 16:09:06 opera volumio[1290]: info: Fetching Streaming Services browse cache Dec 15 16:09:06 opera kernel: usb 1-1.4: new high-speed USB device number 4 using dwc2 Dec 15 16:09:06 opera kernel: usb 1-1.4: New USB device found, idVendor=0bda, idProduct=9210 Dec 15 16:09:06 opera kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 15 16:09:06 opera kernel: usb 1-1.4: Product: RTL9210 Dec 15 16:09:06 opera kernel: usb 1-1.4: Manufacturer: Realtek Dec 15 16:09:06 opera kernel: usb 1-1.4: SerialNumber: 012345678902 Dec 15 16:09:06 opera kernel: usb-storage 1-1.4:1.0: USB Mass Storage device detected Dec 15 16:09:06 opera kernel: scsi host0: usb-storage 1-1.4:1.0 Dec 15 16:09:07 opera volumio[1290]: info: Checking Spotify Web API Dec 15 16:09:07 opera kernel: scsi 0:0:0:0: Direct-Access Realtek RTL9210 NVME 1.00 PQ: 0 ANSI: 6 Dec 15 16:09:07 opera kernel: sd 0:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) Dec 15 16:09:07 opera kernel: sd 0:0:0:0: [sda] Write Protect is off Dec 15 16:09:07 opera kernel: sd 0:0:0:0: [sda] Mode Sense: 37 00 00 08 Dec 15 16:09:07 opera kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Dec 15 16:09:07 opera kernel: sda: sda1 sda2 Dec 15 16:09:07 opera kernel: sd 0:0:0:0: [sda] Attached SCSI disk Dec 15 16:09:07 opera udisks-glue[663]: Device file /dev/sda inserted Dec 15 16:09:07 opera udisks-glue[663]: Device file /dev/sda2 inserted Dec 15 16:09:07 opera udisks-glue[663]: Trying to automount /dev/sda2... Dec 15 16:09:08 opera volumio[1290]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 15 16:09:08 opera volumio[1290]: { Error: addMembership ENODEV Dec 15 16:09:08 opera volumio[1290]: at _errnoException (util.js:1022:11) Dec 15 16:09:08 opera volumio[1290]: at Socket.addMembership (dgram.js:615:11) Dec 15 16:09:08 opera volumio[1290]: at Timeout.addMembership [as _onTimeout] (/volumio/node_modules/node-ssdp/lib/index.js:264:16) Dec 15 16:09:08 opera volumio[1290]: at ontimeout (timers.js:482:11) Dec 15 16:09:08 opera volumio[1290]: at tryOnTimeout (timers.js:317:5) Dec 15 16:09:08 opera volumio[1290]: at Timer.listOnTimeout (timers.js:277:5) code: 'ENODEV', errno: 'ENODEV', syscall: 'addMembership' } Dec 15 16:09:08 opera volumio[1290]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 15 16:09:08 opera ntfs-3g[1853]: Version 2014.2.15AR.2 integrated FUSE 28 Dec 15 16:09:08 opera ntfs-3g[1853]: Mounted /dev/sda2 (Read-Write, label "Classical Easy Test Ost", NTFS 3.1) Dec 15 16:09:08 opera ntfs-3g[1853]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks Dec 15 16:09:08 opera ntfs-3g[1853]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/sda2,blkdev,blksize=4096 Dec 15 16:09:08 opera ntfs-3g[1853]: Global ownership and permissions enforced, configuration type 7 Dec 15 16:09:08 opera udisks-glue[663]: Successfully automounted /dev/sda2 at /media/Classical Easy Test Ost__ Dec 15 16:09:09 opera udisks-glue[663]: Device file /dev/sda1 inserted Dec 15 16:09:09 opera udisks-glue[663]: Device file /dev/sda2 mounted at /media/Classical Easy Test Ost__ Dec 15 16:09:09 opera udisks-glue[663]: Updating DB (#2) ... Dec 15 16:09:09 opera udisks-glue[663]: volume: n/a repeat: off random: off single: off consume: off Dec 15 16:09:09 opera sudo[1858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-15 16:08 Dec 15 16:09:09 opera sudo[1858]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"