-- Logs begin at Mon 2025-05-12 23:16:25 CEST, end at Mon 2025-05-12 23:58:20 CEST. --
May 12 23:57:17 volumio go-librespot[1592]: time="2025-05-12T23:57:17+02:00" level=trace msg="sent dealer ping"
May 12 23:57:17 volumio go-librespot[1592]: time="2025-05-12T23:57:17+02:00" level=trace msg="received dealer pong"
May 12 23:57:47 volumio go-librespot[1592]: time="2025-05-12T23:57:47+02:00" level=trace msg="received accesspoint ping"
May 12 23:57:47 volumio go-librespot[1592]: time="2025-05-12T23:57:47+02:00" level=trace msg="received accesspoint pong ack"
May 12 23:57:47 volumio go-librespot[1592]: time="2025-05-12T23:57:47+02:00" level=trace msg="sent dealer ping"
May 12 23:57:47 volumio go-librespot[1592]: time="2025-05-12T23:57:47+02:00" level=trace msg="received dealer pong"
May 12 23:57:54 volumio volumio[1000]: error: Upnp client error: Error: This socket has been ended by the other party
May 12 23:57:57 volumio volumio[1000]: info:
May 12 23:57:57 volumio volumio[1000]: ---------------------------- MPD announces state update: player
May 12 23:57:57 volumio volumio[1000]: info: ControllerMpd::getState
May 12 23:57:57 volumio volumio[1000]: verbose: ControllerMpd::sendMpdCommand status
May 12 23:57:57 volumio volumio[1000]: info: sendMpdCommand status took 0 milliseconds
May 12 23:57:57 volumio volumio[1000]: verbose: ControllerMpd::parseState
May 12 23:57:57 volumio volumio[1000]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 12 23:57:57 volumio volumio[1000]: info: sendMpdCommand playlistinfo took 0 milliseconds
May 12 23:57:57 volumio volumio[1000]: verbose: ControllerMpd::parseTrackInfo
May 12 23:57:57 volumio volumio[1000]: info: ControllerMpd::pushState
May 12 23:57:57 volumio volumio[1000]: info: CoreCommandRouter::servicePushState
May 12 23:57:57 volumio volumio[1000]: verbose: In UPNP mode
May 12 23:57:57 volumio volumio[1000]: verbose: STATE SERVICE {"status":"pause","position":1,"seek":172494,"duration":349,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3250 Kbps","isStreaming":false,"title":"What A Wonderful World","artist":"Tsuyoshi Yamamoto Trio","album":"What A Wonderful World","uri":"https://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKAgDEiRiMzk5YzZmOTExNDRiNzEwNGI2MzcyMGUzOGMxZGVjZi5tcDQ/0.flac?token=1747090253~ZGRmNGM0ZDAwMDBjZDg4NTUzM2M0ZWQ0NWEyMjc0NzJkYzhkZGU0YQ==","trackType":"tidal"}
May 12 23:57:57 volumio volumio[1000]: verbose: CURRENT POSITION 0
May 12 23:57:57 volumio volumio[1000]: info: CoreStateMachine::syncState stateService pause
May 12 23:57:57 volumio volumio[1000]: info: CoreStateMachine::syncState currentStatus play
May 12 23:57:57 volumio volumio[1000]: info: CoreStateMachine::pushState
May 12 23:57:57 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 12 23:57:57 volumio volumio[1000]: info: CoreCommandRouter::volumioPushState
May 12 23:57:57 volumio volumio[1000]: info: CoreStateMachine::stPlaybackTimer
May 12 23:57:57 volumio volumio[1000]: info: ------------------------------ 3ms
May 12 23:57:57 volumio volumio[1000]: info: CoreCommandRouter::volumioGetQueue
May 12 23:57:57 volumio volumio[1000]: info: CoreStateMachine::getQueue
May 12 23:57:57 volumio volumio[1000]: info: CorePlayQueue::getQueue
May 12 23:57:57 volumio volumio[1000]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65
May 12 23:58:05 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 12 23:58:05 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 12 23:58:05 volumio volumio[1000]: info: Discovery: Getting this device information
May 12 23:58:05 volumio volumio[1000]: info: CoreCommandRouter::volumioGetState
May 12 23:58:05 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 12 23:58:05 volumio volumio[1000]: verbose: New Socket.io Connection to 192.168.1.16:3000 from 192.168.1.22 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6
May 12 23:58:05 volumio volumio[1000]: info: CoreCommandRouter::volumioGetState
May 12 23:58:05 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 12 23:58:05 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 12 23:58:06 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 12 23:58:06 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 12 23:58:06 volumio volumio[1000]: info: Discovery: Getting this device information
May 12 23:58:06 volumio volumio[1000]: info: CoreCommandRouter::volumioGetState
May 12 23:58:06 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 12 23:58:07 volumio volumio[1000]: info: CoreCommandRouter::volumioGetState
May 12 23:58:09 volumio sudo[8050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 12 23:58:09 volumio sudo[8050]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 12 23:58:09 volumio sudo[8050]: pam_unix(sudo:session): session closed for user root
May 12 23:58:09 volumio sudo[8053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 12 23:58:09 volumio sudo[8053]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 12 23:58:09 volumio sudo[8053]: pam_unix(sudo:session): session closed for user root
May 12 23:58:09 volumio volumio[1000]: verbose: New Socket.io Connection to 192.168.1.16 from 192.168.1.22 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.113 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
May 12 23:58:10 volumio sudo[8072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 12 23:58:10 volumio sudo[8072]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 12 23:58:10 volumio sudo[8072]: pam_unix(sudo:session): session closed for user root
May 12 23:58:10 volumio sudo[8075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 12 23:58:10 volumio sudo[8075]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 12 23:58:10 volumio sudo[8075]: pam_unix(sudo:session): session closed for user root
May 12 23:58:10 volumio volumio[1000]: verbose: New Socket.io Connection to 192.168.1.16 from 192.168.1.22 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.113 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::volumioGetVisibleSources
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::volumioGetState
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 12 23:58:10 volumio volumio[1000]: info: Received Get System Info
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 12 23:58:10 volumio volumio[1000]: info: Discovery: Getting this device information
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::volumioGetState
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::volumioGetState
May 12 23:58:10 volumio volumio[1000]: info: Listing playlists
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 12 23:58:10 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 12 23:58:12 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 12 23:58:12 volumio volumio[1000]: info: Received Get System Info
May 12 23:58:12 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 12 23:58:12 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 12 23:58:12 volumio volumio[1000]: info: Discovery: Getting this device information
May 12 23:58:12 volumio volumio[1000]: info: CoreCommandRouter::volumioGetState
May 12 23:58:12 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 12 23:58:12 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::getUIConfigOnPlugin
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::getUIConfigOnPlugin
May 12 23:58:13 volumio volumio[1000]: info: Retrieving Cloud Streaming UI
May 12 23:58:13 volumio volumio[1000]: info: Getting Tidal Cloud Configuration
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::getUIConfigOnPlugin
May 12 23:58:13 volumio volumio[1000]: info: Getting Qobuz Cloud Configuration
May 12 23:58:13 volumio volumio[1000]: info: Asking plugin for UI Config
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::getUIConfigOnPlugin
May 12 23:58:13 volumio volumio[1000]: info: Getting Spotify Cloud Configuration
May 12 23:58:13 volumio volumio[1000]: info: Asking plugin for UI Config
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::getUIConfigOnPlugin
May 12 23:58:13 volumio volumio[1000]: info: Saving Spotify Acccount
May 12 23:58:13 volumio volumio[1000]: info: Got Tidal Cloud Configuration
May 12 23:58:13 volumio volumio[1000]: info: Got it
May 12 23:58:13 volumio volumio[1000]: info: Got it
May 12 23:58:13 volumio volumio[1000]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::getUIConfigOnPlugin
May 12 23:58:13 volumio volumio[1000]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::volumioGetBrowseSources
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::volumioGetBrowseSources
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::volumioGetBrowseSources
May 12 23:58:13 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 12 23:58:14 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 12 23:58:14 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 12 23:58:14 volumio volumio[1000]: info: Received Get System Info
May 12 23:58:14 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 12 23:58:14 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 12 23:58:14 volumio volumio[1000]: info: Discovery: Getting this device information
May 12 23:58:14 volumio volumio[1000]: info: CoreCommandRouter::volumioGetState
May 12 23:58:14 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 12 23:58:17 volumio go-librespot[1592]: time="2025-05-12T23:58:17+02:00" level=trace msg="sent dealer ping"
May 12 23:58:17 volumio go-librespot[1592]: time="2025-05-12T23:58:17+02:00" level=trace msg="received dealer pong"
May 12 23:58:17 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 12 23:58:18 volumio volumio[1000]: info: Disabling MyMusic plugin upnp
May 12 23:58:18 volumio sudo[8080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
May 12 23:58:18 volumio sudo[8080]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 12 23:58:18 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD...
May 12 23:58:18 volumio volumio[1000]: error: Upnp client error: Error: This socket has been ended by the other party
May 12 23:58:20 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 12 23:58:20 volumio volumio[1000]: info: Enabling MyMusic plugin upnp
May 12 23:58:20 volumio volumio[1000]: info: Enabling plugin upnp
May 12 23:58:20 volumio volumio[1000]: info: Loading plugin "upnp"...
May 12 23:58:20 volumio volumio[1000]: info: [1747087100514] Starting Upmpd Daemon
May 12 23:58:20 volumio volumio[1000]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 12 23:58:20 volumio volumio[1000]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 12 23:58:20 volumio volumio[1000]: Error: listen EADDRINUSE: address already in use :::6599
May 12 23:58:20 volumio volumio[1000]: at Server.setupListenHandle [as _listen2] (net.js:1331:16)
May 12 23:58:20 volumio volumio[1000]: at listenInCluster (net.js:1379:12)
May 12 23:58:20 volumio volumio[1000]: at Server.listen (net.js:1465:7)
May 12 23:58:20 volumio volumio[1000]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
May 12 23:58:20 volumio volumio[1000]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
May 12 23:58:20 volumio volumio[1000]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
May 12 23:58:20 volumio volumio[1000]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
May 12 23:58:20 volumio volumio[1000]: at processTicksAndRejections (internal/process/task_queues.js:77:11) {
May 12 23:58:20 volumio volumio[1000]: code: 'EADDRINUSE',
May 12 23:58:20 volumio volumio[1000]: errno: -98,
May 12 23:58:20 volumio volumio[1000]: syscall: 'listen',
May 12 23:58:20 volumio volumio[1000]: address: '::',
May 12 23:58:20 volumio volumio[1000]: port: 6599
May 12 23:58:20 volumio volumio[1000]: }
May 12 23:58:20 volumio volumio[1000]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 12 23:58:20 volumio sudo[8105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-12 23:57
May 12 23:58:20 volumio sudo[8105]: 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="Wed 30 Apr 2025 12:21:23 PM CEST"
VOLUMIO_VERSION="3.807"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="a9588e47e4b05f1a05bf70b4acc7555c"