-- Logs begin at Fri 2024-11-01 17:04:38 CET, end at Fri 2024-11-01 22:40:19 CET. -- Nov 01 22:39:48 volumio volumio[893]: info: Tunnel connection is inactive, restarting it Nov 01 22:39:48 volumio volumio[893]: info: Starting Tunnel 1 Nov 01 22:39:48 volumio volumio[893]: info: Starting Tunnel Connection Checker Nov 01 22:39:48 volumio sudo[17576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Nov 01 22:39:48 volumio sudo[17576]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 22:39:48 volumio autossh[17432]: received signal to exit (15) Nov 01 22:39:48 volumio systemd[1]: Stopping MyVolumio SSH Tunnel... Nov 01 22:39:48 volumio systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Nov 01 22:39:48 volumio systemd[1]: sshtunnel.service: Succeeded. Nov 01 22:39:48 volumio systemd[1]: Stopped MyVolumio SSH Tunnel. Nov 01 22:39:48 volumio systemd[1]: Started MyVolumio SSH Tunnel. Nov 01 22:39:48 volumio sudo[17576]: pam_unix(sudo:session): session closed for user root Nov 01 22:39:48 volumio volumio[893]: info: Remote SSH Started Nov 01 22:39:48 volumio autossh[17580]: port set to 0, monitoring disabled Nov 01 22:39:48 volumio autossh[17580]: starting ssh (count 1) Nov 01 22:39:48 volumio autossh[17580]: ssh child pid is 17583 Nov 01 22:39:48 volumio volumio[893]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Nov 01 22:39:48 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Nov 01 22:39:48 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Nov 01 22:39:54 volumio sudo[17626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 01 22:39:54 volumio sudo[17626]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 22:39:54 volumio sudo[17626]: pam_unix(sudo:session): session closed for user root Nov 01 22:39:54 volumio sudo[17629]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 01 22:39:54 volumio sudo[17629]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 22:39:54 volumio sudo[17629]: pam_unix(sudo:session): session closed for user root Nov 01 22:39:54 volumio volumio[893]: verbose: New Socket.io Connection to 192.168.50.48 from 192.168.50.19 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 OPR/114.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Nov 01 22:39:54 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 01 22:39:54 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 22:39:54 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Nov 01 22:39:54 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Nov 01 22:39:54 volumio volumio[893]: info: CoreCommandRouter::volumioGetVisibleSources Nov 01 22:39:54 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 22:39:54 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 01 22:39:54 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 01 22:39:54 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 01 22:39:54 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 01 22:39:54 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 01 22:39:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 01 22:39:57 volumio volumio[893]: info: Received Get System Info Nov 01 22:39:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 22:39:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 22:39:57 volumio volumio[893]: info: Discovery: Getting this device information Nov 01 22:39:57 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Nov 01 22:39:57 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Nov 01 22:39:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 22:39:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 01 22:39:57 volumio volumio[893]: info: CoreCommandRouter::volumioGetQueue Nov 01 22:39:57 volumio volumio[893]: info: CoreStateMachine::getQueue Nov 01 22:39:57 volumio volumio[893]: info: CorePlayQueue::getQueue Nov 01 22:39:57 volumio volumio[893]: info: Listing playlists Nov 01 22:39:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 01 22:39:57 volumio volumio[893]: info: Received Get System Info Nov 01 22:39:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 22:39:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 22:39:57 volumio volumio[893]: info: Discovery: Getting this device information Nov 01 22:39:57 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Nov 01 22:39:57 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Nov 01 22:39:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 22:39:57 volumio volumio[893]: info: Preload queue cleared Nov 01 22:39:59 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Nov 01 22:39:59 volumio volumio[893]: Error Retrieving last played file: Error: /data/laststates.json: ENOENT: no such file or directory, open '/data/laststates.json' Nov 01 22:39:59 volumio volumio[893]: info: Preload queue cleared Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 22:40:06 volumio volumio[893]: info: Retrieving Cloud Streaming UI Nov 01 22:40:06 volumio volumio[893]: info: Getting Tidal Cloud Configuration Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 22:40:06 volumio volumio[893]: info: Getting Qobuz Cloud Configuration Nov 01 22:40:06 volumio volumio[893]: info: Asking plugin for UI Config Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 22:40:06 volumio volumio[893]: info: Getting Spotify Cloud Configuration Nov 01 22:40:06 volumio volumio[893]: info: Asking plugin for UI Config Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 22:40:06 volumio volumio[893]: info: Saving Spotify Acccount Nov 01 22:40:06 volumio volumio[893]: info: Got Tidal Cloud Configuration Nov 01 22:40:06 volumio volumio[893]: info: Got it Nov 01 22:40:06 volumio volumio[893]: info: Got it Nov 01 22:40:06 volumio volumio[893]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 22:40:06 volumio volumio[893]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::volumioGetBrowseSources Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::volumioGetBrowseSources Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::volumioGetBrowseSources Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 01 22:40:06 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 01 22:40:10 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 01 22:40:13 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 01 22:40:13 volumio volumio[893]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 01 22:40:13 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 01 22:40:13 volumio volumio[893]: info: Received Get System Version Nov 01 22:40:13 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 01 22:40:13 volumio volumio[893]: info: Received Get System Info Nov 01 22:40:13 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 22:40:13 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 22:40:13 volumio volumio[893]: info: Discovery: Getting this device information Nov 01 22:40:13 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Nov 01 22:40:13 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Nov 01 22:40:13 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 22:40:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 01 22:40:15 volumio volumio[893]: info: Disabling MyMusic plugin upnp Nov 01 22:40:15 volumio sudo[17634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Nov 01 22:40:15 volumio sudo[17634]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 22:40:15 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Nov 01 22:40:15 volumio volumio[893]: error: Upnp client error: Error: This socket has been ended by the other party Nov 01 22:40:16 volumio volumiossh-tunnel[17578]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts. Nov 01 22:40:18 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 01 22:40:18 volumio volumio[893]: info: Enabling MyMusic plugin upnp Nov 01 22:40:18 volumio volumio[893]: info: Enabling plugin upnp Nov 01 22:40:18 volumio volumio[893]: info: Loading plugin "upnp"... Nov 01 22:40:18 volumio volumio[893]: info: [1730497218717] Starting Upmpd Daemon Nov 01 22:40:18 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 01 22:40:18 volumio volumio[893]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 22:40:18 volumio volumio[893]: Error: listen EADDRINUSE: address already in use :::6599 Nov 01 22:40:18 volumio volumio[893]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 01 22:40:18 volumio volumio[893]: at listenInCluster (net.js:1366:12) Nov 01 22:40:18 volumio volumio[893]: at Server.listen (net.js:1452:7) Nov 01 22:40:18 volumio volumio[893]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Nov 01 22:40:18 volumio volumio[893]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Nov 01 22:40:18 volumio volumio[893]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Nov 01 22:40:18 volumio volumio[893]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Nov 01 22:40:18 volumio volumio[893]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Nov 01 22:40:18 volumio volumio[893]: code: 'EADDRINUSE', Nov 01 22:40:18 volumio volumio[893]: errno: -98, Nov 01 22:40:18 volumio volumio[893]: syscall: 'listen', Nov 01 22:40:18 volumio volumio[893]: address: '::', Nov 01 22:40:18 volumio volumio[893]: port: 6599 Nov 01 22:40:18 volumio volumio[893]: } Nov 01 22:40:18 volumio volumio[893]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 22:40:19 volumio sudo[17645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-01 22:39 Nov 01 22:40:19 volumio sudo[17645]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"