-- Logs begin at Thu 2024-07-18 14:35:42 JST, end at Thu 2024-07-18 14:38:06 JST. --
Jul 18 14:37:00 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 18 14:37:01 volumio volumio[1042]: info: Retrieving Cloud Streaming UI
Jul 18 14:37:01 volumio volumio[1042]: info: Getting Tidal Cloud Configuration
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 18 14:37:01 volumio volumio[1042]: info: Getting Qobuz Cloud Configuration
Jul 18 14:37:01 volumio volumio[1042]: info: Asking plugin for UI Config
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 18 14:37:01 volumio volumio[1042]: info: Getting Spotify Cloud Configuration
Jul 18 14:37:01 volumio volumio[1042]: info: Asking plugin for UI Config
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 18 14:37:01 volumio volumio[1042]: info: Saving Spotify Acccount
Jul 18 14:37:01 volumio volumio[1042]: info: Got Tidal Cloud Configuration
Jul 18 14:37:01 volumio volumio[1042]: info: Got it
Jul 18 14:37:01 volumio volumio[1042]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 18 14:37:01 volumio volumio[1042]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:01 volumio mpd[2554]: exception: No database
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Jul 18 14:37:01 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 18 14:37:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:05 volumio mpd[2554]: exception: No database
Jul 18 14:37:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Jul 18 14:37:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 18 14:37:05 volumio volumio-remote-updater[776]: No test mode
Jul 18 14:37:05 volumio volumio-remote-updater[776]: No alpha test mode
Jul 18 14:37:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Jul 18 14:37:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Jul 18 14:37:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 18 14:37:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Jul 18 14:37:06 volumio volumio-remote-updater[776]: No test mode
Jul 18 14:37:06 volumio volumio-remote-updater[776]: No alpha test mode
Jul 18 14:37:06 volumio volumio[1042]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Jul 18 14:37:06 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jul 18 14:37:06 volumio volumio[1042]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Jul 18 14:37:06 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jul 18 14:37:07 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Jul 18 14:37:07 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 18 14:37:07 volumio systemd[1]: systemd-timedated.service: Succeeded.
Jul 18 14:37:07 volumio volumio-remote-updater[776]: No test mode
Jul 18 14:37:07 volumio volumio-remote-updater[776]: No alpha test mode
Jul 18 14:37:07 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Jul 18 14:37:07 volumio volumio[1042]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Jul 18 14:37:07 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jul 18 14:37:08 volumio volumio[1042]: info: CoreCommandRouter::Close All Modals sent
Jul 18 14:37:08 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted
Jul 18 14:37:08 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 18 14:37:08 volumio volumio[1042]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jul 18 14:37:08 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jul 18 14:37:08 volumio volumio[1042]: info: Received Get System Version
Jul 18 14:37:08 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 18 14:37:08 volumio volumio[1042]: info: Received Get System Info
Jul 18 14:37:08 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 18 14:37:08 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 18 14:37:08 volumio volumio[1042]: info: Discovery: Getting this device information
Jul 18 14:37:08 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState
Jul 18 14:37:08 volumio volumio[1042]: info: CorePlayQueue::getTrack 0
Jul 18 14:37:08 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 18 14:37:09 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:09 volumio mpd[2554]: exception: No database
Jul 18 14:37:10 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 18 14:37:10 volumio volumio[1042]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jul 18 14:37:10 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jul 18 14:37:10 volumio volumio[1042]: info: Received Get System Version
Jul 18 14:37:10 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 18 14:37:10 volumio volumio[1042]: info: Received Get System Info
Jul 18 14:37:10 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 18 14:37:10 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 18 14:37:10 volumio volumio[1042]: info: Discovery: Getting this device information
Jul 18 14:37:10 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState
Jul 18 14:37:10 volumio volumio[1042]: info: CorePlayQueue::getTrack 0
Jul 18 14:37:10 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 18 14:37:11 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Jul 18 14:37:11 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Jul 18 14:37:13 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:13 volumio mpd[2554]: exception: No database
Jul 18 14:37:17 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:17 volumio mpd[2554]: exception: No database
Jul 18 14:37:21 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:21 volumio mpd[2554]: exception: No database
Jul 18 14:37:25 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:25 volumio mpd[2554]: exception: No database
Jul 18 14:37:29 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:29 volumio mpd[2554]: exception: No database
Jul 18 14:37:33 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:33 volumio mpd[2554]: exception: No database
Jul 18 14:37:37 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:37 volumio mpd[2554]: exception: No database
Jul 18 14:37:41 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:41 volumio mpd[2554]: exception: No database
Jul 18 14:37:45 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:45 volumio mpd[2554]: exception: No database
Jul 18 14:37:49 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:49 volumio mpd[2554]: exception: No database
Jul 18 14:37:53 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:53 volumio mpd[2554]: exception: No database
Jul 18 14:37:54 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare
Jul 18 14:37:54 volumio volumio[1042]: info: Adding a new share
Jul 18 14:37:54 volumio volumio[1042]: info: No correspondence found in configuration for share music1 on IP 192.168.10.129
Jul 18 14:37:54 volumio sudo[2798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=shinoryo,password=susumu0327,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.10.129/music1 /mnt/NAS/music1
Jul 18 14:37:54 volumio sudo[2798]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 18 14:37:54 volumio kernel: FS-Cache: Loaded
Jul 18 14:37:54 volumio kernel: Key type dns_resolver registered
Jul 18 14:37:54 volumio kernel: Key type cifs.spnego registered
Jul 18 14:37:54 volumio kernel: Key type cifs.idmap registered
Jul 18 14:37:54 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount.
Jul 18 14:37:54 volumio kernel: CIFS: Attempting to mount //192.168.10.129/music1
Jul 18 14:37:54 volumio sudo[2798]: pam_unix(sudo:session): session closed for user root
Jul 18 14:37:54 volumio volumio[1042]: info: [1721281074857] Database scan error: Error: Command failed: /usr/bin/mpc update
Jul 18 14:37:54 volumio volumio[1042]: MPD error: No database
Jul 18 14:37:55 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Jul 18 14:37:57 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:37:57 volumio mpd[2554]: exception: No database
Jul 18 14:38:01 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:38:01 volumio mpd[2554]: exception: No database
Jul 18 14:38:02 volumio volumio[1042]: info: Disabling MyMusic plugin upnp
Jul 18 14:38:02 volumio sudo[2825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Jul 18 14:38:02 volumio sudo[2825]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 18 14:38:02 volumio volumio[1042]: error: Upnp client error: Error: This socket has been ended by the other party
Jul 18 14:38:02 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD...
Jul 18 14:38:04 volumio volumio[1042]: info: Disabling MyMusic plugin airplay_emulation
Jul 18 14:38:04 volumio volumio[1042]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync
Jul 18 14:38:04 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 18 14:38:04 volumio volumio[1042]: info: Disabling plugin airplay_emulation
Jul 18 14:38:04 volumio volumio[1042]: info: Done.
Jul 18 14:38:04 volumio sudo[2828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync
Jul 18 14:38:04 volumio sudo[2828]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 18 14:38:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 18 14:38:04 volumio systemd[1]: shairport-sync.service: Succeeded.
Jul 18 14:38:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 18 14:38:04 volumio sudo[2828]: pam_unix(sudo:session): session closed for user root
Jul 18 14:38:04 volumio volumio[1042]: info: Shairport-Sync Stopped
Jul 18 14:38:05 volumio volumio[1042]: info: Disabling MyMusic plugin upnp
Jul 18 14:38:05 volumio sudo[2831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Jul 18 14:38:05 volumio sudo[2831]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 18 14:38:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 18 14:38:05 volumio mpd[2554]: exception: No database
Jul 18 14:38:06 volumio volumio[1042]: info: Enabling MyMusic plugin upnp
Jul 18 14:38:06 volumio volumio[1042]: info: Enabling plugin upnp
Jul 18 14:38:06 volumio volumio[1042]: info: Loading plugin "upnp"...
Jul 18 14:38:06 volumio volumio[1042]: info: [1721281086352] Starting Upmpd Daemon
Jul 18 14:38:06 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 18 14:38:06 volumio volumio[1042]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 18 14:38:06 volumio volumio[1042]: Error: listen EADDRINUSE: address already in use :::6599
Jul 18 14:38:06 volumio volumio[1042]: at Server.setupListenHandle [as _listen2] (net.js:1331:16)
Jul 18 14:38:06 volumio volumio[1042]: at listenInCluster (net.js:1379:12)
Jul 18 14:38:06 volumio volumio[1042]: at Server.listen (net.js:1465:7)
Jul 18 14:38:06 volumio volumio[1042]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
Jul 18 14:38:06 volumio volumio[1042]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
Jul 18 14:38:06 volumio volumio[1042]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Jul 18 14:38:06 volumio volumio[1042]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Jul 18 14:38:06 volumio volumio[1042]: at processTicksAndRejections (internal/process/task_queues.js:77:11) {
Jul 18 14:38:06 volumio volumio[1042]: code: 'EADDRINUSE',
Jul 18 14:38:06 volumio volumio[1042]: errno: -98,
Jul 18 14:38:06 volumio volumio[1042]: syscall: 'listen',
Jul 18 14:38:06 volumio volumio[1042]: address: '::',
Jul 18 14:38:06 volumio volumio[1042]: port: 6599
Jul 18 14:38:06 volumio volumio[1042]: }
Jul 18 14:38:06 volumio volumio[1042]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 18 14:38:06 volumio sudo[2842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-18 14:37
Jul 18 14:38:06 volumio sudo[2842]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"