-- Logs begin at Fri 2024-11-01 10:21:00 UTC, end at Mon 2025-04-28 10:03:14 UTC. -- Apr 28 10:02:46 opera systemd[1]: Time has been changed Apr 28 10:02:46 opera wireless.js[814]: Overtime, starting plan B Apr 28 10:02:46 opera wireless.js[814]: STARTING HOTSPOT Apr 28 10:02:46 opera wpa_supplicant[998]: wlan0: CTRL-EVENT-TERMINATING Apr 28 10:02:49 opera systemd[1]: Stopped hotspot.service. Apr 28 10:02:49 opera sudo[1331]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 28 10:02:49 opera sudo[1331]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:02:49 opera sudo[1331]: pam_unix(sudo:session): session closed for user root Apr 28 10:02:49 opera sudo[1339]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 28 10:02:49 opera sudo[1339]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:02:49 opera sudo[1339]: pam_unix(sudo:session): session closed for user root Apr 28 10:02:49 opera wireless.js[814]: Hotspot is disabled, not starting it Apr 28 10:02:49 opera systemd[1]: Started Wireless Services. Apr 28 10:02:49 opera systemd[1]: Starting Volumio Backend Module... Apr 28 10:02:49 opera systemd[1]: Started Volumio Backend Module. Apr 28 10:02:49 opera systemd[1]: Starting Start Volumio Kiosk... Apr 28 10:02:49 opera systemd[1]: Started Start Volumio Kiosk. Apr 28 10:02:49 opera systemd[1]: Starting Volumio Streaming Daemon... Apr 28 10:02:49 opera systemd[1]: Started Volumio Streaming Daemon. Apr 28 10:02:49 opera volumio-streaming-daemon[1352]: ############################ Apr 28 10:02:49 opera volumio-streaming-daemon[1352]: # Volumio Streaming Daemon # Apr 28 10:02:49 opera volumio-streaming-daemon[1352]: # Running on port 7777 # Apr 28 10:02:49 opera volumio-streaming-daemon[1352]: ############################ Apr 28 10:02:49 opera volumio-streaming-daemon[1352]: Checking variant in static cache Apr 28 10:02:49 opera volumio-streaming-daemon[1352]: Enabled services: Apr 28 10:02:49 opera volumio-streaming-daemon[1352]: 1) tidal Apr 28 10:02:49 opera volumio-streaming-daemon[1352]: 2) qobuz Apr 28 10:02:50 opera startx[1351]: X.Org X Server 1.16.4 Apr 28 10:02:50 opera startx[1351]: Release Date: 2014-12-20 Apr 28 10:02:50 opera startx[1351]: X Protocol Version 11, Revision 0 Apr 28 10:02:50 opera startx[1351]: Build Operating System: Linux 4.9.0-4-armmp-lpae armv7l Debian Apr 28 10:02:50 opera startx[1351]: Current Operating System: Linux opera 4.4.71+ #23 SMP Sun Sep 20 12:23:26 CEST 2020 armv7l Apr 28 10:02:50 opera startx[1351]: Kernel command line: earlyprintk splash plymouth.ignore-serial-consoles console=tty1 console=ttyS3,115200n8 rw init=/sbin/init imgpart=UUID=b3508cc2-d68f-4517-a3d5-5fba0c8ecd27 imgfile=/volumio_current.sqsh bootpart=UUID=2E95-29EE datapart=UUID=dd89f6f0-fc8c-4c62-b483-abdb338ee1f9 bootconfig=/extlinux/extlinux.conf logo.nologo vt.global_cursor_default=0 loglevel=0 uboot_version=2017.07-g879646d1d6 root=/dev/mmcblk1p2 Apr 28 10:02:50 opera startx[1351]: Build Date: 16 October 2017 09:26:27AM Apr 28 10:02:50 opera startx[1351]: xorg-server 2:1.16.4-1+deb8u2 (http://www.debian.org/support) Apr 28 10:02:50 opera startx[1351]: Current version of pixman: 0.32.6 Apr 28 10:02:50 opera startx[1351]: Before reporting problems, check http://wiki.x.org Apr 28 10:02:50 opera startx[1351]: to make sure that you have the latest version. Apr 28 10:02:50 opera startx[1351]: Markers: (--) probed, (**) from config file, (==) default setting, Apr 28 10:02:50 opera startx[1351]: (++) from command line, (!!) notice, (II) informational, Apr 28 10:02:50 opera startx[1351]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Apr 28 10:02:50 opera startx[1351]: (==) Log file: "/var/log/Xorg.0.log", Time: Mon Apr 28 10:02:50 2025 Apr 28 10:02:50 opera startx[1351]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Apr 28 10:02:51 opera volumio[1349]: info: ------------------------------------------- Apr 28 10:02:51 opera volumio[1349]: info: ----- Volumio2 ---- Apr 28 10:02:51 opera volumio[1349]: info: ------------------------------------------- Apr 28 10:02:51 opera volumio[1349]: info: ----- System startup ---- Apr 28 10:02:51 opera volumio[1349]: info: ------------------------------------------- Apr 28 10:02:52 opera volumio[1349]: info: Plugin folders cleanup Apr 28 10:02:52 opera volumio[1349]: info: Scanning into folder /volumio/app/plugins/ Apr 28 10:02:52 opera volumio[1349]: info: Scanning category audio_interface Apr 28 10:02:52 opera volumio[1349]: info: Scanning category miscellanea Apr 28 10:02:52 opera volumio[1349]: info: Scanning category music_service Apr 28 10:02:52 opera volumio[1349]: info: Scanning category plugins.json Apr 28 10:02:52 opera volumio[1349]: info: Scanning category system_controller Apr 28 10:02:52 opera volumio[1349]: info: Scanning category user_interface Apr 28 10:02:52 opera volumio[1349]: info: Scanning into folder /data/plugins/ Apr 28 10:02:52 opera volumio[1349]: info: Plugin folders cleanup completed Apr 28 10:02:52 opera volumio[1349]: info: ------------------------------------------- Apr 28 10:02:52 opera volumio[1349]: info: ----- Core plugins startup ---- Apr 28 10:02:52 opera volumio[1349]: info: ------------------------------------------- Apr 28 10:02:52 opera volumio[1349]: info: Loading plugins from folder /volumio/app/plugins/ Apr 28 10:02:52 opera volumio[1349]: info: Adding plugin bluetooth to MyMusic Plugins Apr 28 10:02:52 opera volumio[1349]: info: Adding plugin upnp to MyMusic Plugins Apr 28 10:02:52 opera volumio[1349]: info: Adding plugin metavolumio to MyMusic Plugins Apr 28 10:02:52 opera volumio[1349]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 28 10:02:52 opera volumio[1349]: info: Adding plugin cd_controller to MyMusic Plugins Apr 28 10:02:52 opera volumio[1349]: info: Adding plugin raat to MyMusic Plugins Apr 28 10:02:52 opera volumio[1349]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 28 10:02:52 opera volumio[1349]: info: Adding plugin volspotconnect2 to MyMusic Plugins Apr 28 10:02:52 opera volumio[1349]: info: Loading plugins from folder /data/plugins/ Apr 28 10:02:52 opera volumio[1349]: info: Loading plugin "system"... Apr 28 10:02:52 opera volumio[1349]: info: Loading plugin "appearance"... Apr 28 10:02:53 opera volumio[1349]: info: Loading plugin "network"... Apr 28 10:02:53 opera volumio[1349]: info: Refreshing Cached IP Addresses Apr 28 10:02:53 opera sudo[1435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 28 10:02:53 opera volumio[1349]: info: Loading plugin "services"... Apr 28 10:02:53 opera sudo[1435]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:02:53 opera volumio[1349]: info: Loading plugin "alsa_controller"... Apr 28 10:02:53 opera sudo[1437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 28 10:02:53 opera sudo[1435]: pam_unix(sudo:session): session closed for user root Apr 28 10:02:53 opera sudo[1437]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:02:53 opera sudo[1437]: pam_unix(sudo:session): session closed for user root Apr 28 10:02:53 opera volumio[1349]: info: Loading plugin "wizard"... Apr 28 10:02:53 opera volumio[1349]: info: Loading plugin "volumio_command_line_client"... Apr 28 10:02:53 opera volumio[1349]: info: Loading plugin "upnp"... Apr 28 10:02:53 opera volumio[1349]: info: [1745834573282] Starting Upmpd Daemon Apr 28 10:02:53 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 28 10:02:53 opera volumio[1349]: info: Loading plugin "my_music"... Apr 28 10:02:53 opera volumio[1349]: info: Loading plugin "mpd"... Apr 28 10:02:53 opera volumio[1349]: info: Loading plugin "upnp_browser"... Apr 28 10:02:53 opera volumio[1349]: info: Loading plugin "networkfs"... Apr 28 10:02:53 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 28 10:02:53 opera volumio[1349]: info: Loading plugin "bluetooth"... Apr 28 10:02:54 opera volumio[1349]: info: [1745834574118] Starting BluetoothController Apr 28 10:02:54 opera volumio[1349]: info: Loading plugin "alarm-clock"... Apr 28 10:02:54 opera volumio[1349]: info: Loading plugin "metavolumio"... Apr 28 10:02:55 opera volumio[1349]: info: Loading plugin "airplay_emulation"... Apr 28 10:02:55 opera volumio[1349]: info: Starting Shairport Sync Apr 28 10:02:55 opera volumio[1349]: info: Loading plugin "cd_controller"... Apr 28 10:02:55 opera volumio[1349]: info: Loading plugin "last_100"... Apr 28 10:02:55 opera volumio[1349]: info: Plugin raat is not enabled Apr 28 10:02:55 opera volumio[1349]: info: Loading plugin "streaming_services"... Apr 28 10:02:55 opera volumio[1349]: info: Loading plugin "webradio"... Apr 28 10:02:55 opera volumio[1349]: info: Loading plugin "i2s_dacs"... Apr 28 10:02:55 opera volumio[1349]: info: I2S DAC not set, start Auto-detection Apr 28 10:02:55 opera volumio[1349]: info: Loading plugin "volumiodiscovery"... Apr 28 10:02:55 opera volumio[1349]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 28 10:02:55 opera node[1349]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 28 10:02:55 opera node[1349]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 28 10:02:55 opera node[1349]: *** WARNING *** For more information see Apr 28 10:02:55 opera node[1349]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 28 10:02:55 opera node[1349]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 28 10:02:55 opera node[1349]: *** WARNING *** For more information see Apr 28 10:02:55 opera volumio[1349]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 28 10:02:55 opera volumio[1349]: *** WARNING *** For more information see Apr 28 10:02:55 opera volumio[1349]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 28 10:02:55 opera volumio[1349]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 28 10:02:55 opera volumio[1349]: *** WARNING *** For more information see Apr 28 10:02:55 opera volumio[1349]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 28 10:02:55 opera volumio[1349]: Discovery: StartAdv! undefined Apr 28 10:02:55 opera volumio[1349]: Discovery: Started advertising... Opera - undefined Apr 28 10:02:55 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 28 10:02:55 opera volumio[1349]: info: Loading plugin "outputs"... Apr 28 10:02:55 opera volumio[1349]: info: Loading plugin "albumart"... Apr 28 10:02:55 opera volumio[1349]: info: Plugin example_plugin is not enabled Apr 28 10:02:55 opera volumio[1349]: info: Loading plugin "hi_res_audio"... Apr 28 10:02:55 opera volumio-remote-updater[664]: [2025-04-28 10:02:55] [connect] Successful connection Apr 28 10:02:56 opera volumio[1349]: Forking 3 albumart workers Apr 28 10:02:56 opera volumio[1349]: Starting albumart workers Apr 28 10:02:56 opera volumio[1349]: Starting albumart workers Apr 28 10:02:56 opera volumio[1349]: Starting albumart workers Apr 28 10:02:57 opera volumio[1349]: info: Applying required configuration parameters for plugin hi_res_audio Apr 28 10:02:57 opera volumio[1349]: info: Loading plugin "inputs"... Apr 28 10:02:57 opera volumio[1349]: info: Loading plugin "qobuz"... Apr 28 10:02:58 opera volumio[1349]: info: Loading plugin "tidal"... Apr 28 10:02:59 opera volumio[1349]: info: Loading plugin "volspotconnect2"... Apr 28 10:03:00 opera volumio[1349]: info: Loading plugin "updater_comm"... Apr 28 10:03:00 opera volumio[1349]: info: Plugin mpdemulation is not enabled Apr 28 10:03:00 opera volumio[1349]: info: Loading plugin "rest_api"... Apr 28 10:03:00 opera volumio[1349]: info: Loading plugin "websocket"... Apr 28 10:03:00 opera volumio[1349]: info: ___________ START PLUGINS ___________ Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 28 10:03:00 opera volumio[1349]: info: [1745834580742] CoreMusicLibrary::Adding element Media Servers Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 28 10:03:00 opera volumio[1349]: info: Adding METAVOLUMIO REST API Endpoints Apr 28 10:03:00 opera volumio[1349]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Apr 28 10:03:00 opera sudo[1584]: pam_unix(sudo:auth): conversation failed Apr 28 10:03:00 opera sudo[1584]: pam_unix(sudo:auth): auth could not identify password for [volumio] Apr 28 10:03:00 opera volumio[1349]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 28 10:03:00 opera volumio[1349]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 28 10:03:00 opera volumio[1349]: info: Preparing CD Folders Apr 28 10:03:00 opera volumio[1349]: info: Adding CD REST API Endpoints Apr 28 10:03:00 opera volumio[1349]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Apr 28 10:03:00 opera volumio[1349]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Apr 28 10:03:00 opera volumio[1349]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Apr 28 10:03:00 opera volumio[1349]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Apr 28 10:03:00 opera volumio[1349]: info: Detecting CD presence with Flag file Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 28 10:03:00 opera volumio[1349]: info: [1745834580838] CoreMusicLibrary::Adding element Last_100 Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 10:03:00 opera volumio[1349]: info: Streaming services startup Apr 28 10:03:00 opera volumio[1349]: info: Starting Streaming Daemon Apr 28 10:03:00 opera sudo[1595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 28 10:03:00 opera sudo[1595]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:03:00 opera systemd[1]: Stopping Volumio Streaming Daemon... Apr 28 10:03:00 opera systemd[1]: Starting Volumio Streaming Daemon... Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 28 10:03:00 opera systemd[1]: Started Volumio Streaming Daemon. Apr 28 10:03:00 opera volumio[1349]: info: [1745834580880] CoreMusicLibrary::Adding element Webradio Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 28 10:03:00 opera volumio-streaming-daemon[1606]: ############################ Apr 28 10:03:00 opera volumio-streaming-daemon[1606]: # Volumio Streaming Daemon # Apr 28 10:03:00 opera volumio-streaming-daemon[1606]: # Running on port 7777 # Apr 28 10:03:00 opera volumio-streaming-daemon[1606]: ############################ Apr 28 10:03:00 opera sudo[1595]: pam_unix(sudo:session): session closed for user root Apr 28 10:03:00 opera volumio-streaming-daemon[1606]: Checking variant in static cache Apr 28 10:03:00 opera volumio-streaming-daemon[1606]: Enabled services: Apr 28 10:03:00 opera volumio-streaming-daemon[1606]: 1) tidal Apr 28 10:03:00 opera volumio-streaming-daemon[1606]: 2) qobuz Apr 28 10:03:00 opera volumio[1349]: error: Hi Res Audio Failed Login: Missing Login Data Apr 28 10:03:00 opera volumio[1349]: info: Loading i18n strings for locale zh Apr 28 10:03:00 opera sudo[1616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Apr 28 10:03:00 opera volumio[1349]: Updating browse sources language Apr 28 10:03:00 opera sudo[1616]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:03:00 opera volumio[1349]: Cannot find translation for sourceMedia Servers Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 10:03:00 opera systemd[1]: Starting Volspotconnect2 Daemon... Apr 28 10:03:00 opera systemd[1]: Started Volspotconnect2 Daemon. Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::initPlayerControls Apr 28 10:03:00 opera volumio[1621]: /bin/bash: /tmp/startconnect.sh: No such file or directory Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 10:03:00 opera volumio[1349]: info: BOOT COMPLETED Apr 28 10:03:00 opera volumio[1349]: [Metrics] CommandRouter: 9s 303.05ms Apr 28 10:03:00 opera systemd[1]: volspotconnect2.service: main process exited, code=exited, status=127/n/a Apr 28 10:03:00 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 28 10:03:00 opera systemd[1]: Unit volspotconnect2.service entered failed state. Apr 28 10:03:00 opera sudo[1616]: pam_unix(sudo:session): session closed for user root Apr 28 10:03:03 opera systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Apr 28 10:03:03 opera systemd[1]: Stopping Volspotconnect2 Daemon... Apr 28 10:03:03 opera systemd[1]: Starting Volspotconnect2 Daemon... Apr 28 10:03:03 opera systemd[1]: Started Volspotconnect2 Daemon. Apr 28 10:03:03 opera volumio[1631]: /bin/bash: /tmp/startconnect.sh: No such file or directory Apr 28 10:03:03 opera systemd[1]: volspotconnect2.service: main process exited, code=exited, status=127/n/a Apr 28 10:03:03 opera systemd[1]: Unit volspotconnect2.service entered failed state. Apr 28 10:03:05 opera systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Apr 28 10:03:05 opera systemd[1]: Stopping Volspotconnect2 Daemon... Apr 28 10:03:05 opera systemd[1]: Starting Volspotconnect2 Daemon... Apr 28 10:03:05 opera systemd[1]: Started Volspotconnect2 Daemon. Apr 28 10:03:05 opera volumio[1634]: /bin/bash: /tmp/startconnect.sh: No such file or directory Apr 28 10:03:05 opera systemd[1]: volspotconnect2.service: main process exited, code=exited, status=127/n/a Apr 28 10:03:05 opera systemd[1]: Unit volspotconnect2.service entered failed state. Apr 28 10:03:06 opera volumio[1349]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Apr 28 10:03:06 opera volumio[1349]: info: CoreCommandRouter::Close All Modals sent Apr 28 10:03:06 opera volumio[1349]: info: CoreCommandRouter::Close All Modals sent Apr 28 10:03:06 opera volumio[1349]: Express server listening on port 3000 Apr 28 10:03:06 opera volumio[1349]: [Metrics] WebUI: 15s 329.43ms Apr 28 10:03:06 opera volumio[1349]: Volumio Calling Home Apr 28 10:03:06 opera volumio[1349]: info: CoreStateMachine::resetVolumioState Apr 28 10:03:06 opera volumio[1349]: info: CoreStateMachine::getcurrentVolume Apr 28 10:03:06 opera volumio[1349]: info: CoreCommandRouter::volumioRetrievevolume Apr 28 10:03:06 opera volumio[1349]: info: Stopping AccessToken refresher cron for QOBUZ Apr 28 10:03:06 opera volumio[1349]: info: AccessToken refresher cron started for QOBUZ Apr 28 10:03:06 opera volumio[1349]: info: Stopping AccessToken refresher cron Apr 28 10:03:06 opera volumio[1349]: info: AccessToken refresher cron started Apr 28 10:03:06 opera volumio[1349]: info: CoreStateMachine::pushState Apr 28 10:03:06 opera volumio[1349]: info: CorePlayQueue::getTrack 0 Apr 28 10:03:06 opera volumio[1349]: info: CoreCommandRouter::volumioPushState Apr 28 10:03:06 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 10:03:06 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 28 10:03:06 opera sudo[1648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 28 10:03:06 opera sudo[1648]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:03:06 opera sudo[1648]: pam_unix(sudo:session): session closed for user root Apr 28 10:03:06 opera sudo[1651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 28 10:03:06 opera sudo[1651]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:03:06 opera sudo[1659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Apr 28 10:03:06 opera sudo[1651]: pam_unix(sudo:session): session closed for user root Apr 28 10:03:06 opera sudo[1659]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:03:06 opera systemd[1]: Configuration file /lib/systemd/system/volumiobt.service is marked executable. Please remove executable permission bits. Proceeding anyway. Apr 28 10:03:06 opera systemd[1]: Starting Volumio Bluetooth Module... Apr 28 10:03:06 opera systemd[1]: Started Volumio Bluetooth Module. Apr 28 10:03:06 opera sudo[1659]: pam_unix(sudo:session): session closed for user root Apr 28 10:03:06 opera volumio[1349]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 28 10:03:06 opera sudo[1675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Apr 28 10:03:06 opera sudo[1675]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:03:06 opera volumiobt[1671]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Apr 28 10:03:06 opera sudo[1675]: pam_unix(sudo:session): session closed for user root Apr 28 10:03:06 opera volumio[1349]: info: Setting Device type: Tinkerboard Apr 28 10:03:06 opera volumio[1349]: [SpotifyConnect] Vollibrespot Daemon Started Apr 28 10:03:06 opera volumio[1349]: [SpotifyConnect] Starting metadata listener Apr 28 10:03:06 opera volumio[1349]: [SpotifyConnect] FE => [ 1, [length]: 1 ] Apr 28 10:03:06 opera volumio[1349]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'Opera' Apr 28 10:03:06 opera volumio[1349]: We trust you have received the usual lecture from the local System Apr 28 10:03:06 opera volumio[1349]: Administrator. It usually boils down to these three things: Apr 28 10:03:06 opera volumio[1349]: #1) Respect the privacy of others. Apr 28 10:03:06 opera volumio[1349]: #2) Think before you type. Apr 28 10:03:06 opera volumio[1349]: #3) With great power comes great responsibility. Apr 28 10:03:06 opera volumio[1349]: sudo: no tty present and no askpass program specified Apr 28 10:03:06 opera volumio[1349]: info: MPD running with PID691 Apr 28 10:03:06 opera volumio[1349]: ,establishing connection Apr 28 10:03:06 opera sudo[1686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Apr 28 10:03:06 opera sudo[1686]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:03:06 opera sudo[1686]: pam_unix(sudo:session): session closed for user root Apr 28 10:03:06 opera volumio[1349]: info: Volumio BT Module successfully started Apr 28 10:03:06 opera volumio[1349]: info: Apr 28 10:03:06 opera volumio[1349]: ---------------------------- Client requests Volume 35 Apr 28 10:03:06 opera volumio[1349]: info: VolumeController::SetAlsaVolume35 Apr 28 10:03:06 opera volumio[1349]: info: CoreStateMachine::pushState Apr 28 10:03:06 opera volumio[1349]: info: CorePlayQueue::getTrack 0 Apr 28 10:03:06 opera volumio[1349]: info: CoreCommandRouter::volumioPushState Apr 28 10:03:06 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 10:03:07 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 28 10:03:07 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 10:03:07 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 10:03:07 opera volumio[1349]: info: Reloading queue from file Apr 28 10:03:07 opera volumio[1349]: error: updateQueue error: null Apr 28 10:03:07 opera volumio[1349]: error: Failed LSINFO: Error: [50@0] {} No such directory Apr 28 10:03:07 opera volumio[1349]: info: Setting volume on startup at 35 Apr 28 10:03:07 opera volumio[1349]: info: CoreStateMachine::setRepeat true single undefined Apr 28 10:03:07 opera volumio[1349]: info: CoreStateMachine::pushState Apr 28 10:03:07 opera volumio[1349]: info: CorePlayQueue::getTrack 0 Apr 28 10:03:07 opera volumio[1349]: info: CoreCommandRouter::volumioPushState Apr 28 10:03:07 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 10:03:07 opera volumio[1349]: info: CoreStateMachine::setRandom false Apr 28 10:03:07 opera volumio[1349]: info: CoreStateMachine::pushState Apr 28 10:03:07 opera volumio[1349]: info: CorePlayQueue::getTrack 0 Apr 28 10:03:07 opera volumio[1349]: info: CoreCommandRouter::volumioPushState Apr 28 10:03:07 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 10:03:07 opera volumio[1349]: info: Starting Shairport Sync Apr 28 10:03:07 opera volumio[1349]: info: Starting Shairport Sync Apr 28 10:03:07 opera sudo[1698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 28 10:03:07 opera sudo[1698]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:03:07 opera sudo[1700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 28 10:03:07 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Apr 28 10:03:07 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 28 10:03:07 opera sudo[1706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 28 10:03:07 opera sudo[1698]: pam_unix(sudo:session): session closed for user root Apr 28 10:03:07 opera sudo[1700]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:03:07 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 28 10:03:07 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Apr 28 10:03:07 opera sudo[1706]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:03:07 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 28 10:03:07 opera sudo[1700]: pam_unix(sudo:session): session closed for user root Apr 28 10:03:07 opera systemd[1]: Starting UPnP Renderer front-end to MPD... Apr 28 10:03:07 opera systemd[1]: Started UPnP Renderer front-end to MPD. Apr 28 10:03:07 opera sudo[1706]: pam_unix(sudo:session): session closed for user root Apr 28 10:03:07 opera volumio[1349]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 28 10:03:07 opera volumio[1349]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 28 10:03:07 opera volumio[1349]: info: Shairport-Sync Started Apr 28 10:03:07 opera volumio[1349]: Error adding Membership: Error: addMembership EINVAL Apr 28 10:03:07 opera volumio[1349]: Discovery: adding d698e710-d62c-46fb-8a42-2d8604f39f27 Apr 28 10:03:07 opera volumio[1349]: info: mDNS: Found device Opera Apr 28 10:03:07 opera volumio[1349]: info: CoreCommandRouter::volumioGetState Apr 28 10:03:07 opera volumio[1349]: info: CorePlayQueue::getTrack 0 Apr 28 10:03:07 opera volumio[1349]: error: Could not retrieve plugin audio_interface multiroom Apr 28 10:03:07 opera volumio[1349]: error: Could not retrieve plugin audio_interface multiroom Apr 28 10:03:07 opera volumio[1349]: info: Upmpdcli Daemon Started Apr 28 10:03:07 opera volumio[1349]: info: Shairport-Sync Started Apr 28 10:03:07 opera volumio[1349]: info: CoreCommandRouter::volumioGetState Apr 28 10:03:07 opera volumio[1349]: info: CorePlayQueue::getTrack 0 Apr 28 10:03:07 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 28 10:03:07 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 28 10:03:07 opera volumio[1349]: No protocol specified Apr 28 10:03:07 opera volumio[1349]: xcb_connection_has_error() returned true Apr 28 10:03:07 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 28 10:03:07 opera systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Apr 28 10:03:07 opera systemd[1]: Stopping Volspotconnect2 Daemon... Apr 28 10:03:07 opera systemd[1]: Starting Volspotconnect2 Daemon... Apr 28 10:03:07 opera systemd[1]: Started Volspotconnect2 Daemon. Apr 28 10:03:07 opera volumio[1349]: info: Volumio called home Apr 28 10:03:07 opera volumio[1757]: vollibrespot v0.1.9 c98fd5d 2019-11-08 (librespot 4674946 2019-11-08) -- Built On 2019-11-08 Apr 28 10:03:07 opera sudo[1761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Apr 28 10:03:07 opera sudo[1761]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 10:03:07 opera volumiobt[1671]: pulseaudio: no process found Apr 28 10:03:07 opera sudo[1761]: pam_unix(sudo:session): session closed for user root Apr 28 10:03:07 opera volumio[1757]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Apr 28 10:03:07 opera dbus[692]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Apr 28 10:03:07 opera systemd[1]: Starting RealtimeKit Scheduling Policy Service... Apr 28 10:03:07 opera volumio[1349]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 28 10:03:07 opera kernel: IPVS: Creating netns size=1496 id=2 Apr 28 10:03:07 opera kernel: IPVS: ftp: loaded support on port[0] = 21 Apr 28 10:03:07 opera dbus[692]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Apr 28 10:03:07 opera systemd[1]: Started RealtimeKit Scheduling Policy Service. Apr 28 10:03:07 opera rtkit-daemon[1773]: Successfully called chroot. Apr 28 10:03:07 opera rtkit-daemon[1773]: Successfully dropped privileges. Apr 28 10:03:07 opera rtkit-daemon[1773]: Successfully limited resources. Apr 28 10:03:07 opera rtkit-daemon[1773]: Running. Apr 28 10:03:07 opera rtkit-daemon[1773]: Watchdog thread running. Apr 28 10:03:07 opera rtkit-daemon[1773]: Canary thread running. Apr 28 10:03:08 opera pulseaudio[1772]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 28 10:03:08 opera pulseaudio[1772]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 28 10:03:08 opera volumiobt[1671]: Applying permissions Apr 28 10:03:08 opera volumiobt[1671]: Setting BT discoverable and pairable Apr 28 10:03:08 opera pulseaudio[1772]: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist Apr 28 10:03:08 opera bluetoothd[869]: Endpoint registered: sender=:1.19 path=/MediaEndpoint/A2DPSource Apr 28 10:03:08 opera bluetoothd[869]: Endpoint registered: sender=:1.19 path=/MediaEndpoint/A2DPSink Apr 28 10:03:08 opera volumiobt[1671]: [103B blob data] Apr 28 10:03:08 opera volumiobt[1671]: [79B blob data] Apr 28 10:03:08 opera volumiobt[1671]: [79B blob data] Apr 28 10:03:08 opera volumiobt[1671]: [79B blob data] Apr 28 10:03:08 opera volumiobt[1671]: [79B blob data] Apr 28 10:03:08 opera volumiobt[1671]: [86B blob data] Apr 28 10:03:08 opera volumiobt[1671]: [bluetooth]# -e power on Apr 28 10:03:08 opera volumiobt[1671]: Invalid command Apr 28 10:03:08 opera volumiobt[1671]: [bluetooth]# agent on Apr 28 10:03:08 opera volumiobt[1671]: [bluetooth]# discoverable on Apr 28 10:03:08 opera volumiobt[1671]: [bluetooth]# pairable on Apr 28 10:03:08 opera volumiobt[1671]: [bluetooth]# agent NoInputNoOutput Apr 28 10:03:08 opera volumiobt[1671]: Failed to register agent object Apr 28 10:03:08 opera volumiobt[1671]: [bluetooth]# default-agent Apr 28 10:03:08 opera volumiobt[1671]: No agent is registered Apr 28 10:03:08 opera volumiobt[1671]: [bluetooth]# quit Apr 28 10:03:08 opera volumiobt[1671]: [61B blob data] Apr 28 10:03:08 opera volumiobt[1671]: [89B blob data] Apr 28 10:03:08 opera volumiobt[1671]: [62B blob data] Apr 28 10:03:09 opera volumio-streaming-daemon[1606]: Checking variant in static cache Apr 28 10:03:09 opera volumio[1349]: info: Fetching Streaming Services browse cache Apr 28 10:03:10 opera volumio-remote-updater[664]: [2025-04-28 10:03:10] [connect] Successful connection Apr 28 10:03:10 opera volumio-remote-updater[664]: [2025-04-28 10:03:10] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1745834590 101 Apr 28 10:03:12 opera volumio[1349]: info: CoreCommandRouter::volumioGetState Apr 28 10:03:12 opera volumio[1349]: info: CorePlayQueue::getTrack 0 Apr 28 10:03:13 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 28 10:03:13 opera volumio[1349]: error: Could not retrieve plugin audio_interface multiroom Apr 28 10:03:13 opera volumio[1349]: info: Listing playlists Apr 28 10:03:13 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 28 10:03:13 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 28 10:03:13 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 28 10:03:13 opera volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 28 10:03:13 opera volumio[1349]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 10:03:13 opera volumio[1349]: { Error: connect ECONNREFUSED 130.211.15.150:443 Apr 28 10:03:13 opera volumio[1349]: at Object._errnoException (util.js:1022:11) Apr 28 10:03:13 opera volumio[1349]: at _exceptionWithHostPort (util.js:1044:20) Apr 28 10:03:13 opera volumio[1349]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 28 10:03:13 opera volumio[1349]: code: 'ECONNREFUSED', Apr 28 10:03:13 opera volumio[1349]: errno: 'ECONNREFUSED', Apr 28 10:03:13 opera volumio[1349]: syscall: 'connect', Apr 28 10:03:13 opera volumio[1349]: address: '130.211.15.150', Apr 28 10:03:13 opera volumio[1349]: port: 443 } Apr 28 10:03:13 opera volumio[1349]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 10:03:14 opera sudo[1816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-28 10:02 Apr 28 10:03:14 opera sudo[1816]: 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"