-- Logs begin at Sat 2024-08-17 10:31:40 UTC, end at Sat 2024-08-17 10:38:48 UTC. -- Aug 17 10:37:18 volumio volumio[907]: info: CoreCommandRouter::volumioGetVisibleSources Aug 17 10:37:18 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 17 10:37:18 volumio volumio[907]: info: CoreCommandRouter::volumioGetQueue Aug 17 10:37:18 volumio volumio[907]: info: CoreStateMachine::getQueue Aug 17 10:37:18 volumio volumio[907]: info: CorePlayQueue::getQueue Aug 17 10:37:18 volumio volumio[907]: info: Listing playlists Aug 17 10:37:21 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 17 10:37:21 volumio volumio[907]: info: CURURI: music-library Aug 17 10:37:21 volumio volumio[907]: error: Failed LSINFO: null Aug 17 10:37:28 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 17 10:37:28 volumio volumio[907]: info: CURURI: music-library Aug 17 10:37:28 volumio volumio[907]: error: Failed LSINFO: null Aug 17 10:36:28 volumio systemd[1]: Time has been changed Aug 17 10:36:41 volumio volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 17 10:36:41 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 17 10:36:41 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 10:36:41 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 17 10:36:42 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:36:42 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:36:42 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:36:42 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:36:42 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:36:42 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:36:42 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:36:42 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 17 10:36:42 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 17 10:37:07 volumio volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 17 10:37:07 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 17 10:37:07 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Aug 17 10:37:07 volumio sudo[2411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Aug 17 10:37:07 volumio sudo[2411]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 10:37:07 volumio sudo[2416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Aug 17 10:37:07 volumio sudo[2411]: pam_unix(sudo:session): session closed for user root Aug 17 10:37:07 volumio sudo[2416]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 10:37:07 volumio sudo[2416]: pam_unix(sudo:session): session closed for user root Aug 17 10:37:07 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Aug 17 10:37:07 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Aug 17 10:37:07 volumio sudo[2422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Aug 17 10:37:07 volumio sudo[2422]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 10:37:07 volumio sudo[2422]: pam_unix(sudo:session): session closed for user root Aug 17 10:37:07 volumio sudo[2427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Aug 17 10:37:07 volumio sudo[2427]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 10:37:07 volumio sudo[2427]: pam_unix(sudo:session): session closed for user root Aug 17 10:37:07 volumio sudo[2434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 17 10:37:07 volumio sudo[2434]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 10:37:07 volumio sudo[2436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 17 10:37:07 volumio sudo[2436]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 10:37:07 volumio sudo[2436]: pam_unix(sudo:session): session closed for user root Aug 17 10:37:07 volumio sudo[2434]: pam_unix(sudo:session): session closed for user root Aug 17 10:37:16 volumio volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 17 10:37:17 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 17 10:37:17 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 10:37:17 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 17 10:37:17 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:37:17 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:37:17 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:37:17 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:37:17 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:37:17 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:37:17 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:37:17 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 17 10:37:17 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 17 10:37:30 volumio volumio-remote-updater[636]: [2024-08-17 10:37:30] [disconnect] Disconnect close local:[1000] remote:[1000] Aug 17 10:37:30 volumio systemd[1]: volumio-remote-updater.service holdoff time over, scheduling restart. Aug 17 10:37:30 volumio systemd[1]: Stopping volumio-remote-updater.service... Aug 17 10:37:30 volumio systemd[1]: Starting volumio-remote-updater.service... Aug 17 10:37:30 volumio systemd[1]: Started volumio-remote-updater.service. Aug 17 10:37:30 volumio volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 17 10:37:31 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 17 10:37:31 volumio volumio-remote-updater[2454]: Error: No active session Aug 17 10:37:31 volumio volumio-remote-updater[2454]: [2024-08-17 10:37:31] [connect] Successful connection Aug 17 10:37:31 volumio volumio-remote-updater[2454]: [2024-08-17 10:37:31] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1723891051 101 Aug 17 10:37:31 volumio volumio[907]: info: Received Get System Version Aug 17 10:37:31 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 17 10:37:35 volumio volumio[907]: error: Upnp client error: Error: This socket has been ended by the other party Aug 17 10:37:40 volumio volumio-remote-updater[2454]: No test mode Aug 17 10:37:41 volumio volumio[907]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 17 10:37:45 volumio volumio[907]: info: CoreCommandRouter::Close All Modals sent Aug 17 10:38:04 volumio nmbd[941]: [2024/08/17 10:38:04.618278, 0] ../source3/libsmb/nmblib.c:873(send_udp) Aug 17 10:38:04 volumio nmbd[941]: Packet send failed to 192.168.1.255(138) ERRNO=Invalid argument Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 17 10:38:19 volumio volumio[907]: info: Retrieving Cloud Streaming UI Aug 17 10:38:19 volumio volumio[907]: info: Getting Tidal Cloud Configuration Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 17 10:38:19 volumio volumio[907]: info: Getting Qobuz Cloud Configuration Aug 17 10:38:19 volumio volumio[907]: info: Asking plugin for UI Config Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 17 10:38:19 volumio volumio[907]: info: Getting Spotify Cloud Configuration Aug 17 10:38:19 volumio volumio[907]: info: Asking plugin for UI Config Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 17 10:38:19 volumio volumio[907]: info: Saving Spotify Acccount Aug 17 10:38:19 volumio volumio[907]: info: Got Tidal Cloud Configuration Aug 17 10:38:19 volumio volumio[907]: info: Got it Aug 17 10:38:19 volumio volumio[907]: info: Got it Aug 17 10:38:19 volumio volumio[907]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 17 10:38:19 volumio volumio[907]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 10:38:19 volumio volumio[907]: info: CoreCommandRouter::volumioGetBrowseSources Aug 17 10:38:20 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 17 10:38:21 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 17 10:38:24 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 17 10:38:28 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 17 10:38:32 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 17 10:38:36 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 17 10:38:40 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 17 10:38:41 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Aug 17 10:38:42 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 17 10:38:42 volumio sudo[2166]: pam_unix(sudo:session): session closed for user root Aug 17 10:38:42 volumio volumio[907]: info: Cannot mount NAS Music-DSD at system boot, trial number 3 ,retrying in 5 seconds Aug 17 10:38:44 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Aug 17 10:38:45 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 17 10:38:46 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand status Aug 17 10:38:46 volumio volumio[907]: info: Aug 17 10:38:46 volumio volumio[907]: ---------------------------- MPD announces state update: update Aug 17 10:38:46 volumio volumio[907]: info: ControllerMpd::getState Aug 17 10:38:46 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand status Aug 17 10:38:46 volumio volumio[907]: info: sendMpdCommand status took 7 milliseconds Aug 17 10:38:46 volumio volumio[907]: info: sendMpdCommand status took 6 milliseconds Aug 17 10:38:46 volumio volumio[907]: verbose: ControllerMpd::parseState Aug 17 10:38:46 volumio volumio[907]: info: Command Router : Notfying DB Updatetrue Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::Close All Modals sent Aug 17 10:38:46 volumio volumio[907]: verbose: ControllerMpd::parseState Aug 17 10:38:46 volumio volumio[907]: info: ControllerMpd::pushState Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::servicePushState Aug 17 10:38:46 volumio volumio[907]: info: CoreStateMachine::pushState Aug 17 10:38:46 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 10:38:46 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Aug 17 10:38:46 volumio volumio[907]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 17 10:38:46 volumio volumio[907]: verbose: CURRENT POSITION 0 Aug 17 10:38:46 volumio volumio[907]: info: CoreStateMachine::syncState stateService stop Aug 17 10:38:46 volumio volumio[907]: info: CoreStateMachine::syncState currentStatus stop Aug 17 10:38:46 volumio volumio[907]: info: CoreStateMachine::pushState Aug 17 10:38:46 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 10:38:46 volumio volumio[907]: info: No code Aug 17 10:38:46 volumio volumio[907]: info: CoreStateMachine::pushState Aug 17 10:38:46 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 10:38:46 volumio volumio[907]: info: ------------------------------ 68ms Aug 17 10:38:46 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand status Aug 17 10:38:46 volumio volumio[907]: info: Aug 17 10:38:46 volumio volumio[907]: ---------------------------- MPD announces state update: update Aug 17 10:38:46 volumio volumio[907]: info: ControllerMpd::getState Aug 17 10:38:46 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand status Aug 17 10:38:46 volumio volumio[907]: info: sendMpdCommand status took 21 milliseconds Aug 17 10:38:46 volumio volumio[907]: info: sendMpdCommand status took 9 milliseconds Aug 17 10:38:46 volumio volumio[907]: verbose: ControllerMpd::parseState Aug 17 10:38:46 volumio volumio[907]: info: Command Router : Notfying DB Updatefalse Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::Close All Modals sent Aug 17 10:38:46 volumio volumio[907]: verbose: ControllerMpd::parseState Aug 17 10:38:46 volumio volumio[907]: info: ControllerMpd::pushState Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::servicePushState Aug 17 10:38:46 volumio volumio[907]: info: CoreStateMachine::pushState Aug 17 10:38:46 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 10:38:46 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Aug 17 10:38:46 volumio volumio[907]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 17 10:38:46 volumio volumio[907]: verbose: CURRENT POSITION 0 Aug 17 10:38:46 volumio volumio[907]: info: CoreStateMachine::syncState stateService stop Aug 17 10:38:46 volumio volumio[907]: info: CoreStateMachine::syncState currentStatus stop Aug 17 10:38:46 volumio volumio[907]: info: CoreStateMachine::pushState Aug 17 10:38:46 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 10:38:46 volumio volumio[907]: info: No code Aug 17 10:38:46 volumio volumio[907]: info: CoreStateMachine::pushState Aug 17 10:38:46 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Aug 17 10:38:46 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 10:38:46 volumio volumio[907]: info: ------------------------------ 84ms Aug 17 10:38:47 volumio volumio[907]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 17 10:38:47 volumio volumio[907]: TypeError: Cannot read property 'replace' of undefined Aug 17 10:38:47 volumio volumio[907]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:198:28) Aug 17 10:38:47 volumio volumio[907]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:251:20) Aug 17 10:38:47 volumio volumio[907]: at ontimeout (timers.js:482:11) Aug 17 10:38:47 volumio volumio[907]: at tryOnTimeout (timers.js:317:5) Aug 17 10:38:47 volumio volumio[907]: at Timer.listOnTimeout (timers.js:277:5) Aug 17 10:38:47 volumio volumio[907]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 17 10:38:48 volumio sudo[2622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-17 10:37 Aug 17 10:38:48 volumio sudo[2622]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"