-- Logs begin at Sat 2024-06-29 19:42:30 EDT, end at Sun 2024-09-08 00:17:25 EDT. -- Sep 08 00:16:43 bedroom-shd systemd[1]: Starting Daily apt download activities... Sep 08 00:16:45 bedroom-shd systemd[1]: apt-daily.service: Succeeded. Sep 08 00:16:45 bedroom-shd systemd[1]: Started Daily apt download activities. Sep 08 00:16:45 bedroom-shd systemd[1]: Starting Daily apt upgrade and clean activities... Sep 08 00:16:45 bedroom-shd volumio-remote-updater[454]: [2024-09-08 00:16:45] [connect] Successful connection Sep 08 00:16:45 bedroom-shd volumio[796]: info: Loading plugin "network"... Sep 08 00:16:45 bedroom-shd volumio[796]: info: Refreshing Cached IP Addresses Sep 08 00:16:45 bedroom-shd sudo[916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 08 00:16:45 bedroom-shd sudo[916]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:16:45 bedroom-shd sudo[916]: pam_unix(sudo:session): session closed for user root Sep 08 00:16:45 bedroom-shd volumio[796]: info: Loading plugin "services"... Sep 08 00:16:45 bedroom-shd sudo[919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 08 00:16:45 bedroom-shd sudo[919]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:16:45 bedroom-shd volumio[796]: info: Loading plugin "alsa_controller"... Sep 08 00:16:45 bedroom-shd sudo[919]: pam_unix(sudo:session): session closed for user root Sep 08 00:16:45 bedroom-shd sudo[923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 08 00:16:45 bedroom-shd sudo[923]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:16:45 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 08 00:16:45 bedroom-shd volumio[796]: info: Loading plugin "wizard"... Sep 08 00:16:45 bedroom-shd volumio[796]: info: Loading plugin "networkfs"... Sep 08 00:16:45 bedroom-shd volumio[796]: info: Starting Udev Watcher for removable devices Sep 08 00:16:46 bedroom-shd volumio[796]: info: Ignoring mount for partition: BOOT Sep 08 00:16:46 bedroom-shd volumio[796]: info: Ignoring mount for partition: volumio Sep 08 00:16:46 bedroom-shd volumio[796]: info: Ignoring mount for partition: volumio_data Sep 08 00:16:46 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 08 00:16:46 bedroom-shd volumio[796]: info: Loading plugin "volumio_command_line_client"... Sep 08 00:16:46 bedroom-shd volumio[796]: info: Loading plugin "upnp"... Sep 08 00:16:46 bedroom-shd volumio[796]: info: [1725769006118] Starting Upmpd Daemon Sep 08 00:16:46 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 08 00:16:46 bedroom-shd volumio[796]: info: Loading plugin "my_music"... Sep 08 00:16:46 bedroom-shd volumio[796]: info: Loading plugin "mpd"... Sep 08 00:16:46 bedroom-shd systemd[1]: apt-daily-upgrade.service: Succeeded. Sep 08 00:16:46 bedroom-shd systemd[1]: Started Daily apt upgrade and clean activities. Sep 08 00:16:46 bedroom-shd volumio[796]: info: Loading plugin "upnp_browser"... Sep 08 00:16:47 bedroom-shd volumio[796]: info: Loading plugin "bluetooth"... Sep 08 00:16:48 bedroom-shd volumio[796]: info: [1725769008092] Starting BluetoothController Sep 08 00:16:48 bedroom-shd volumio[796]: info: Loading plugin "alarm-clock"... Sep 08 00:16:48 bedroom-shd volumio[796]: info: Loading plugin "manifestui"... Sep 08 00:16:49 bedroom-shd volumio[796]: info: Loading plugin "metavolumio"... Sep 08 00:16:49 bedroom-shd sudo[923]: pam_unix(sudo:session): session closed for user root Sep 08 00:16:50 bedroom-shd systemd[1]: systemd-fsckd.service: Succeeded. Sep 08 00:16:51 bedroom-shd volumio[796]: info: Loading plugin "airplay_emulation"... Sep 08 00:16:51 bedroom-shd volumio[796]: info: Starting Shairport Sync Sep 08 00:16:51 bedroom-shd volumio[796]: info: Loading plugin "cd_controller"... Sep 08 00:16:51 bedroom-shd sh[383]: timed out Sep 08 00:16:51 bedroom-shd sh[383]: dhcpcd exited Sep 08 00:16:51 bedroom-shd dhcpcd[406]: timed out Sep 08 00:16:51 bedroom-shd sh[383]: ifup: failed to bring up eth0 Sep 08 00:16:51 bedroom-shd dhcpcd[406]: dhcpcd exited Sep 08 00:16:51 bedroom-shd systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Sep 08 00:16:51 bedroom-shd systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Sep 08 00:16:52 bedroom-shd volumio[796]: info: Loading plugin "last_100"... Sep 08 00:16:52 bedroom-shd volumio[796]: info: Loading plugin "raat"... Sep 08 00:16:52 bedroom-shd volumio[796]: info: RAAT Plugin loaded Sep 08 00:16:52 bedroom-shd volumio[796]: info: Adding restartRAATSocket REST API Endpoint Sep 08 00:16:52 bedroom-shd volumio[796]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Sep 08 00:16:52 bedroom-shd volumio[796]: info: Loading plugin "streaming_services"... Sep 08 00:16:54 bedroom-shd volumio[796]: info: Starting Streaming Service Transparent Proxy Sep 08 00:16:54 bedroom-shd volumio[796]: info: Loading plugin "tidalconnect"... Sep 08 00:16:55 bedroom-shd volumio[796]: info: Loading plugin "webradio"... Sep 08 00:16:55 bedroom-shd volumio[796]: info: Loading plugin "i2s_dacs"... Sep 08 00:16:55 bedroom-shd volumio[796]: info: I2S DAC not set, start Auto-detection Sep 08 00:16:55 bedroom-shd volumio[796]: info: Loading plugin "volumiodiscovery"... Sep 08 00:16:55 bedroom-shd volumio[796]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 08 00:16:55 bedroom-shd volumio[796]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 08 00:16:55 bedroom-shd node[796]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 08 00:16:55 bedroom-shd volumio[796]: *** WARNING *** For more information see Sep 08 00:16:55 bedroom-shd volumio[796]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 08 00:16:55 bedroom-shd volumio[796]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 08 00:16:55 bedroom-shd volumio[796]: *** WARNING *** For more information see Sep 08 00:16:55 bedroom-shd node[796]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 08 00:16:55 bedroom-shd node[796]: *** WARNING *** For more information see Sep 08 00:16:55 bedroom-shd node[796]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 08 00:16:55 bedroom-shd node[796]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 08 00:16:55 bedroom-shd node[796]: *** WARNING *** For more information see Sep 08 00:16:55 bedroom-shd volumio[796]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 08 00:16:55 bedroom-shd volumio[796]: info: Discovery: Started advertising with name: Bedroom SHD Sep 08 00:16:55 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 08 00:16:55 bedroom-shd volumio[796]: info: Loading plugin "spop"... Sep 08 00:16:57 bedroom-shd volumio[796]: STREAMING PROXY: Starting server on port 3245 Sep 08 00:16:57 bedroom-shd volumio[796]: Node JS runtime: 14 Sep 08 00:16:58 bedroom-shd volumio[796]: info: Loading plugin "multiroom"... Sep 08 00:17:00 bedroom-shd volumio-remote-updater[454]: [2024-09-08 00:17:00] [connect] Successful connection Sep 08 00:17:01 bedroom-shd volumio[796]: info: Applying required configuration parameters for plugin multiroom Sep 08 00:17:01 bedroom-shd sudo[964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Sep 08 00:17:01 bedroom-shd sudo[964]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:01 bedroom-shd sudo[964]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:02 bedroom-shd volumio[796]: info: MRS: MultiRoom plugin initialized Sep 08 00:17:02 bedroom-shd volumio[796]: info: MRS: STOPPING SNAPCLIENT Sep 08 00:17:02 bedroom-shd volumio[796]: info: MRS: Snap server stop Sep 08 00:17:02 bedroom-shd sudo[980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Sep 08 00:17:02 bedroom-shd sudo[980]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:02 bedroom-shd volumio[796]: info: MRS: STOPPING volumioStreaming Sep 08 00:17:02 bedroom-shd sudo[982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Sep 08 00:17:02 bedroom-shd sudo[982]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:02 bedroom-shd sudo[980]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:02 bedroom-shd volumio[796]: info: Loading plugin "outputs"... Sep 08 00:17:02 bedroom-shd sudo[985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Sep 08 00:17:02 bedroom-shd sudo[985]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:02 bedroom-shd sudo[988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 08 00:17:02 bedroom-shd sudo[988]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:02 bedroom-shd volumio[796]: info: Loading plugin "albumart"... Sep 08 00:17:02 bedroom-shd sudo[988]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:02 bedroom-shd sudo[982]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:02 bedroom-shd sudo[985]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:02 bedroom-shd volumio[796]: info: Loading plugin "ms_surface_dial"... Sep 08 00:17:03 bedroom-shd volumio[796]: Forking 3 albumart workers Sep 08 00:17:03 bedroom-shd volumio[796]: info: Applying required configuration parameters for plugin ms_surface_dial Sep 08 00:17:03 bedroom-shd volumio[796]: info: Plugin example_plugin is not enabled Sep 08 00:17:03 bedroom-shd volumio[796]: info: Loading plugin "hi_res_audio"... Sep 08 00:17:04 bedroom-shd volumio[796]: Starting albumart workers Sep 08 00:17:04 bedroom-shd volumio[796]: Starting albumart workers Sep 08 00:17:05 bedroom-shd volumio[796]: Starting albumart workers Sep 08 00:17:06 bedroom-shd volumio[796]: info: Applying required configuration parameters for plugin hi_res_audio Sep 08 00:17:06 bedroom-shd volumio[796]: info: Loading plugin "inputs"... Sep 08 00:17:08 bedroom-shd volumio[796]: info: Loading plugin "qobuz"... Sep 08 00:17:10 bedroom-shd volumio[796]: info: Loading plugin "tidal"... Sep 08 00:17:13 bedroom-shd volumio[796]: info: Loading plugin "oem_helper"... Sep 08 00:17:15 bedroom-shd volumio[796]: info: Applying required configuration parameters for plugin oem_helper Sep 08 00:17:15 bedroom-shd volumio[796]: info: Loading plugin "updater_comm"... Sep 08 00:17:15 bedroom-shd volumio-remote-updater[454]: [2024-09-08 00:17:15] [connect] Successful connection Sep 08 00:17:15 bedroom-shd volumio[796]: info: Plugin mpdemulation is not enabled Sep 08 00:17:15 bedroom-shd volumio[796]: info: Loading plugin "rest_api"... Sep 08 00:17:15 bedroom-shd volumio[796]: info: Loading plugin "websocket"... Sep 08 00:17:15 bedroom-shd volumio[796]: info: Loading i18n strings for locale en Sep 08 00:17:15 bedroom-shd volumio[796]: Updating browse sources language Sep 08 00:17:15 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 00:17:15 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 00:17:15 bedroom-shd volumio[796]: info: CoreCommandRouter::initPlayerControls Sep 08 00:17:15 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:15 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:15 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:15 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 00:17:16 bedroom-shd volumio[796]: Express server listening on port 3000 Sep 08 00:17:16 bedroom-shd volumio[796]: [Metrics] WebUI: 37s 444.48ms Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreStateMachine::resetVolumioState Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreStateMachine::getcurrentVolume Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioRetrievevolume Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreStateMachine::pushState Sep 08 00:17:16 bedroom-shd volumio[796]: info: CorePlayQueue::getTrack 0 Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioPushState Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 00:17:16 bedroom-shd sudo[1053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 08 00:17:16 bedroom-shd sudo[1053]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: inputs , getVolume Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: inputs , getDSP Sep 08 00:17:16 bedroom-shd sudo[1053]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:16 bedroom-shd sudo[1055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 08 00:17:16 bedroom-shd sudo[1055]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:16 bedroom-shd sudo[1055]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:16 bedroom-shd volumio[796]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Sep 08 00:17:16 bedroom-shd volumio[796]: info: Completed loading Core Plugins Sep 08 00:17:16 bedroom-shd volumio[796]: info: Preparing to generate the ALSA configuration file Sep 08 00:17:16 bedroom-shd volumio[796]: info: Cannot read play queue from file Sep 08 00:17:16 bedroom-shd volumio[796]: info: MRS: Removed streaming files Sep 08 00:17:16 bedroom-shd volumio[796]: info: MRS: volumioStreaming STOPPED Sep 08 00:17:16 bedroom-shd volumio[796]: info: MRS: SNAPSERVER STOPPED Sep 08 00:17:16 bedroom-shd volumio[796]: info: MRS: SNAPCLIENT STOPPED Sep 08 00:17:16 bedroom-shd volumio[796]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Sep 08 00:17:16 bedroom-shd volumio[796]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Sep 08 00:17:16 bedroom-shd volumio[796]: info: Reading ALSA contributions from plugins. Sep 08 00:17:16 bedroom-shd volumio-remote-updater[454]: [2024-09-08 00:17:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1725769035 101 Sep 08 00:17:16 bedroom-shd volumio[796]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreStateMachine::setRepeat null single undefined Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreStateMachine::pushState Sep 08 00:17:16 bedroom-shd volumio[796]: info: CorePlayQueue::getTrack 0 Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioPushState Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreStateMachine::setRandom null Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreStateMachine::pushState Sep 08 00:17:16 bedroom-shd volumio[796]: info: CorePlayQueue::getTrack 0 Sep 08 00:17:16 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioPushState Sep 08 00:17:16 bedroom-shd volumio[796]: info: Setting Device type: NanoPi NEO 3 Sep 08 00:17:17 bedroom-shd volumio[796]: info: Asound.conf file unchanged, so no further update is needed Sep 08 00:17:17 bedroom-shd volumio[796]: info: Output device has changed, restarting MPD Sep 08 00:17:17 bedroom-shd sudo[1064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 08 00:17:17 bedroom-shd sudo[1064]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:17 bedroom-shd systemd[1]: Started UPnP Renderer front-end to MPD. Sep 08 00:17:17 bedroom-shd sudo[1067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 08 00:17:17 bedroom-shd sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:17 bedroom-shd volumio[796]: info: Output device has changed, restarting Shairport Sync Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 00:17:17 bedroom-shd sudo[1067]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:17 bedroom-shd sudo[1064]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:17 bedroom-shd sudo[1071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 08 00:17:17 bedroom-shd sudo[1071]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:17 bedroom-shd systemd[1]: Listening on mpd.socket. Sep 08 00:17:17 bedroom-shd systemd[1]: Starting Music Player Daemon... Sep 08 00:17:17 bedroom-shd volumio[796]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 08 00:17:17 bedroom-shd volumio[796]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:17 bedroom-shd volumio[796]: info: ___________ START PLUGINS ___________ Sep 08 00:17:17 bedroom-shd volumio[796]: info: ControllerMpd::onStart: Initializing MPD Sep 08 00:17:17 bedroom-shd volumio[796]: info: Creating MPD Configuration file Sep 08 00:17:17 bedroom-shd sudo[1080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 08 00:17:17 bedroom-shd sudo[1080]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:17 bedroom-shd volumio[796]: info: [1725769037455] CoreMusicLibrary::Adding element Media Servers Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 00:17:17 bedroom-shd sudo[1080]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:17 bedroom-shd sudo[1082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 08 00:17:17 bedroom-shd sudo[1082]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 08 00:17:17 bedroom-shd systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Sep 08 00:17:17 bedroom-shd systemd[1]: mpd.service: Succeeded. Sep 08 00:17:17 bedroom-shd systemd[1]: Stopped Music Player Daemon. Sep 08 00:17:17 bedroom-shd systemd[1]: Starting Music Player Daemon... Sep 08 00:17:17 bedroom-shd volumio[796]: info: Adding Manifest REST API Endpoints Sep 08 00:17:17 bedroom-shd volumio[796]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui Sep 08 00:17:17 bedroom-shd volumio[796]: info: Adding METAVOLUMIO REST API Endpoints Sep 08 00:17:17 bedroom-shd volumio[796]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Sep 08 00:17:17 bedroom-shd volumio[796]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Sep 08 00:17:17 bedroom-shd volumio[796]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Sep 08 00:17:17 bedroom-shd volumio[796]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 00:17:17 bedroom-shd sudo[1087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Bedroom SHD Sep 08 00:17:17 bedroom-shd sudo[1087]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:17 bedroom-shd sudo[1087]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:17 bedroom-shd volumio[796]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 00:17:17 bedroom-shd volumio[796]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 08 00:17:17 bedroom-shd volumio[796]: info: Preparing CD Folders Sep 08 00:17:17 bedroom-shd volumio[796]: info: Adding CD REST API Endpoints Sep 08 00:17:17 bedroom-shd volumio[796]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Sep 08 00:17:17 bedroom-shd volumio[796]: info: Starting UDEV Watcher for CD Sep 08 00:17:17 bedroom-shd volumio[796]: info: Detecting CD presence with UDEV Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 08 00:17:17 bedroom-shd volumio[796]: info: [1725769037869] CoreMusicLibrary::Adding element Last_100 Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 00:17:17 bedroom-shd volumio[796]: info: Starting RAAT Plugin Sep 08 00:17:17 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Sep 08 00:17:17 bedroom-shd volumio[796]: info: Additional UI Settings Added for plugin music_service/raat Sep 08 00:17:17 bedroom-shd volumio[796]: info: Streaming services startup Sep 08 00:17:17 bedroom-shd volumio[796]: info: Starting Streaming Daemon Sep 08 00:17:18 bedroom-shd sudo[1098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 08 00:17:18 bedroom-shd sudo[1098]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:18 bedroom-shd sudo[1098]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:18 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 08 00:17:18 bedroom-shd volumio[796]: info: [1725769038123] CoreMusicLibrary::Adding element Webradio Sep 08 00:17:18 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 00:17:18 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 08 00:17:18 bedroom-shd sudo[1105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 08 00:17:18 bedroom-shd sudo[1105]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:18 bedroom-shd volumio[796]: info: Creating Spotify config file Sep 08 00:17:18 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:18 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Sep 08 00:17:18 bedroom-shd sudo[1105]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:18 bedroom-shd volumio[796]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 08 00:17:18 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:18 bedroom-shd dbus-daemon[438]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.8' (uid=1000 pid=796 comm="/usr/bin/node /volumio/index.js ") Sep 08 00:17:18 bedroom-shd volumio[796]: error: Hi Res Audio Failed Login: Missing Login Data Sep 08 00:17:18 bedroom-shd volumio[796]: info: Adding HIGHRESAUDIO REST API Endpoints Sep 08 00:17:18 bedroom-shd volumio[796]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Sep 08 00:17:18 bedroom-shd systemd[1]: Starting Bluetooth service... Sep 08 00:17:18 bedroom-shd volumio[796]: info: Refreshing TIDAL token Sep 08 00:17:18 bedroom-shd bluetoothd[1111]: Bluetooth daemon 5.23 Sep 08 00:17:18 bedroom-shd dbus-daemon[438]: [system] Successfully activated service 'org.bluez' Sep 08 00:17:18 bedroom-shd systemd[1]: Started Bluetooth service. Sep 08 00:17:18 bedroom-shd bluetoothd[1111]: Starting SDP server Sep 08 00:17:18 bedroom-shd bluetoothd[1111]: kernel lacks bnep-protocol support Sep 08 00:17:18 bedroom-shd bluetoothd[1111]: System does not support network plugin Sep 08 00:17:18 bedroom-shd dbus-daemon[438]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.11' (uid=0 pid=1111 comm="/usr/local/libexec/bluetooth/bluetoothd ") Sep 08 00:17:18 bedroom-shd bluetoothd[1111]: Bluetooth management interface 1.14 initialized Sep 08 00:17:18 bedroom-shd systemd[1]: Starting Hostname Service... Sep 08 00:17:18 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 08 00:17:18 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 00:17:18 bedroom-shd volumio[796]: info: Volumio Calling Home Sep 08 00:17:18 bedroom-shd dbus-daemon[438]: [system] Successfully activated service 'org.freedesktop.hostname1' Sep 08 00:17:18 bedroom-shd systemd[1]: Started Hostname Service. Sep 08 00:17:18 bedroom-shd volumio[796]: info: Stopping AccessToken refresher cron for QOBUZ Sep 08 00:17:19 bedroom-shd volumio[796]: info: AccessToken refresher cron started for QOBUZ Sep 08 00:17:19 bedroom-shd volumio[796]: info: Adding QOBUZ REST API Endpoints Sep 08 00:17:19 bedroom-shd volumio[796]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Sep 08 00:17:19 bedroom-shd volumio[796]: info: Discovery: adding ed6535e8-206a-47b5-8533-8f948ca91186 Sep 08 00:17:19 bedroom-shd volumio[796]: info: Discovery: Found device Bedroom SHD Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioGetState Sep 08 00:17:19 bedroom-shd volumio[796]: info: CorePlayQueue::getTrack 0 Sep 08 00:17:19 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output for this device Sep 08 00:17:19 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output Sep 08 00:17:19 bedroom-shd volumio[796]: info: Adding audio output: Sep 08 00:17:19 bedroom-shd volumio[796]: info: Adding audio output: Sep 08 00:17:19 bedroom-shd volumio[796]: info: Serial port opened successfully Sep 08 00:17:19 bedroom-shd volumio[796]: error: Cannot start Volumio Streaming Daemon Sep 08 00:17:19 bedroom-shd volumio[796]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 08 00:17:19 bedroom-shd volumio[796]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 08 00:17:19 bedroom-shd volumio[796]: info: RAAT Albumart path created successfully Sep 08 00:17:19 bedroom-shd volumio[796]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'Bedroom SHD' Sep 08 00:17:19 bedroom-shd volumio[796]: Can't get device info: No such device Sep 08 00:17:19 bedroom-shd volumio[796]: info: MPD Permissions set Sep 08 00:17:19 bedroom-shd volumio[796]: info: MPD Permissions set Sep 08 00:17:19 bedroom-shd volumio[796]: info: Upmpdcli Daemon Started Sep 08 00:17:19 bedroom-shd volumio[796]: info: msSurfaceDial volumioupdatevolume callback: {"vol":85,"dbVolume":-18.5,"disableVolumeControl":false} Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreStateMachine::pushState Sep 08 00:17:19 bedroom-shd volumio[796]: info: CorePlayQueue::getTrack 0 Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioPushState Sep 08 00:17:19 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output update for this device Sep 08 00:17:19 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Sep 08 00:17:19 bedroom-shd volumio[796]: info: Ignoring ROON Volume update because of undefined data Sep 08 00:17:19 bedroom-shd volumio[796]: info: msSurfaceDial Managed Objs {"/org/bluez":{"org.freedesktop.DBus.Introspectable":{},"org.bluez.AgentManager1":{},"org.bluez.ProfileManager1":{}}} Sep 08 00:17:19 bedroom-shd volumio[796]: info: [msSurfaceDial init()] check /org/bluez Sep 08 00:17:19 bedroom-shd volumio[796]: info: [msSurfaceDial init()] Adapter: null; SurfaceDial: null Sep 08 00:17:19 bedroom-shd volumio[796]: info: msSurfaceDial BluetoothSurfaceDial init() - ready! Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::Reload Ui Sep 08 00:17:19 bedroom-shd volumio[796]: info: Volumio called home Sep 08 00:17:19 bedroom-shd volumio[796]: info: Spotify config file written Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: raat , updateDSP Sep 08 00:17:19 bedroom-shd volumio[796]: info: updateDSP function in raat called! Sep 08 00:17:19 bedroom-shd volumio[796]: info: Updating RAAT Signal Path Sep 08 00:17:19 bedroom-shd volumio[796]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: raat , reconfigureAndRestartRaat Sep 08 00:17:19 bedroom-shd volumio[796]: info: Reconfiguring and Restarting RAAT Plugin Sep 08 00:17:19 bedroom-shd sudo[1128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Sep 08 00:17:19 bedroom-shd sudo[1128]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 00:17:19 bedroom-shd systemd[1]: Started go-librespot Daemon. Sep 08 00:17:19 bedroom-shd volumio[796]: info: Not Reporting Auto name since its the default one Sep 08 00:17:19 bedroom-shd volumio[796]: info: RAAT Overriding default device vendor model Sep 08 00:17:19 bedroom-shd sudo[1128]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:19 bedroom-shd volumio[796]: info: Adding MINIDSP Inputs Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 08 00:17:19 bedroom-shd volumio[796]: info: [1725769039846] CoreMusicLibrary::Adding element Inputs Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 00:17:19 bedroom-shd go-librespot[1134]: Librespot-go daemon starting... Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 08 00:17:19 bedroom-shd volumio[796]: info: [1725769039860] CoreMusicLibrary::Adding element Presets Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 00:17:19 bedroom-shd volumio[796]: Cannot find translation for source Presets Sep 08 00:17:19 bedroom-shd volumio[796]: (node:796) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Sep 08 00:17:19 bedroom-shd volumio[796]: (Use `node --trace-deprecation ...` to show where the warning was created) Sep 08 00:17:19 bedroom-shd volumio[796]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:19 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:20 bedroom-shd go-librespot[1134]: time="2024-09-08T00:17:20-04:00" level=info msg="generated new device id: ccb9d6556c0dd611c589aac1c9541cc08e13409a" Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 08 00:17:20 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:20 bedroom-shd volumio[796]: info: Access Token successfully retrieved Sep 08 00:17:20 bedroom-shd go-librespot[1134]: time="2024-09-08T00:17:20-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Sep 08 00:17:20 bedroom-shd go-librespot[1134]: time="2024-09-08T00:17:20-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Sep 08 00:17:20 bedroom-shd sudo[1155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Sep 08 00:17:20 bedroom-shd sudo[1155]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:20 bedroom-shd go-librespot[1134]: time="2024-09-08T00:17:20-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Sep 08 00:17:20 bedroom-shd go-librespot[1134]: time="2024-09-08T00:17:20-04:00" level=debug msg="zeroconf server listening on port 46063" Sep 08 00:17:20 bedroom-shd volumio[796]: info: Starting Shairport Sync Sep 08 00:17:20 bedroom-shd systemd[1]: Started Volumio Bluetooth Module. Sep 08 00:17:20 bedroom-shd volumio[796]: info: Starting Shairport Sync Sep 08 00:17:20 bedroom-shd sudo[1155]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:20 bedroom-shd sudo[1159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Sep 08 00:17:20 bedroom-shd sudo[1159]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:20 bedroom-shd volumiobt[1157]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Sep 08 00:17:20 bedroom-shd sudo[1160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 08 00:17:20 bedroom-shd sudo[1159]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:20 bedroom-shd sudo[1160]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:20 bedroom-shd volumio[796]: info: Starting Shairport Sync Sep 08 00:17:21 bedroom-shd sudo[1165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Sep 08 00:17:21 bedroom-shd systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 08 00:17:21 bedroom-shd sudo[1165]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:21 bedroom-shd systemd[1]: shairport-sync.service: Succeeded. Sep 08 00:17:21 bedroom-shd systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 08 00:17:21 bedroom-shd sudo[1167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 08 00:17:21 bedroom-shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 08 00:17:21 bedroom-shd sudo[1167]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:21 bedroom-shd sudo[1160]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:21 bedroom-shd systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 08 00:17:21 bedroom-shd volumio[796]: xcb_connection_has_error() returned true Sep 08 00:17:21 bedroom-shd systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Sep 08 00:17:21 bedroom-shd systemd[1]: shairport-sync.service: Succeeded. Sep 08 00:17:21 bedroom-shd systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 08 00:17:21 bedroom-shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 08 00:17:21 bedroom-shd sudo[1167]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:21 bedroom-shd sudo[1165]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:21 bedroom-shd volumio[796]: info: CorePlayQueue::getTrack 0 Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreCommandRouter::volumiosetSourceActiveno-source Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 00:17:21 bedroom-shd volumio[796]: Cannot find translation for source Presets Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioStop Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreStateMachine::stop Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 08 00:17:21 bedroom-shd sudo[1175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Sep 08 00:17:21 bedroom-shd sudo[1175]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:21 bedroom-shd volumio[796]: info: Notifying Active Input {"trackType":"input","service":"inputs","title":"TOSLINK","disableUiControls":true,"albumart":"/albumart"} Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 08 00:17:21 bedroom-shd systemd[1]: Started RAAT DAEMON. Sep 08 00:17:21 bedroom-shd sudo[1175]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Sep 08 00:17:21 bedroom-shd volumio[796]: info: Enabling external Volume Control Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 00:17:21 bedroom-shd volumio[796]: info: Raat Daemon started successfully Sep 08 00:17:21 bedroom-shd volumio[796]: info: Shairport-Sync Started Sep 08 00:17:21 bedroom-shd volumio[796]: Error adding Membership: Error: addMembership EINVAL Sep 08 00:17:21 bedroom-shd volumio[796]: info: Shairport-Sync Started Sep 08 00:17:21 bedroom-shd volumio[796]: info: Shairport-Sync Started Sep 08 00:17:21 bedroom-shd volumio[796]: info: TidalConnect service stoped! Sep 08 00:17:21 bedroom-shd volumio[796]: info: Volumio BT Module successfully started Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreCommandRouter::servicePushState Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreStateMachine::pushState Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 00:17:21 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioPushState Sep 08 00:17:21 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output update for this device Sep 08 00:17:21 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output Sep 08 00:17:21 bedroom-shd volumio[796]: info: Successfully retrieved User Session From TIDAL Sep 08 00:17:22 bedroom-shd sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Sep 08 00:17:22 bedroom-shd sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:22 bedroom-shd volumiobt[1157]: pulseaudio: no process found Sep 08 00:17:22 bedroom-shd sudo[1193]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:22 bedroom-shd dbus-daemon[438]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.16' (uid=1000 pid=1197 comm="/usr/bin/pulseaudio --high-priority=true ") Sep 08 00:17:22 bedroom-shd systemd[1]: Starting RealtimeKit Scheduling Policy Service... Sep 08 00:17:22 bedroom-shd volumio[796]: info: Executing endpoint restartRAATSocket Sep 08 00:17:22 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Sep 08 00:17:22 bedroom-shd dbus-daemon[438]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Sep 08 00:17:22 bedroom-shd systemd[1]: Started RealtimeKit Scheduling Policy Service. Sep 08 00:17:22 bedroom-shd rtkit-daemon[1198]: Successfully called chroot. Sep 08 00:17:22 bedroom-shd rtkit-daemon[1198]: Successfully dropped privileges. Sep 08 00:17:22 bedroom-shd rtkit-daemon[1198]: Successfully limited resources. Sep 08 00:17:22 bedroom-shd rtkit-daemon[1198]: Running. Sep 08 00:17:22 bedroom-shd dbus-daemon[438]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.17' (uid=0 pid=1198 comm="/usr/lib/rtkit/rtkit-daemon ") Sep 08 00:17:22 bedroom-shd rtkit-daemon[1198]: Watchdog thread running. Sep 08 00:17:22 bedroom-shd rtkit-daemon[1198]: Canary thread running. Sep 08 00:17:22 bedroom-shd systemd[1]: Starting Authorization Manager... Sep 08 00:17:22 bedroom-shd volumiologrotate[429]: ls: cannot access '/var/log/samba/log.wb-BEDROOM': No such file or directory Sep 08 00:17:22 bedroom-shd volumiologrotate[429]: ls: cannot access 'SHD': No such file or directory Sep 08 00:17:22 bedroom-shd volumio[796]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Sep 08 00:17:22 bedroom-shd volumio[796]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 08 00:17:22 bedroom-shd polkitd[1214]: started daemon version 0.105 using authority implementation `local' version `0.105' Sep 08 00:17:22 bedroom-shd dbus-daemon[438]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Sep 08 00:17:22 bedroom-shd systemd[1]: Started Authorization Manager. Sep 08 00:17:22 bedroom-shd volumio[796]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 08 00:17:22 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioGetState Sep 08 00:17:23 bedroom-shd volumio[796]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Sep 08 00:17:23 bedroom-shd volumio[796]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Sep 08 00:17:23 bedroom-shd sudo[1249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Sep 08 00:17:23 bedroom-shd sudo[1249]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 00:17:23 bedroom-shd systemd[1]: Started Volumio Tidal Connect Service. Sep 08 00:17:23 bedroom-shd volumio[796]: info: msSurfaceDial volumioupdatevolume callback: {"vol":85,"dbVolume":-18.5,"mute":false,"disableVolumeControl":false} Sep 08 00:17:23 bedroom-shd volumio[796]: info: CoreStateMachine::pushState Sep 08 00:17:23 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 00:17:23 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioPushState Sep 08 00:17:23 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output update for this device Sep 08 00:17:23 bedroom-shd sudo[1249]: pam_unix(sudo:session): session closed for user root Sep 08 00:17:23 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output Sep 08 00:17:23 bedroom-shd volumio[796]: error: Help! Some callbacks for volumioPushState are crashing! Sep 08 00:17:23 bedroom-shd volumio[796]: error: Cannot read property 'sendVolumeMute' of undefined Sep 08 00:17:23 bedroom-shd volumio[796]: info: Successfully retrieved User Subscription From TIDAL Sep 08 00:17:23 bedroom-shd volumio[796]: info: Adding TIDAL to Browse Sources Sep 08 00:17:23 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 08 00:17:23 bedroom-shd volumio[796]: info: [1725769043353] CoreMusicLibrary::Adding element TIDAL Sep 08 00:17:23 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 00:17:23 bedroom-shd volumio[796]: Cannot find translation for source Presets Sep 08 00:17:23 bedroom-shd volumio[796]: Cannot find translation for source TIDAL Sep 08 00:17:23 bedroom-shd volumio[796]: info: Stopping AccessToken refresher cron Sep 08 00:17:23 bedroom-shd volumio[796]: info: AccessToken refresher cron started Sep 08 00:17:23 bedroom-shd volumio[796]: info: Adding TIDAL REST API Endpoints Sep 08 00:17:23 bedroom-shd volumio[796]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Sep 08 00:17:23 bedroom-shd volumio[796]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 Sep 08 00:17:23 bedroom-shd volumio[796]: info: MRS: Getting audio outputs on start Sep 08 00:17:23 bedroom-shd volumio[796]: info: MRS: Requesting all other devices output Sep 08 00:17:23 bedroom-shd volumio[796]: info: go-librespot daemon successfully initialized Sep 08 00:17:23 bedroom-shd pulseaudio[1197]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Sep 08 00:17:23 bedroom-shd pulseaudio[1197]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Sep 08 00:17:23 bedroom-shd volumiobt[1157]: Applying permissions Sep 08 00:17:23 bedroom-shd volumiobt[1157]: Setting BT discoverable and pairable Sep 08 00:17:23 bedroom-shd pulseaudio[1197]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Sep 08 00:17:23 bedroom-shd volumiobt[1157]: [38B blob data] Sep 08 00:17:23 bedroom-shd volumiobt[1157]: Invalid command Sep 08 00:17:23 bedroom-shd volumiobt[1157]: [bluetooth]# agent on Sep 08 00:17:23 bedroom-shd volumiobt[1157]: [bluetooth]# discoverable on Sep 08 00:17:23 bedroom-shd volumiobt[1157]: No default controller available Sep 08 00:17:23 bedroom-shd volumiobt[1157]: [bluetooth]# pairable on Sep 08 00:17:23 bedroom-shd volumiobt[1157]: No default controller available Sep 08 00:17:23 bedroom-shd volumiobt[1157]: [bluetooth]# agent NoInputNoOutput Sep 08 00:17:23 bedroom-shd volumiobt[1157]: Failed to register agent object Sep 08 00:17:23 bedroom-shd volumiobt[1157]: [bluetooth]# default-agent Sep 08 00:17:23 bedroom-shd volumiobt[1157]: No agent is registered Sep 08 00:17:23 bedroom-shd volumiobt[1157]: [bluetooth]# quit Sep 08 00:17:23 bedroom-shd volumiobt[1157]: [61B blob data] Sep 08 00:17:23 bedroom-shd volumio[796]: info: msSurfaceDial volumioupdatevolume callback: {"vol":85,"dbVolume":-18.5,"mute":false,"disableVolumeControl":false} Sep 08 00:17:23 bedroom-shd volumio[796]: info: CoreStateMachine::pushState Sep 08 00:17:23 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioPushState Sep 08 00:17:23 bedroom-shd volumiobt[1157]: [62B blob data] Sep 08 00:17:23 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output update for this device Sep 08 00:17:23 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output Sep 08 00:17:23 bedroom-shd volumio[796]: error: Help! Some callbacks for volumioPushState are crashing! Sep 08 00:17:23 bedroom-shd volumio[796]: error: Cannot read property 'sendVolumeMute' of undefined Sep 08 00:17:23 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioGetState Sep 08 00:17:24 bedroom-shd volumio[796]: info: Executing endpoint tc_getconfig Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Sep 08 00:17:24 bedroom-shd vtcs[1251]: STARTING TidalConnect services, version: 1.3.0.19 Sep 08 00:17:24 bedroom-shd volumio[796]: info: Airplay started streaming, receiving metadatas Sep 08 00:17:24 bedroom-shd volumio[796]: verbose: UNSET VOLATILE: Service: inputs Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreCommandRouter::servicePushState Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreStateMachine::pushState Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioPushState Sep 08 00:17:24 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output update for this device Sep 08 00:17:24 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output Sep 08 00:17:24 bedroom-shd volumio[796]: error: Help! Some callbacks for volumioPushState are crashing! Sep 08 00:17:24 bedroom-shd volumio[796]: error: Cannot read property 'sendVolumeMute' of undefined Sep 08 00:17:24 bedroom-shd volumio[796]: info: Airplay started streaming, receiving metadatas Sep 08 00:17:24 bedroom-shd volumio[796]: info: CorePlayQueue::getTrack 0 Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioStop Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreStateMachine::stop Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreStateMachine::stPlaybackTimer Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreStateMachine::updateTrackBlock Sep 08 00:17:24 bedroom-shd volumio[796]: info: CorePlayQueue::getTrackBlock Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreStateMachine::pushState Sep 08 00:17:24 bedroom-shd volumio[796]: info: CorePlayQueue::getTrack 0 Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreCommandRouter::volumioPushState Sep 08 00:17:24 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output update for this device Sep 08 00:17:24 bedroom-shd volumio[796]: info: MRS: Pushing multiroomSync output Sep 08 00:17:24 bedroom-shd volumio[796]: error: Help! Some callbacks for volumioPushState are crashing! Sep 08 00:17:24 bedroom-shd volumio[796]: error: Cannot read property 'sendVolumeMute' of undefined Sep 08 00:17:24 bedroom-shd volumio[796]: info: CoreStateMachine::serviceStop Sep 08 00:17:24 bedroom-shd volumio[796]: info: CorePlayQueue::getTrack 0 Sep 08 00:17:24 bedroom-shd volumio[796]: info: ControllerMpd::stop Sep 08 00:17:24 bedroom-shd volumio[796]: verbose: ControllerMpd::sendMpdCommand stop Sep 08 00:17:24 bedroom-shd shairport-sync[1173]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 08 00:17:24 bedroom-shd shairport-sync[1173]: Dload Upload Total Spent Left Speed Sep 08 00:17:24 bedroom-shd volumio[796]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 08 00:17:24 bedroom-shd volumio[796]: TypeError: Cannot read property 'then' of undefined Sep 08 00:17:24 bedroom-shd volumio[796]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6) Sep 08 00:17:24 bedroom-shd volumio[796]: at ControllerMpd.stop (/volumio/app/plugins/music_service/mpd/index.js:2778:15) Sep 08 00:17:24 bedroom-shd volumio[796]: at CoreStateMachine.serviceStop (/volumio/app/statemachine.js:1265:24) Sep 08 00:17:24 bedroom-shd volumio[796]: at CoreStateMachine.stop (/volumio/app/statemachine.js:1234:19) Sep 08 00:17:24 bedroom-shd volumio[796]: at CoreCommandRouter.volumioStop (/volumio/app/index.js:89:28) Sep 08 00:17:24 bedroom-shd volumio[796]: at AirPlayInterface.prepareAirplayPlayback (/volumio/app/plugins/music_service/airplay_emulation/index.js:543:32) Sep 08 00:17:24 bedroom-shd volumio[796]: at ShairportSyncReaderUDP. (/volumio/app/plugins/music_service/airplay_emulation/index.js:257:12) Sep 08 00:17:24 bedroom-shd volumio[796]: at ShairportSyncReaderUDP.emit (events.js:412:35) Sep 08 00:17:24 bedroom-shd volumio[796]: at ShairportSyncReaderUDP.useData (/volumio/app/plugins/music_service/airplay_emulation/shairport-sync-reader/shairport-sync-reader-base.js:86:16) Sep 08 00:17:24 bedroom-shd volumio[796]: at Socket. (/volumio/app/plugins/music_service/airplay_emulation/shairport-sync-reader/shairport-sync-reader-udp.js:21:12) Sep 08 00:17:24 bedroom-shd volumio[796]: at Socket.emit (events.js:400:28) Sep 08 00:17:24 bedroom-shd volumio[796]: at UDP.onMessage [as onmessage] (dgram.js:931:8) Sep 08 00:17:24 bedroom-shd volumio[796]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 08 00:17:24 bedroom-shd vtcs[1251]: STARTED TidalConnect services. Sep 08 00:17:25 bedroom-shd sudo[1282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-08 00:16 Sep 08 00:17:25 bedroom-shd sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 22 Mar 2024 03:13:25 PM CET" VOLUMIO_VERSION="3.608" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="18533ba33f8f92d7e7e459bb30f70beb"