-- Logs begin at Sun 2025-01-19 15:28:46 UTC, end at Sun 2025-01-19 15:49:09 UTC. -- Jan 19 15:48:24 opera systemd[1]: mpd.service: main process exited, code=killed, status=11/SEGV Jan 19 15:48:24 opera systemd[1]: Unit mpd.service entered failed state. Jan 19 15:48:24 opera volumio[955]: error: Upnp client error: Error: This socket has been ended by the other party Jan 19 15:48:31 opera volumio[955]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BE%90%E5%B0%8F%E9%B3%B3/7909bda8-c3f0-490f-bb06-8f59ffd596b1.jpg' Jan 19 15:48:32 opera volumio[955]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 19 15:48:32 opera volumio[955]: { Error: connect ETIMEDOUT 74.86.12.173:80 Jan 19 15:48:32 opera volumio[955]: at Object._errnoException (util.js:1022:11) Jan 19 15:48:32 opera volumio[955]: at _exceptionWithHostPort (util.js:1044:20) Jan 19 15:48:32 opera volumio[955]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jan 19 15:48:32 opera volumio[955]: code: 'ETIMEDOUT', Jan 19 15:48:32 opera volumio[955]: errno: 'ETIMEDOUT', Jan 19 15:48:32 opera volumio[955]: syscall: 'connect', Jan 19 15:48:32 opera volumio[955]: address: '74.86.12.173', Jan 19 15:48:32 opera volumio[955]: port: 80 } Jan 19 15:48:32 opera volumio[955]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 19 15:48:32 opera sudo[4359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-19 15:47 Jan 19 15:48:32 opera sudo[4359]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 15:48:32 opera sudo[4359]: pam_unix(sudo:session): session closed for user root Jan 19 15:48:33 opera volumio-remote-updater[692]: [2025-01-19 15:48:33] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jan 19 15:48:33 opera volumio-remote-updater[692]: [2025-01-19 15:48:33] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jan 19 15:48:33 opera systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Jan 19 15:48:33 opera systemd[1]: Unit volumio.service entered failed state. Jan 19 15:48:33 opera systemd[1]: Starting dynamicswap service... Jan 19 15:48:33 opera systemd[1]: Started dynamicswap service. Jan 19 15:48:34 opera systemd[1]: volumio.service holdoff time over, scheduling restart. Jan 19 15:48:34 opera systemd[1]: Starting dynamicswap service... Jan 19 15:48:34 opera systemd[1]: Started dynamicswap service. Jan 19 15:48:34 opera systemd[1]: Stopping Volumio Backend Module... Jan 19 15:48:34 opera systemd[1]: Starting Volumio Backend Module... Jan 19 15:48:34 opera systemd[1]: Started Volumio Backend Module. Jan 19 15:48:35 opera volumio[4385]: info: ------------------------------------------- Jan 19 15:48:35 opera volumio[4385]: info: ----- Volumio2 ---- Jan 19 15:48:35 opera volumio[4385]: info: ------------------------------------------- Jan 19 15:48:35 opera volumio[4385]: info: ----- System startup ---- Jan 19 15:48:35 opera volumio[4385]: info: ------------------------------------------- Jan 19 15:48:35 opera volumio[4385]: info: Plugin folders cleanup Jan 19 15:48:35 opera volumio[4385]: info: Scanning into folder /volumio/app/plugins/ Jan 19 15:48:35 opera volumio[4385]: info: Scanning category audio_interface Jan 19 15:48:35 opera volumio[4385]: info: Scanning category miscellanea Jan 19 15:48:35 opera volumio[4385]: info: Scanning category music_service Jan 19 15:48:35 opera volumio[4385]: info: Scanning category plugins.json Jan 19 15:48:35 opera volumio[4385]: info: Scanning category system_controller Jan 19 15:48:35 opera volumio[4385]: info: Scanning category user_interface Jan 19 15:48:35 opera volumio[4385]: info: Scanning into folder /data/plugins/ Jan 19 15:48:35 opera volumio[4385]: info: Plugin folders cleanup completed Jan 19 15:48:35 opera volumio[4385]: info: ------------------------------------------- Jan 19 15:48:35 opera volumio[4385]: info: ----- Core plugins startup ---- Jan 19 15:48:35 opera volumio[4385]: info: ------------------------------------------- Jan 19 15:48:35 opera volumio[4385]: info: Loading plugins from folder /volumio/app/plugins/ Jan 19 15:48:35 opera volumio[4385]: info: Adding plugin bluetooth to MyMusic Plugins Jan 19 15:48:35 opera volumio[4385]: info: Adding plugin upnp to MyMusic Plugins Jan 19 15:48:35 opera volumio[4385]: info: Adding plugin metavolumio to MyMusic Plugins Jan 19 15:48:35 opera volumio[4385]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 19 15:48:35 opera volumio[4385]: info: Adding plugin cd_controller to MyMusic Plugins Jan 19 15:48:35 opera volumio[4385]: info: Adding plugin raat to MyMusic Plugins Jan 19 15:48:35 opera volumio[4385]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 19 15:48:35 opera volumio[4385]: info: Adding plugin volspotconnect2 to MyMusic Plugins Jan 19 15:48:35 opera volumio[4385]: info: Loading plugins from folder /data/plugins/ Jan 19 15:48:35 opera volumio[4385]: info: Loading plugin "system"... Jan 19 15:48:36 opera volumio[4385]: info: Loading plugin "appearance"... Jan 19 15:48:36 opera volumio[4385]: info: Loading plugin "network"... Jan 19 15:48:36 opera volumio[4385]: info: Refreshing Cached IP Addresses Jan 19 15:48:36 opera sudo[4413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 19 15:48:36 opera volumio[4385]: info: Loading plugin "services"... Jan 19 15:48:36 opera sudo[4413]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 15:48:36 opera volumio[4385]: info: Loading plugin "alsa_controller"... Jan 19 15:48:36 opera sudo[4413]: pam_unix(sudo:session): session closed for user root Jan 19 15:48:36 opera sudo[4416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 19 15:48:36 opera sudo[4416]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 15:48:36 opera sudo[4416]: pam_unix(sudo:session): session closed for user root Jan 19 15:48:36 opera volumio[4385]: info: Loading plugin "wizard"... Jan 19 15:48:36 opera volumio[4385]: info: Loading plugin "volumio_command_line_client"... Jan 19 15:48:36 opera volumio[4385]: info: Loading plugin "upnp"... Jan 19 15:48:36 opera volumio[4385]: info: [1737301716962] Starting Upmpd Daemon Jan 19 15:48:36 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 19 15:48:36 opera volumio[4385]: info: Loading plugin "my_music"... Jan 19 15:48:36 opera volumio[4385]: info: Loading plugin "mpd"... Jan 19 15:48:37 opera volumio[4385]: info: Loading plugin "upnp_browser"... Jan 19 15:48:37 opera volumio[4385]: info: Loading plugin "networkfs"... Jan 19 15:48:37 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 19 15:48:37 opera volumio[4385]: info: Loading plugin "bluetooth"... Jan 19 15:48:37 opera volumio[4385]: info: [1737301717784] Starting BluetoothController Jan 19 15:48:37 opera volumio[4385]: info: Loading plugin "alarm-clock"... Jan 19 15:48:37 opera volumio[4385]: info: Loading plugin "metavolumio"... Jan 19 15:48:38 opera volumio-remote-updater[692]: [2025-01-19 15:48:38] [connect] Successful connection Jan 19 15:48:38 opera volumio[4385]: info: Loading plugin "airplay_emulation"... Jan 19 15:48:38 opera volumio[4385]: info: Starting Shairport Sync Jan 19 15:48:38 opera volumio[4385]: info: Loading plugin "cd_controller"... Jan 19 15:48:38 opera volumio[4385]: info: Loading plugin "last_100"... Jan 19 15:48:38 opera volumio[4385]: info: Loading plugin "raat"... Jan 19 15:48:38 opera volumio[4385]: info: RAAT Plugin loaded Jan 19 15:48:38 opera volumio[4385]: info: Adding restartRAATSocket REST API Endpoint Jan 19 15:48:38 opera volumio[4385]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Jan 19 15:48:38 opera volumio[4385]: info: Loading plugin "streaming_services"... Jan 19 15:48:39 opera volumio[4385]: info: Loading plugin "webradio"... Jan 19 15:48:39 opera volumio[4385]: info: Loading plugin "i2s_dacs"... Jan 19 15:48:39 opera volumio[4385]: info: I2S DAC not set, start Auto-detection Jan 19 15:48:39 opera volumio[4385]: info: Loading plugin "volumiodiscovery"... Jan 19 15:48:39 opera volumio[4385]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 19 15:48:39 opera node[4385]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 19 15:48:39 opera node[4385]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 19 15:48:39 opera node[4385]: *** WARNING *** For more information see Jan 19 15:48:39 opera node[4385]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 19 15:48:39 opera node[4385]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 19 15:48:39 opera node[4385]: *** WARNING *** For more information see Jan 19 15:48:39 opera volumio[4385]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 19 15:48:39 opera volumio[4385]: *** WARNING *** For more information see Jan 19 15:48:39 opera volumio[4385]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 19 15:48:39 opera volumio[4385]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 19 15:48:39 opera volumio[4385]: *** WARNING *** For more information see Jan 19 15:48:39 opera volumio[4385]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 19 15:48:39 opera volumio[4385]: Discovery: StartAdv! undefined Jan 19 15:48:39 opera volumio[4385]: Discovery: Started advertising... Opera - undefined Jan 19 15:48:39 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 19 15:48:39 opera volumio[4385]: info: Loading plugin "outputs"... Jan 19 15:48:39 opera volumio[4385]: info: Loading plugin "albumart"... Jan 19 15:48:39 opera volumio[4385]: info: Plugin example_plugin is not enabled Jan 19 15:48:39 opera volumio[4385]: info: Loading plugin "hi_res_audio"... Jan 19 15:48:39 opera volumio[4385]: Forking 3 albumart workers Jan 19 15:48:40 opera volumio[4385]: Starting albumart workers Jan 19 15:48:40 opera volumio[4385]: Starting albumart workers Jan 19 15:48:40 opera volumio[4385]: info: Applying required configuration parameters for plugin hi_res_audio Jan 19 15:48:40 opera volumio[4385]: info: Loading plugin "inputs"... Jan 19 15:48:40 opera volumio[4385]: info: Loading plugin "qobuz"... Jan 19 15:48:40 opera volumio[4385]: Starting albumart workers Jan 19 15:48:41 opera volumio[4385]: info: Loading plugin "tidal"... Jan 19 15:48:42 opera volumio[4385]: info: Loading plugin "volspotconnect2"... Jan 19 15:48:42 opera volumio[4385]: info: Loading plugin "updater_comm"... Jan 19 15:48:42 opera volumio[4385]: info: Plugin mpdemulation is not enabled Jan 19 15:48:42 opera volumio[4385]: info: Loading plugin "rest_api"... Jan 19 15:48:42 opera volumio[4385]: info: Loading plugin "websocket"... Jan 19 15:48:42 opera volumio[4385]: info: ___________ START PLUGINS ___________ Jan 19 15:48:42 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 19 15:48:42 opera volumio[4385]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 19 15:48:42 opera volumio[4385]: info: [1737301722966] CoreMusicLibrary::Adding element Media Servers Jan 19 15:48:42 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 19 15:48:42 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 19 15:48:43 opera volumio[4385]: info: Adding METAVOLUMIO REST API Endpoints Jan 19 15:48:43 opera volumio[4385]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jan 19 15:48:43 opera sudo[4490]: pam_unix(sudo:auth): conversation failed Jan 19 15:48:43 opera sudo[4490]: pam_unix(sudo:auth): auth could not identify password for [volumio] Jan 19 15:48:43 opera volumio[4385]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 19 15:48:43 opera volumio[4385]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 19 15:48:43 opera volumio[4385]: info: Preparing CD Folders Jan 19 15:48:43 opera volumio[4385]: info: Adding CD REST API Endpoints Jan 19 15:48:43 opera volumio[4385]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Jan 19 15:48:43 opera volumio[4385]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Jan 19 15:48:43 opera volumio[4385]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Jan 19 15:48:43 opera volumio[4385]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jan 19 15:48:43 opera volumio[4385]: info: Detecting CD presence with Flag file Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 19 15:48:43 opera volumio[4385]: info: [1737301723096] CoreMusicLibrary::Adding element Last_100 Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 19 15:48:43 opera volumio[4385]: info: Starting RAAT Plugin Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Jan 19 15:48:43 opera volumio[4385]: info: Additional UI Settings Added for plugin music_service/raat Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 19 15:48:43 opera volumio[4385]: info: Not Reporting Auto name since its the default one Jan 19 15:48:43 opera volumio[4385]: info: Streaming services startup Jan 19 15:48:43 opera volumio[4385]: info: Starting Streaming Daemon Jan 19 15:48:43 opera sudo[4505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 19 15:48:43 opera sudo[4505]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 19 15:48:43 opera volumio[4385]: info: [1737301723165] CoreMusicLibrary::Adding element Webradio Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 19 15:48:43 opera systemd[1]: Stopping Volumio Streaming Daemon... Jan 19 15:48:43 opera systemd[1]: Starting Volumio Streaming Daemon... Jan 19 15:48:43 opera systemd[1]: Started Volumio Streaming Daemon. Jan 19 15:48:43 opera volumio[4385]: error: Hi Res Audio Failed Login: Missing Login Data Jan 19 15:48:43 opera sudo[4505]: pam_unix(sudo:session): session closed for user root Jan 19 15:48:43 opera volumio-streaming-daemon[4515]: ############################ Jan 19 15:48:43 opera volumio-streaming-daemon[4515]: # Volumio Streaming Daemon # Jan 19 15:48:43 opera volumio-streaming-daemon[4515]: # Running on port 7777 # Jan 19 15:48:43 opera volumio-streaming-daemon[4515]: ############################ Jan 19 15:48:43 opera volumio-streaming-daemon[4515]: Checking variant in static cache Jan 19 15:48:43 opera volumio-streaming-daemon[4515]: Enabled services: Jan 19 15:48:43 opera volumio-streaming-daemon[4515]: 1) tidal Jan 19 15:48:43 opera volumio-streaming-daemon[4515]: 2) qobuz Jan 19 15:48:43 opera volumio[4385]: info: Loading i18n strings for locale zh Jan 19 15:48:43 opera sudo[4527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jan 19 15:48:43 opera volumio[4385]: Updating browse sources language Jan 19 15:48:43 opera volumio[4385]: Cannot find translation for sourceMedia Servers Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 19 15:48:43 opera sudo[4527]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 15:48:43 opera systemd[1]: Started Volspotconnect2 Daemon. Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 19 15:48:43 opera sudo[4527]: pam_unix(sudo:session): session closed for user root Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::initPlayerControls Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 19 15:48:43 opera volumio[4385]: info: BOOT COMPLETED Jan 19 15:48:43 opera volumio[4385]: [Metrics] CommandRouter: 7s 912.61ms Jan 19 15:48:43 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 19 15:48:48 opera volumio[4385]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jan 19 15:48:48 opera volumio[4385]: info: CoreCommandRouter::Close All Modals sent Jan 19 15:48:48 opera volumio[4385]: info: CoreCommandRouter::Close All Modals sent Jan 19 15:48:48 opera volumio[4385]: Express server listening on port 3000 Jan 19 15:48:48 opera volumio[4385]: [Metrics] WebUI: 13s 874.52ms Jan 19 15:48:48 opera volumio[4385]: Volumio Calling Home Jan 19 15:48:48 opera volumio[4385]: info: CoreStateMachine::resetVolumioState Jan 19 15:48:48 opera volumio[4385]: info: CoreStateMachine::getcurrentVolume Jan 19 15:48:48 opera volumio[4385]: info: CoreCommandRouter::volumioRetrievevolume Jan 19 15:48:48 opera volumio[4385]: info: Stopping AccessToken refresher cron for QOBUZ Jan 19 15:48:48 opera volumio[4385]: info: AccessToken refresher cron started for QOBUZ Jan 19 15:48:48 opera volumio[4385]: info: Stopping AccessToken refresher cron Jan 19 15:48:48 opera volumio[4385]: info: AccessToken refresher cron started Jan 19 15:48:48 opera volumio[4385]: info: CoreStateMachine::pushState Jan 19 15:48:48 opera volumio[4385]: info: CorePlayQueue::getTrack 0 Jan 19 15:48:48 opera volumio[4385]: info: CoreCommandRouter::volumioPushState Jan 19 15:48:48 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 19 15:48:49 opera sudo[4550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jan 19 15:48:49 opera sudo[4550]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 15:48:49 opera systemd[1]: Started Volumio Bluetooth Module. Jan 19 15:48:49 opera sudo[4550]: pam_unix(sudo:session): session closed for user root Jan 19 15:48:49 opera sudo[4559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 19 15:48:49 opera sudo[4559]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 15:48:49 opera sudo[4559]: pam_unix(sudo:session): session closed for user root Jan 19 15:48:49 opera volumio[4385]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 19 15:48:49 opera sudo[4562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 19 15:48:49 opera sudo[4562]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 15:48:49 opera sudo[4562]: pam_unix(sudo:session): session closed for user root Jan 19 15:48:49 opera systemd[1]: Starting Music Player Daemon... Jan 19 15:48:49 opera volumio[4385]: info: Volumio BT Module successfully started Jan 19 15:48:49 opera volumio[4385]: info: Setting Device type: Tinkerboard Jan 19 15:48:49 opera volumio[4385]: [SpotifyConnect] Vollibrespot Daemon Started Jan 19 15:48:49 opera volumio[4385]: [SpotifyConnect] Starting metadata listener Jan 19 15:48:49 opera volumio[4385]: [SpotifyConnect] FE => [ 1, [length]: 1 ] Jan 19 15:48:49 opera volumio[4385]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'Opera' Jan 19 15:48:49 opera volumio[4385]: We trust you have received the usual lecture from the local System Jan 19 15:48:49 opera volumio[4385]: Administrator. It usually boils down to these three things: Jan 19 15:48:49 opera volumio[4385]: #1) Respect the privacy of others. Jan 19 15:48:49 opera volumio[4385]: #2) Think before you type. Jan 19 15:48:49 opera volumio[4385]: #3) With great power comes great responsibility. Jan 19 15:48:49 opera volumio[4385]: sudo: no tty present and no askpass program specified Jan 19 15:48:49 opera volumio[4385]: error: Cannot initialize MPD Connection: MPD is not running Jan 19 15:48:49 opera sudo[4579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Jan 19 15:48:49 opera sudo[4579]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 15:48:49 opera sudo[4579]: pam_unix(sudo:session): session closed for user root Jan 19 15:48:49 opera volumio[4385]: info: Jan 19 15:48:49 opera volumio[4385]: ---------------------------- Client requests Volume 5 Jan 19 15:48:49 opera volumio[4385]: info: VolumeController::SetAlsaVolume5 Jan 19 15:48:49 opera volumio[4385]: info: CoreStateMachine::pushState Jan 19 15:48:49 opera volumio[4385]: info: CorePlayQueue::getTrack 0 Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::volumioPushState Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jan 19 15:48:49 opera volumio[4385]: No protocol specified Jan 19 15:48:49 opera volumio[4385]: xcb_connection_has_error() returned true Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 19 15:48:49 opera volumio[4385]: info: Reloading queue from file Jan 19 15:48:49 opera sudo[4590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jan 19 15:48:49 opera sudo[4590]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 15:48:49 opera systemd[1]: Stopping RAAT DAEMON... Jan 19 15:48:49 opera systemd[1]: Starting RAAT DAEMON... Jan 19 15:48:49 opera systemd[1]: Started RAAT DAEMON. Jan 19 15:48:49 opera sudo[4590]: pam_unix(sudo:session): session closed for user root Jan 19 15:48:49 opera volumio[4385]: info: Setting volume on startup at 5 Jan 19 15:48:49 opera volumio[4385]: info: CoreStateMachine::setRepeat null single undefined Jan 19 15:48:49 opera volumio[4385]: info: CoreStateMachine::pushState Jan 19 15:48:49 opera volumio[4385]: info: CorePlayQueue::getTrack 0 Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::volumioPushState Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 15:48:49 opera volumio[4385]: info: CoreStateMachine::setRandom null Jan 19 15:48:49 opera volumio[4385]: info: CoreStateMachine::pushState Jan 19 15:48:49 opera volumio[4385]: info: CorePlayQueue::getTrack 0 Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::volumioPushState Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 15:48:49 opera volumio[4385]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 19 15:48:49 opera volumio[4385]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 19 15:48:49 opera volumio[4385]: info: Raat Daemon started successfully Jan 19 15:48:49 opera volumio[4385]: info: Volumio called home Jan 19 15:48:49 opera volumio[4385]: info: Starting Shairport Sync Jan 19 15:48:49 opera volumio[4385]: info: Starting Shairport Sync Jan 19 15:48:49 opera sudo[4614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 19 15:48:49 opera sudo[4614]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 15:48:49 opera sudo[4618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 19 15:48:49 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 19 15:48:49 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jan 19 15:48:49 opera sudo[4618]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 15:48:49 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 19 15:48:49 opera sudo[4614]: pam_unix(sudo:session): session closed for user root Jan 19 15:48:49 opera sudo[4628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 19 15:48:49 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 19 15:48:49 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jan 19 15:48:49 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 19 15:48:49 opera sudo[4618]: pam_unix(sudo:session): session closed for user root Jan 19 15:48:49 opera sudo[4628]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 15:48:49 opera volumio[4385]: info: Executing endpoint restartRAATSocket Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jan 19 15:48:49 opera systemd[1]: Started UPnP Renderer front-end to MPD. Jan 19 15:48:49 opera sudo[4628]: pam_unix(sudo:session): session closed for user root Jan 19 15:48:49 opera volumio[4385]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 19 15:48:49 opera volumio[4385]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 19 15:48:49 opera volumio[4385]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 19 15:48:49 opera volumio[4385]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 19 15:48:49 opera volumio[4385]: info: Shairport-Sync Started Jan 19 15:48:49 opera volumio[4385]: Error adding Membership: Error: addMembership EINVAL Jan 19 15:48:49 opera volumio[4385]: info: Shairport-Sync Started Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 19 15:48:49 opera volumio[4385]: No protocol specified Jan 19 15:48:49 opera volumio[4385]: xcb_connection_has_error() returned true Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 19 15:48:49 opera volumio[4385]: Discovery: adding b0edabbb-63ff-47db-a139-60349f568f5f Jan 19 15:48:49 opera volumio[4385]: info: mDNS: Found device Opera Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::volumioGetState Jan 19 15:48:49 opera volumio[4385]: info: CorePlayQueue::getTrack 0 Jan 19 15:48:49 opera volumio[4385]: error: Could not retrieve plugin audio_interface multiroom Jan 19 15:48:49 opera volumio[4385]: error: Could not retrieve plugin audio_interface multiroom Jan 19 15:48:49 opera volumio[4385]: info: CorePlayQueue::getTrack 0 Jan 19 15:48:49 opera volumio[4385]: info: Upmpdcli Daemon Started Jan 19 15:48:49 opera volumio[4385]: info: CoreCommandRouter::volumioGetState Jan 19 15:48:49 opera volumio[4385]: info: CorePlayQueue::getTrack 0 Jan 19 15:48:50 opera systemd[1]: Started Music Player Daemon. Jan 19 15:48:51 opera volumio-remote-updater[692]: [2025-01-19 15:48:51] [connect] Successful connection Jan 19 15:48:51 opera volumio-remote-updater[692]: [2025-01-19 15:48:51] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1737301731 101 Jan 19 15:48:51 opera volumio-streaming-daemon[4515]: Checking variant in static cache Jan 19 15:48:51 opera volumio[4385]: info: Fetching Streaming Services browse cache Jan 19 15:48:52 opera volumio[4385]: info: CoreCommandRouter::volumioGetState Jan 19 15:48:52 opera volumio[4385]: info: CorePlayQueue::getTrack 0 Jan 19 15:48:52 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 19 15:48:52 opera volumio[4385]: error: Could not retrieve plugin audio_interface multiroom Jan 19 15:48:52 opera volumio[4385]: info: Listing playlists Jan 19 15:48:54 opera volumio[4385]: info: CoreCommandRouter::volumioGetState Jan 19 15:48:54 opera volumio[4385]: info: CorePlayQueue::getTrack 0 Jan 19 15:48:54 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 19 15:48:54 opera volumio[4385]: error: Could not retrieve plugin audio_interface multiroom Jan 19 15:48:54 opera volumio[4385]: info: Listing playlists Jan 19 15:48:54 opera volumio[4385]: info: CoreCommandRouter::volumioGetVisibleSources Jan 19 15:48:54 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 19 15:48:54 opera volumio[4385]: info: CoreCommandRouter::volumioGetQueue Jan 19 15:48:54 opera volumio[4385]: info: CoreStateMachine::getQueue Jan 19 15:48:54 opera volumio[4385]: info: CorePlayQueue::getQueue Jan 19 15:48:57 opera volumio[4385]: info: CoreCommandRouter::volumioNext Jan 19 15:48:57 opera volumio[4385]: info: CoreStateMachine::next Jan 19 15:48:57 opera volumio[4385]: info: CoreStateMachine::stop Jan 19 15:48:57 opera volumio[4385]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 15:48:57 opera volumio[4385]: verbose: UNSET VOLATILE Jan 19 15:48:57 opera volumio[4385]: info: CoreStateMachine::play index undefined Jan 19 15:48:57 opera volumio[4385]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 15:48:57 opera volumio[4385]: info: CorePlayQueue::getTrack 1 Jan 19 15:48:57 opera volumio[4385]: info: CoreStateMachine::startPlaybackTimer Jan 19 15:48:57 opera volumio[4385]: info: CorePlayQueue::getTrack 1 Jan 19 15:48:57 opera volumio[4385]: verbose: ControllerMpd::clearAddPlayTracks USB/My Book/唱片公司专辑/01瑞鸣专辑/瑞鸣_小曲儿(德版)/02京韵大鼓：剑阁闻铃.wav Jan 19 15:48:57 opera volumio[4385]: verbose: ControllerMpd::sendMpdCommand stop Jan 19 15:49:09 opera volumio[4385]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 19 15:49:09 opera volumio[4385]: info: CoreStateMachine::ClearQueue Jan 19 15:49:09 opera volumio[4385]: info: CoreStateMachine::stop Jan 19 15:49:09 opera volumio[4385]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 15:49:09 opera volumio[4385]: verbose: UNSET VOLATILE Jan 19 15:49:09 opera volumio[4385]: info: CorePlayQueue::clearPlayQueue Jan 19 15:49:09 opera volumio[4385]: info: CorePlayQueue::saveQueue Jan 19 15:49:09 opera volumio[4385]: info: CoreCommandRouter::volumioPushState Jan 19 15:49:09 opera volumio[4385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 15:49:09 opera volumio[4385]: info: CoreCommandRouter::volumioPushQueue Jan 19 15:49:09 opera volumio[4385]: info: CoreStateMachine::addQueueItems Jan 19 15:49:09 opera volumio[4385]: info: CorePlayQueue::addQueueItems Jan 19 15:49:09 opera volumio[4385]: info: Adding Item to queue: music-library/USB/My Book/唱片公司专辑/01瑞鸣专辑/瑞鸣_小曲儿(德版)/01东北二人转：大西厢.wav Jan 19 15:49:09 opera volumio[4385]: info: Exploding uri music-library/USB/My Book/唱片公司专辑/01瑞鸣专辑/瑞鸣_小曲儿(德版)/01东北二人转：大西厢.wav in service mpd Jan 19 15:49:09 opera volumio[4385]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 19 15:49:09 opera volumio[4385]: TypeError: Cannot read property 'then' of undefined Jan 19 15:49:09 opera volumio[4385]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2479:19) Jan 19 15:49:09 opera volumio[4385]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2277:21) Jan 19 15:49:09 opera volumio[4385]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1283:16) Jan 19 15:49:09 opera volumio[4385]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:144:48) Jan 19 15:49:09 opera volumio[4385]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:238:25) Jan 19 15:49:09 opera volumio[4385]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:476:23) Jan 19 15:49:09 opera volumio[4385]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:452:17) Jan 19 15:49:09 opera volumio[4385]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:106:35) Jan 19 15:49:09 opera volumio[4385]: at emitTwo (events.js:126:13) Jan 19 15:49:09 opera volumio[4385]: at Socket.emit (events.js:214:7) Jan 19 15:49:09 opera volumio[4385]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jan 19 15:49:09 opera volumio[4385]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jan 19 15:49:09 opera volumio[4385]: at process._tickCallback (internal/process/next_tick.js:180:9) Jan 19 15:49:09 opera volumio[4385]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 19 15:49:09 opera sudo[4736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-19 15:48 Jan 19 15:49:09 opera sudo[4736]: 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"