-- Logs begin at Thu 2025-05-01 16:54:23 EDT, end at Thu 2025-05-01 21:35:08 EDT. -- May 01 21:34:19 fuzzybois volumio[875]: info: Starting Uninstall of plugin music_service - volroon May 01 21:35:05 fuzzybois sudo[8089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 21:35:05 fuzzybois sudo[8089]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 21:35:05 fuzzybois sudo[8089]: pam_unix(sudo:session): session closed for user root May 01 21:35:05 fuzzybois sudo[8092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 21:35:05 fuzzybois sudo[8092]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 21:35:05 fuzzybois sudo[8092]: pam_unix(sudo:session): session closed for user root May 01 21:35:05 fuzzybois volumio[875]: verbose: New Socket.io Connection to 192.168.1.180 from 192.168.1.105 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::volumioGetVisibleSources May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::volumioGetState May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 01 21:35:05 fuzzybois volumio[875]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 01 21:35:05 fuzzybois volumio[875]: info: Received Get System Info May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 21:35:05 fuzzybois volumio[875]: info: Discovery: Getting this device information May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::volumioGetState May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::volumioGetState May 01 21:35:05 fuzzybois volumio[875]: info: Listing playlists May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 01 21:35:05 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 01 21:35:07 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 01 21:35:07 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 21:35:07 fuzzybois volumio[875]: info: Received Get System Info May 01 21:35:07 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 21:35:07 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 21:35:07 fuzzybois volumio[875]: info: Discovery: Getting this device information May 01 21:35:07 fuzzybois volumio[875]: info: CoreCommandRouter::volumioGetState May 01 21:35:07 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 21:35:07 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 21:35:07 fuzzybois volumio[875]: info: Received Get System Info May 01 21:35:07 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 21:35:07 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 21:35:07 fuzzybois volumio[875]: info: Discovery: Getting this device information May 01 21:35:07 fuzzybois volumio[875]: info: CoreCommandRouter::volumioGetState May 01 21:35:07 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 21:35:07 fuzzybois volumio[875]: info: Enabling plugin volroon May 01 21:35:07 fuzzybois volumio[875]: info: Loading plugin "volroon"... May 01 21:35:07 fuzzybois volumio[875]: info: Applying required configuration parameters for plugin volroon May 01 21:35:07 fuzzybois volumio[875]: info: Preparing to generate the ALSA configuration file May 01 21:35:07 fuzzybois volumio[875]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 01 21:35:07 fuzzybois volumio[875]: info: Reading ALSA contributions from plugins. May 01 21:35:07 fuzzybois volumio[875]: info: Asound.conf file unchanged, so no further update is needed May 01 21:35:07 fuzzybois volumio[875]: info: Output device has changed, restarting MPD May 01 21:35:08 fuzzybois sudo[8097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 01 21:35:08 fuzzybois sudo[8097]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 21:35:08 fuzzybois sudo[8097]: pam_unix(sudo:session): session closed for user root May 01 21:35:08 fuzzybois volumio[875]: info: Output device has changed, restarting Shairport Sync May 01 21:35:08 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 21:35:08 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 21:35:08 fuzzybois sudo[8100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 01 21:35:08 fuzzybois sudo[8100]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 21:35:08 fuzzybois systemd[1]: Stopping Music Player Daemon... May 01 21:35:08 fuzzybois systemd[1]: mpd.service: Succeeded. May 01 21:35:08 fuzzybois systemd[1]: Stopped Music Player Daemon. May 01 21:35:08 fuzzybois volumio[875]: xcb_connection_has_error() returned true May 01 21:35:08 fuzzybois volumio[875]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 01 21:35:08 fuzzybois volumio[875]: xcb_connection_has_error() returned true May 01 21:35:08 fuzzybois volumio[875]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 01 21:35:08 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 21:35:08 fuzzybois vtcs[1504]: [2025-05-01 21:35:08.025] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected May 01 21:35:08 fuzzybois vtcs[1504]: [2025-05-01 21:35:08.025] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE May 01 21:35:08 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAplayInfo May 01 21:35:08 fuzzybois systemd[1]: Starting Music Player Daemon... May 01 21:35:08 fuzzybois sudo[8109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 01 21:35:08 fuzzybois sudo[8109]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 21:35:08 fuzzybois systemd[1]: Stopping Volumio Tidal Connect Service... May 01 21:35:08 fuzzybois systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM May 01 21:35:08 fuzzybois systemd[1]: vtcs.service: Succeeded. May 01 21:35:08 fuzzybois sudo[8109]: pam_unix(sudo:session): session closed for user root May 01 21:35:08 fuzzybois systemd[1]: Stopped Volumio Tidal Connect Service. May 01 21:35:08 fuzzybois volumio[875]: xcb_connection_has_error() returned true May 01 21:35:08 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 21:35:08 fuzzybois volumio[875]: info: volroon::Output device has changed May 01 21:35:08 fuzzybois volumio[875]: info: PLUGIN START: volroon May 01 21:35:08 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAplayInfo May 01 21:35:08 fuzzybois sudo[8105]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 01 21:35:08 fuzzybois sudo[8105]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 21:35:08 fuzzybois volumio[875]: xcb_connection_has_error() returned true May 01 21:35:08 fuzzybois volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 21:35:08 fuzzybois sudo[8105]: pam_unix(sudo:session): session closed for user root May 01 21:35:08 fuzzybois sudo[8120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service May 01 21:35:08 fuzzybois sudo[8120]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 21:35:08 fuzzybois volumio[875]: info: volroon::Roon API Services Started May 01 21:35:08 fuzzybois sudo[8120]: pam_unix(sudo:session): session closed for user root May 01 21:35:08 fuzzybois volumio[875]: info: Done. May 01 21:35:08 fuzzybois volumio[875]: ------------------------------------ BT MESSAGE: BT STATUS: running May 01 21:35:08 fuzzybois volumio[875]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 01 21:35:08 fuzzybois volumio[875]: ------------------------------------ BT MESSAGE: BT STATUS: running May 01 21:35:08 fuzzybois volumio[875]: ------------------------------------ BT MESSAGE: BT STATUS: running May 01 21:35:08 fuzzybois sudo[8123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 01 21:35:08 fuzzybois sudo[8123]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 21:35:08 fuzzybois volumio[875]: error: ::Cannot start Roon Bridge - Error: Error: Command failed: /usr/bin/sudo /bin/systemctl start roonbridge.service May 01 21:35:08 fuzzybois volumio[875]: Failed to start roonbridge.service: Unit roonbridge.service not found. May 01 21:35:08 fuzzybois volumio[875]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 21:35:08 fuzzybois volumio[875]: Error: Unable to resolve or reject the same promise twice May 01 21:35:08 fuzzybois volumio[875]: at Promise.reject (/data/plugins/music_service/volroon/node_modules/kew/kew.js:189:43) May 01 21:35:08 fuzzybois volumio[875]: at /data/plugins/music_service/volroon/index.js:392:10 May 01 21:35:08 fuzzybois volumio[875]: at ChildProcess.exithandler (child_process.js:390:5) May 01 21:35:08 fuzzybois volumio[875]: at ChildProcess.emit (events.js:400:28) May 01 21:35:08 fuzzybois volumio[875]: at maybeClose (internal/child_process.js:1088:16) May 01 21:35:08 fuzzybois volumio[875]: at Socket. (internal/child_process.js:446:11) May 01 21:35:08 fuzzybois volumio[875]: at Socket.emit (events.js:400:28) May 01 21:35:08 fuzzybois volumio[875]: at Pipe. (net.js:686:12) May 01 21:35:08 fuzzybois volumio[875]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 21:35:08 fuzzybois sudo[8123]: pam_unix(sudo:session): session closed for user root May 01 21:35:08 fuzzybois sudo[8135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-01 21:34 May 01 21:35:08 fuzzybois sudo[8135]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 10:07:11 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="dc77d77f02ef88ea816c3d31de871e8f"