-- Logs begin at Sun 2025-02-16 12:53:33 CET, end at Sun 2025-02-16 13:26:20 CET. -- Feb 16 13:25:21 volumio kernel: input: 78:64:C0:4E:9C:57 as /devices/virtual/input/input26 Feb 16 13:25:22 volumio systemd-udevd[9233]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 16 13:25:22 volumio systemd-logind[718]: Watching system buttons on /dev/input/event17 (78:64:C0:4E:9C:57) Feb 16 13:25:22 volumio volumio[1179]: BT PLUGIN MESSAGE: Duration is 220000 Feb 16 13:25:22 volumio volumio[1179]: info: VolumeController::SetAlsaVolume37 Feb 16 13:25:22 volumio volumio[1179]: BT PLUGIN MESSAGE: Volume set to 37 Feb 16 13:25:22 volumio volumio[1179]: info: CoreStateMachine::pushState Feb 16 13:25:22 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 13:25:22 volumio volumio[1179]: info: CoreCommandRouter::volumioPushState Feb 16 13:25:22 volumio volumio[1179]: info: MRS: Pushing multiroomSync output update for this device Feb 16 13:25:22 volumio volumio[1179]: info: MRS: Pushing multiroomSync output Feb 16 13:25:22 volumio volumio[1179]: ------------------------------------ BT MESSAGE: BT STATUS: pending Feb 16 13:25:22 volumio volumio[1179]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Feb 16 13:25:22 volumio volumio[1179]: xcb_connection_has_error() returned true Feb 16 13:25:25 volumio bluetoothd[720]: /org/bluez/hci0/dev_78_64_C0_4E_9C_57/fd4: fd(26) ready Feb 16 13:25:25 volumio volumio[1179]: ------------------------------------ BT MESSAGE: BT STATUS: active Feb 16 13:25:25 volumio volumio[1179]: BT PLUGIN MESSAGE: Playing: true Feb 16 13:25:25 volumio volumio[1179]: BT PLUGIN MESSAGE: VOLATILE: airplay_emulation Feb 16 13:25:25 volumio volumio[1179]: BT PLUGIN MESSAGE: STATE:undefined Feb 16 13:25:25 volumio volumio[1179]: info: CoreCommandRouter::volumioStop Feb 16 13:25:25 volumio volumio[1179]: info: CoreStateMachine::stop Feb 16 13:25:25 volumio volumio[1179]: info: CoreStateMachine::serviceStop Feb 16 13:25:25 volumio volumio[1179]: info: CoreCommandRouter::serviceStop Feb 16 13:25:25 volumio volumio[1179]: info: Airplay Stop Feb 16 13:25:25 volumio volumio[1179]: info: Stopping Airplay Playback and sending pause command to client via USR2 Feb 16 13:25:25 volumio pulseaudio[2082]: Cannot set requested source latency of 66.67 ms, adjusting to 135.29 ms Feb 16 13:25:25 volumio sudo[9241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 Feb 16 13:25:25 volumio sudo[9241]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 13:25:25 volumio sudo[9241]: pam_unix(sudo:session): session closed for user root Feb 16 13:25:25 volumio volumio[1179]: info: Cannot execute Shairport-sync USR2 kill: Error: Command failed: /usr/bin/sudo /bin/kill -USR2 $(pidof shairport-sync) Feb 16 13:25:25 volumio volumio[1179]: Usage: Feb 16 13:25:25 volumio volumio[1179]: kill [options] [...] Feb 16 13:25:25 volumio volumio[1179]: Options: Feb 16 13:25:25 volumio volumio[1179]: [...] send signal to every listed Feb 16 13:25:25 volumio volumio[1179]: -, -s, --signal Feb 16 13:25:25 volumio volumio[1179]: specify the to be sent Feb 16 13:25:25 volumio volumio[1179]: -l, --list=[] list all signal names, or convert one to a name Feb 16 13:25:25 volumio volumio[1179]: -L, --table list all signal names in a nice table Feb 16 13:25:25 volumio volumio[1179]: -h, --help display this help and exit Feb 16 13:25:25 volumio volumio[1179]: -V, --version output version information and exit Feb 16 13:25:25 volumio volumio[1179]: For more details see kill(1). Feb 16 13:25:25 volumio pulseaudio[2082]: Too many underruns, increasing latency to 205.00 ms Feb 16 13:25:53 volumio sudo[9345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 16 13:25:53 volumio sudo[9345]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 13:25:53 volumio sudo[9345]: pam_unix(sudo:session): session closed for user root Feb 16 13:25:53 volumio sudo[9348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 16 13:25:53 volumio sudo[9348]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 13:25:53 volumio sudo[9348]: pam_unix(sudo:session): session closed for user root Feb 16 13:25:53 volumio volumio[1179]: verbose: New Socket.io Connection to 192.168.0.104 from 192.168.0.158 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) CriOS/133.0.6943.84 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 6 Feb 16 13:25:53 volumio volumio[1179]: info: CoreCommandRouter::volumioGetState Feb 16 13:25:53 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 16 13:25:53 volumio volumio[1179]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 16 13:25:53 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 16 13:25:53 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 16 13:25:53 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 16 13:25:53 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 16 13:25:54 volumio ntpd[7057]: Soliciting pool server 185.123.84.51 Feb 16 13:25:55 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 16 13:25:55 volumio volumio[1179]: info: Received Get System Info Feb 16 13:25:55 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 16 13:25:55 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 16 13:25:55 volumio volumio[1179]: info: Discovery: Getting this device information Feb 16 13:25:55 volumio volumio[1179]: info: CoreCommandRouter::volumioGetState Feb 16 13:25:55 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 16 13:25:55 volumio ntpd[7057]: Soliciting pool server 51.195.104.188 Feb 16 13:25:56 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 16 13:25:56 volumio volumio[1179]: info: Received Get System Info Feb 16 13:25:56 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 16 13:25:56 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 16 13:25:56 volumio volumio[1179]: info: Discovery: Getting this device information Feb 16 13:25:56 volumio volumio[1179]: info: CoreCommandRouter::volumioGetState Feb 16 13:25:56 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 16 13:25:57 volumio volumio[1179]: info: Retrieving Cloud Streaming UI Feb 16 13:25:57 volumio volumio[1179]: info: Getting Tidal Cloud Configuration Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 16 13:25:57 volumio volumio[1179]: info: Getting Qobuz Cloud Configuration Feb 16 13:25:57 volumio volumio[1179]: info: Asking plugin for UI Config Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 16 13:25:57 volumio volumio[1179]: info: Getting Spotify Cloud Configuration Feb 16 13:25:57 volumio volumio[1179]: info: Asking plugin for UI Config Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 16 13:25:57 volumio volumio[1179]: info: Saving Spotify Acccount Feb 16 13:25:57 volumio volumio[1179]: info: Got it Feb 16 13:25:57 volumio volumio[1179]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 16 13:25:57 volumio volumio[1179]: info: Got Tidal Cloud Configuration Feb 16 13:25:57 volumio volumio[1179]: info: Got it Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::volumioGetBrowseSources Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::volumioGetBrowseSources Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::volumioGetBrowseSources Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 13:25:57 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 16 13:25:58 volumio ntpd[7057]: Soliciting pool server 129.250.35.251 Feb 16 13:25:58 volumio ntpd[7057]: Soliciting pool server 2001:41d0:700:49bc:: Feb 16 13:26:01 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 13:26:02 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Feb 16 13:26:02 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Feb 16 13:26:05 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 13:26:09 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 13:26:11 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 16 13:26:11 volumio volumio[1179]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 16 13:26:11 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 16 13:26:11 volumio volumio[1179]: info: Received Get System Version Feb 16 13:26:11 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 13:26:11 volumio volumio[1179]: info: Received Get System Info Feb 16 13:26:11 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 16 13:26:11 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 16 13:26:11 volumio volumio[1179]: info: Discovery: Getting this device information Feb 16 13:26:11 volumio volumio[1179]: info: CoreCommandRouter::volumioGetState Feb 16 13:26:11 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 16 13:26:13 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 13:26:17 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 13:26:19 volumio volumio[1179]: info: Disabling MyMusic plugin upnp Feb 16 13:26:19 volumio sudo[9405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Feb 16 13:26:19 volumio sudo[9405]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 13:26:19 volumio volumio[1179]: error: Upnp client error: Error: This socket has been ended by the other party Feb 16 13:26:19 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Feb 16 13:26:19 volumio volumio[1179]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 16 13:26:20 volumio volumio[1179]: info: Enabling MyMusic plugin upnp Feb 16 13:26:20 volumio volumio[1179]: info: Enabling plugin upnp Feb 16 13:26:20 volumio volumio[1179]: info: Loading plugin "upnp"... Feb 16 13:26:20 volumio volumio[1179]: info: [1739708780430] Starting Upmpd Daemon Feb 16 13:26:20 volumio volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 13:26:20 volumio volumio[1179]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 13:26:20 volumio volumio[1179]: Error: listen EADDRINUSE: address already in use :::6599 Feb 16 13:26:20 volumio volumio[1179]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Feb 16 13:26:20 volumio volumio[1179]: at listenInCluster (net.js:1379:12) Feb 16 13:26:20 volumio volumio[1179]: at Server.listen (net.js:1465:7) Feb 16 13:26:20 volumio volumio[1179]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Feb 16 13:26:20 volumio volumio[1179]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Feb 16 13:26:20 volumio volumio[1179]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Feb 16 13:26:20 volumio volumio[1179]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 16 13:26:20 volumio volumio[1179]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Feb 16 13:26:20 volumio volumio[1179]: code: 'EADDRINUSE', Feb 16 13:26:20 volumio volumio[1179]: errno: -98, Feb 16 13:26:20 volumio volumio[1179]: syscall: 'listen', Feb 16 13:26:20 volumio volumio[1179]: address: '::', Feb 16 13:26:20 volumio volumio[1179]: port: 6599 Feb 16 13:26:20 volumio volumio[1179]: } Feb 16 13:26:20 volumio volumio[1179]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 13:26:20 volumio sudo[9416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-16 13:25 Feb 16 13:26:20 volumio sudo[9416]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"