-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sun 2024-07-07 15:20:48 UTC. -- Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreStateMachine::ClearQueue Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreStateMachine::stop Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 07 15:19:04 bmvolumio volumio[945]: verbose: UNSET VOLATILE Jul 07 15:19:04 bmvolumio volumio[945]: info: CorePlayQueue::clearPlayQueue Jul 07 15:19:04 bmvolumio volumio[945]: info: CorePlayQueue::saveQueue Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreCommandRouter::volumioPushState Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreCommandRouter::volumioPushQueue Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreStateMachine::addQueueItems Jul 07 15:19:04 bmvolumio volumio[945]: info: CorePlayQueue::addQueueItems Jul 07 15:19:04 bmvolumio volumio[945]: info: Adding Item to queue: music-library/NAS/BMNAS/CHILLOUT-LOUNGE-TRIPHOP/Air/10,000 Hz Legend/Air - 01 Electronic Performers.mp3 Jul 07 15:19:04 bmvolumio volumio[945]: info: Exploding uri music-library/NAS/BMNAS/CHILLOUT-LOUNGE-TRIPHOP/Air/10,000 Hz Legend/Air - 01 Electronic Performers.mp3 in service mpd Jul 07 15:19:04 bmvolumio volumio[945]: error: scanFolder - failure to stat '/mnt/NAS/BMNAS/CHILLOUT-LOUNGE-TRIPHOP/Air/10,000 Hz Legend/Air - 01 Electronic Performers.mp3' Jul 07 15:19:04 bmvolumio volumio[945]: info: CorePlayQueue::saveQueue Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreCommandRouter::volumioPushQueue Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreStateMachine::updateTrackBlock Jul 07 15:19:04 bmvolumio volumio[945]: info: CorePlayQueue::getTrackBlock Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreCommandRouter::volumioPlay Jul 07 15:19:04 bmvolumio volumio[945]: verbose: UNSET VOLATILE Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreStateMachine::play index 0 Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreStateMachine::stop Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 07 15:19:04 bmvolumio volumio[945]: verbose: UNSET VOLATILE Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreStateMachine::play index undefined Jul 07 15:19:04 bmvolumio volumio[945]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 07 15:19:04 bmvolumio volumio[945]: info: CorePlayQueue::getTrack 0 Jul 07 15:19:12 bmvolumio volumio[945]: info: CoreCommandRouter::volumioPlay Jul 07 15:19:12 bmvolumio volumio[945]: verbose: UNSET VOLATILE Jul 07 15:19:12 bmvolumio volumio[945]: info: CoreStateMachine::play index undefined Jul 07 15:19:12 bmvolumio volumio[945]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 07 15:19:12 bmvolumio volumio[945]: info: CorePlayQueue::getTrack 0 Jul 07 15:19:21 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 07 15:19:27 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 07 15:19:45 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 15:19:45 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 15:19:45 bmvolumio volumio[945]: info: Discovery: Getting this device information Jul 07 15:19:45 bmvolumio volumio[945]: info: CoreCommandRouter::volumioGetState Jul 07 15:19:45 bmvolumio volumio[945]: info: CorePlayQueue::getTrack 0 Jul 07 15:19:45 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 15:19:47 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 15:19:47 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 15:19:47 bmvolumio volumio[945]: info: Discovery: Getting this device information Jul 07 15:19:47 bmvolumio volumio[945]: info: CoreCommandRouter::volumioGetState Jul 07 15:19:47 bmvolumio volumio[945]: info: CorePlayQueue::getTrack 0 Jul 07 15:19:47 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 15:19:48 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 07 15:19:55 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 07 15:19:57 bmvolumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 15:19:57 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 07 15:19:58 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jul 07 15:19:58 bmvolumio sudo[10443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Jul 07 15:19:58 bmvolumio sudo[10443]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 15:19:58 bmvolumio sudo[10448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jul 07 15:19:58 bmvolumio sudo[10448]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 15:19:58 bmvolumio sudo[10443]: pam_unix(sudo:session): session closed for user root Jul 07 15:19:58 bmvolumio sudo[10448]: pam_unix(sudo:session): session closed for user root Jul 07 15:19:58 bmvolumio sudo[10456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jul 07 15:19:58 bmvolumio sudo[10456]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 15:19:58 bmvolumio sudo[10456]: pam_unix(sudo:session): session closed for user root Jul 07 15:19:58 bmvolumio sudo[10462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jul 07 15:19:58 bmvolumio sudo[10462]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 15:19:58 bmvolumio sudo[10462]: pam_unix(sudo:session): session closed for user root Jul 07 15:19:58 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jul 07 15:19:58 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jul 07 15:19:58 bmvolumio sudo[10469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 15:19:58 bmvolumio sudo[10469]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 15:19:58 bmvolumio sudo[10469]: pam_unix(sudo:session): session closed for user root Jul 07 15:19:58 bmvolumio sudo[10471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 15:19:58 bmvolumio sudo[10471]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 15:19:58 bmvolumio sudo[10471]: pam_unix(sudo:session): session closed for user root Jul 07 15:19:58 bmvolumio sudo[10475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 07 15:19:58 bmvolumio sudo[10475]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 15:19:59 bmvolumio sudo[10475]: pam_unix(sudo:session): session closed for user root Jul 07 15:20:27 bmvolumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 15:20:27 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 07 15:20:27 bmvolumio volumio[945]: info: Received Get System Version Jul 07 15:20:27 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 15:20:36 bmvolumio volumio[945]: info: Retrieving Cloud Streaming UI Jul 07 15:20:36 bmvolumio volumio[945]: info: Getting Tidal Cloud Configuration Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 15:20:36 bmvolumio volumio[945]: info: Getting Qobuz Cloud Configuration Jul 07 15:20:36 bmvolumio volumio[945]: info: Asking plugin for UI Config Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 15:20:36 bmvolumio volumio[945]: info: Getting Spotify Cloud Configuration Jul 07 15:20:36 bmvolumio volumio[945]: info: Asking plugin for UI Config Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 15:20:36 bmvolumio volumio[945]: info: Saving Spotify Acccount Jul 07 15:20:36 bmvolumio volumio[945]: info: Got Tidal Cloud Configuration Jul 07 15:20:36 bmvolumio volumio[945]: info: Got it Jul 07 15:20:36 bmvolumio volumio[945]: info: Got it Jul 07 15:20:36 bmvolumio volumio[945]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 15:20:36 bmvolumio volumio[945]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 15:20:36 bmvolumio volumio[945]: info: CoreCommandRouter::volumioGetBrowseSources Jul 07 15:20:37 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 15:20:37 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 07 15:20:41 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 15:20:43 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jul 07 15:20:44 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 07 15:20:45 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 15:20:47 bmvolumio volumio[945]: info: Disabling MyMusic plugin upnp Jul 07 15:20:47 bmvolumio sudo[10490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jul 07 15:20:47 bmvolumio sudo[10490]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 15:20:47 bmvolumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Jul 07 15:20:47 bmvolumio volumio[945]: error: Upnp client error: Error: This socket has been ended by the other party Jul 07 15:20:48 bmvolumio volumio[945]: info: Enabling MyMusic plugin upnp Jul 07 15:20:48 bmvolumio volumio[945]: info: Enabling plugin upnp Jul 07 15:20:48 bmvolumio volumio[945]: info: Loading plugin "upnp"... Jul 07 15:20:48 bmvolumio volumio[945]: info: [1720365648368] Starting Upmpd Daemon Jul 07 15:20:48 bmvolumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 07 15:20:48 bmvolumio volumio[945]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 15:20:48 bmvolumio volumio[945]: Error: listen EADDRINUSE: address already in use :::6599 Jul 07 15:20:48 bmvolumio volumio[945]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Jul 07 15:20:48 bmvolumio volumio[945]: at listenInCluster (net.js:1366:12) Jul 07 15:20:48 bmvolumio volumio[945]: at Server.listen (net.js:1452:7) Jul 07 15:20:48 bmvolumio volumio[945]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jul 07 15:20:48 bmvolumio volumio[945]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jul 07 15:20:48 bmvolumio volumio[945]: at Promise._successFn (/volumio/app/pluginmanager.js:1841:19) Jul 07 15:20:48 bmvolumio volumio[945]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 07 15:20:48 bmvolumio volumio[945]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Jul 07 15:20:48 bmvolumio volumio[945]: code: 'EADDRINUSE', Jul 07 15:20:48 bmvolumio volumio[945]: errno: -98, Jul 07 15:20:48 bmvolumio volumio[945]: syscall: 'listen', Jul 07 15:20:48 bmvolumio volumio[945]: address: '::', Jul 07 15:20:48 bmvolumio volumio[945]: port: 6599 Jul 07 15:20:48 bmvolumio volumio[945]: } Jul 07 15:20:48 bmvolumio volumio[945]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 15:20:48 bmvolumio sudo[10501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-07 15:19 Jul 07 15:20:48 bmvolumio sudo[10501]: 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="1c5fa5a8788b087ca429be9d10851b25c5cc4f5b" VOLUMIO_FE_VERSION="e5ce74e254a237ac98580c4437c4ed223c7d5cd9" VOLUMIO_FE3_VERSION="a86adf3c7ed2d6c50d9bca768f58ab2f56832dc1" VOLUMIO_BE_VERSION="c8882d89d3d4e0a1571e0dc9701741128f5a1656" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 31 Mar 2022 02:51:41 PM CEST" VOLUMIO_VERSION="3.251" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e83cc5fcd68eb3ee4105ab0b8b3779ea"