-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Wed 2024-04-24 20:29:20 MSK. -- Apr 24 20:28:03 volumio volumio[760]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 20:28:03 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 24 20:28:03 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Apr 24 20:28:03 volumio sudo[2735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Apr 24 20:28:03 volumio sudo[2735]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 20:28:03 volumio sudo[2735]: pam_unix(sudo:session): session closed for user root Apr 24 20:28:03 volumio sudo[2740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 24 20:28:03 volumio sudo[2740]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 20:28:03 volumio sudo[2748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 24 20:28:03 volumio sudo[2748]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 20:28:03 volumio sudo[2740]: pam_unix(sudo:session): session closed for user root Apr 24 20:28:03 volumio sudo[2753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 24 20:28:03 volumio sudo[2753]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 20:28:03 volumio sudo[2748]: pam_unix(sudo:session): session closed for user root Apr 24 20:28:03 volumio sudo[2753]: pam_unix(sudo:session): session closed for user root Apr 24 20:28:03 volumio sudo[2761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 24 20:28:03 volumio sudo[2761]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 20:28:03 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 24 20:28:03 volumio sudo[2761]: pam_unix(sudo:session): session closed for user root Apr 24 20:28:03 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 24 20:28:03 volumio sudo[2763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 20:28:03 volumio sudo[2763]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 20:28:03 volumio sudo[2763]: pam_unix(sudo:session): session closed for user root Apr 24 20:28:04 volumio sudo[2767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 24 20:28:04 volumio sudo[2767]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 20:28:06 volumio volumio[760]: info: CoreCommandRouter::volumioGetState Apr 24 20:28:06 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 20:28:08 volumio volumio[760]: info: Retrieving Cloud Streaming UI Apr 24 20:28:08 volumio volumio[760]: info: Getting Tidal Cloud Configuration Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 20:28:08 volumio volumio[760]: info: Getting Qobuz Cloud Configuration Apr 24 20:28:08 volumio volumio[760]: info: Asking plugin for UI Config Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 20:28:08 volumio volumio[760]: info: Getting Spotify Cloud Configuration Apr 24 20:28:08 volumio volumio[760]: info: Asking plugin for UI Config Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 20:28:08 volumio volumio[760]: info: Saving Spotify Acccount Apr 24 20:28:08 volumio volumio[760]: info: Got Tidal Cloud Configuration Apr 24 20:28:08 volumio volumio[760]: info: Got it Apr 24 20:28:08 volumio volumio[760]: info: Got it Apr 24 20:28:08 volumio volumio[760]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 20:28:08 volumio volumio[760]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::volumioGetBrowseSources Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::volumioGetBrowseSources Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::volumioGetBrowseSources Apr 24 20:28:08 volumio sudo[2767]: pam_unix(sudo:session): session closed for user root Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 20:28:08 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 24 20:28:10 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Apr 24 20:28:10 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Apr 24 20:28:11 volumio wpa_supplicant[1811]: RRM: Ignoring radio measurement request: Not RRM network Apr 24 20:28:12 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 20:28:16 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 20:28:20 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 20:28:24 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 20:28:28 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 20:28:32 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 20:28:36 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 20:28:40 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 20:28:41 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Apr 24 20:28:41 volumio volumio[760]: info: Adding a new share Apr 24 20:28:41 volumio volumio[760]: info: No correspondence found in configuration for share music on IP 192.168.1.3 Apr 24 20:28:41 volumio sudo[2816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=server,password=2503,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.3/music2 /mnt/NAS/music Apr 24 20:28:41 volumio sudo[2816]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 20:28:41 volumio kernel: Key type cifs.spnego registered Apr 24 20:28:41 volumio kernel: Key type cifs.idmap registered Apr 24 20:28:41 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. Apr 24 20:28:41 volumio kernel: CIFS: Attempting to mount \\192.168.1.3\music2 Apr 24 20:28:41 volumio sudo[2816]: pam_unix(sudo:session): session closed for user root Apr 24 20:28:41 volumio volumio[760]: verbose: ControllerMpd::sendMpdCommand status Apr 24 20:28:41 volumio volumio[760]: info: Apr 24 20:28:41 volumio volumio[760]: ---------------------------- MPD announces state update: update Apr 24 20:28:41 volumio volumio[760]: info: ControllerMpd::getState Apr 24 20:28:41 volumio volumio[760]: verbose: ControllerMpd::sendMpdCommand status Apr 24 20:28:41 volumio volumio[760]: info: sendMpdCommand status took 7 milliseconds Apr 24 20:28:41 volumio volumio[760]: info: sendMpdCommand status took 5 milliseconds Apr 24 20:28:41 volumio volumio[760]: verbose: ControllerMpd::parseState Apr 24 20:28:42 volumio volumio[760]: info: Command Router : Notfying DB Updatetrue Apr 24 20:28:42 volumio volumio[760]: verbose: ControllerMpd::parseState Apr 24 20:28:42 volumio volumio[760]: info: ControllerMpd::pushState Apr 24 20:28:42 volumio volumio[760]: info: CoreCommandRouter::servicePushState Apr 24 20:28:42 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:42 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:42 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:42 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:42 volumio volumio[760]: 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} Apr 24 20:28:42 volumio volumio[760]: verbose: CURRENT POSITION 0 Apr 24 20:28:42 volumio volumio[760]: info: CoreStateMachine::syncState stateService stop Apr 24 20:28:42 volumio volumio[760]: info: CoreStateMachine::syncState currentStatus stop Apr 24 20:28:42 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:42 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:42 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 20:28:42 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:42 volumio volumio[760]: info: No code Apr 24 20:28:42 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:42 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:42 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:42 volumio volumio[760]: info: ------------------------------ 87ms Apr 24 20:28:42 volumio volumio[760]: info: [1713979722063] Database update started Apr 24 20:28:42 volumio nmbd[615]: [2024/04/24 20:28:42.569848, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 24 20:28:42 volumio nmbd[615]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.13 for name WORKGROUP<1d>. Apr 24 20:28:42 volumio nmbd[615]: This response was from IP 192.168.1.3, reporting an IP address of 192.168.1.3. Apr 24 20:28:42 volumio nmbd[615]: [2024/04/24 20:28:42.570156, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 24 20:28:42 volumio nmbd[615]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.12 for name WORKGROUP<1d>. Apr 24 20:28:42 volumio nmbd[615]: This response was from IP 192.168.1.3, reporting an IP address of 192.168.1.3. Apr 24 20:28:42 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 24 20:28:44 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 20:28:44 volumio volumio[760]: info: CoreCommandRouter::Close All Modals sent Apr 24 20:28:48 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 20:28:49 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Apr 24 20:28:49 volumio volumio[760]: verbose: ControllerMpd::sendMpdCommand update Apr 24 20:28:49 volumio volumio[760]: info: sendMpdCommand update took 3 milliseconds Apr 24 20:28:52 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 20:28:52 volumio volumio[760]: info: MPD Database updated - AlbumList cache refreshed Apr 24 20:28:52 volumio volumio[760]: info: Apr 24 20:28:52 volumio volumio[760]: ---------------------------- MPD announces state update: database Apr 24 20:28:52 volumio volumio[760]: verbose: ControllerMpd::sendMpdCommand status Apr 24 20:28:52 volumio volumio[760]: info: Apr 24 20:28:52 volumio volumio[760]: ---------------------------- MPD announces state update: update Apr 24 20:28:52 volumio volumio[760]: info: ControllerMpd::getState Apr 24 20:28:52 volumio volumio[760]: verbose: ControllerMpd::sendMpdCommand status Apr 24 20:28:52 volumio volumio[760]: info: ControllerMpd::getState Apr 24 20:28:52 volumio volumio[760]: verbose: ControllerMpd::sendMpdCommand status Apr 24 20:28:52 volumio volumio[760]: info: sendMpdCommand status took 345 milliseconds Apr 24 20:28:52 volumio volumio[760]: info: sendMpdCommand status took 344 milliseconds Apr 24 20:28:52 volumio volumio[760]: info: sendMpdCommand status took 345 milliseconds Apr 24 20:28:52 volumio volumio[760]: verbose: ControllerMpd::parseState Apr 24 20:28:52 volumio volumio[760]: info: Command Router : Notfying DB Updatetrue Apr 24 20:28:52 volumio volumio[760]: info: CoreCommandRouter::Close All Modals sent Apr 24 20:28:52 volumio volumio[760]: verbose: ControllerMpd::parseState Apr 24 20:28:52 volumio volumio[760]: verbose: ControllerMpd::parseState Apr 24 20:28:52 volumio volumio[760]: info: ControllerMpd::pushState Apr 24 20:28:52 volumio volumio[760]: info: CoreCommandRouter::servicePushState Apr 24 20:28:52 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:52 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:52 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:52 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:52 volumio volumio[760]: 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} Apr 24 20:28:52 volumio volumio[760]: verbose: CURRENT POSITION 0 Apr 24 20:28:52 volumio volumio[760]: info: CoreStateMachine::syncState stateService stop Apr 24 20:28:52 volumio volumio[760]: info: CoreStateMachine::syncState currentStatus stop Apr 24 20:28:52 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:52 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:52 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:52 volumio volumio[760]: info: No code Apr 24 20:28:52 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:52 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:52 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:52 volumio volumio[760]: info: ControllerMpd::pushState Apr 24 20:28:52 volumio volumio[760]: info: CoreCommandRouter::servicePushState Apr 24 20:28:52 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:52 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:52 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:52 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:52 volumio volumio[760]: 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} Apr 24 20:28:52 volumio volumio[760]: verbose: CURRENT POSITION 0 Apr 24 20:28:52 volumio volumio[760]: info: CoreStateMachine::syncState stateService stop Apr 24 20:28:52 volumio volumio[760]: info: CoreStateMachine::syncState currentStatus stop Apr 24 20:28:52 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:52 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:52 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:52 volumio volumio[760]: info: No code Apr 24 20:28:52 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:52 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:52 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:52 volumio volumio[760]: info: ------------------------------ 426ms Apr 24 20:28:52 volumio volumio[760]: info: ------------------------------ 425ms Apr 24 20:28:54 volumio volumio[760]: info: CoreCommandRouter::volumioGetState Apr 24 20:28:54 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:54 volumio volumio[760]: info: MPD Database updated - AlbumList cache refreshed Apr 24 20:28:54 volumio volumio[760]: info: Apr 24 20:28:54 volumio volumio[760]: ---------------------------- MPD announces state update: database Apr 24 20:28:54 volumio volumio[760]: verbose: ControllerMpd::sendMpdCommand status Apr 24 20:28:54 volumio volumio[760]: info: Apr 24 20:28:54 volumio volumio[760]: ---------------------------- MPD announces state update: update Apr 24 20:28:54 volumio volumio[760]: info: ControllerMpd::getState Apr 24 20:28:54 volumio volumio[760]: verbose: ControllerMpd::sendMpdCommand status Apr 24 20:28:54 volumio volumio[760]: info: ControllerMpd::getState Apr 24 20:28:54 volumio volumio[760]: verbose: ControllerMpd::sendMpdCommand status Apr 24 20:28:54 volumio volumio[760]: info: sendMpdCommand status took 233 milliseconds Apr 24 20:28:54 volumio volumio[760]: info: sendMpdCommand status took 232 milliseconds Apr 24 20:28:54 volumio volumio[760]: info: sendMpdCommand status took 232 milliseconds Apr 24 20:28:54 volumio volumio[760]: verbose: ControllerMpd::parseState Apr 24 20:28:54 volumio volumio[760]: info: Command Router : Notfying DB Updatefalse Apr 24 20:28:54 volumio volumio[760]: info: CoreCommandRouter::Close All Modals sent Apr 24 20:28:54 volumio volumio[760]: verbose: ControllerMpd::parseState Apr 24 20:28:54 volumio volumio[760]: verbose: ControllerMpd::parseState Apr 24 20:28:54 volumio volumio[760]: info: ControllerMpd::pushState Apr 24 20:28:54 volumio volumio[760]: info: CoreCommandRouter::servicePushState Apr 24 20:28:54 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:54 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:54 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:54 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:54 volumio volumio[760]: 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} Apr 24 20:28:54 volumio volumio[760]: verbose: CURRENT POSITION 0 Apr 24 20:28:54 volumio volumio[760]: info: CoreStateMachine::syncState stateService stop Apr 24 20:28:54 volumio volumio[760]: info: CoreStateMachine::syncState currentStatus stop Apr 24 20:28:54 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:54 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:54 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 20:28:54 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:54 volumio volumio[760]: info: No code Apr 24 20:28:54 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:54 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:54 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:54 volumio volumio[760]: info: ControllerMpd::pushState Apr 24 20:28:54 volumio volumio[760]: info: CoreCommandRouter::servicePushState Apr 24 20:28:54 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:54 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:54 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:54 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:54 volumio volumio[760]: 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} Apr 24 20:28:54 volumio volumio[760]: verbose: CURRENT POSITION 0 Apr 24 20:28:54 volumio volumio[760]: info: CoreStateMachine::syncState stateService stop Apr 24 20:28:54 volumio volumio[760]: info: CoreStateMachine::syncState currentStatus stop Apr 24 20:28:54 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:54 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:54 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:54 volumio volumio[760]: info: No code Apr 24 20:28:54 volumio volumio[760]: info: CoreStateMachine::pushState Apr 24 20:28:54 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:28:54 volumio volumio[760]: info: CoreCommandRouter::volumioPushState Apr 24 20:28:54 volumio volumio[760]: info: ------------------------------ 298ms Apr 24 20:28:54 volumio volumio[760]: info: ------------------------------ 299ms Apr 24 20:29:10 volumio volumio[760]: info: CoreCommandRouter::volumioGetState Apr 24 20:29:10 volumio volumio[760]: info: CorePlayQueue::getTrack 0 Apr 24 20:29:14 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 20:29:14 volumio volumio[760]: info: CURURI: music-library Apr 24 20:29:14 volumio volumio[760]: info: Preload queue cleared Apr 24 20:29:15 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 20:29:15 volumio volumio[760]: info: CURURI: music-library/NAS Apr 24 20:29:15 volumio volumio[760]: info: Preload queue cleared Apr 24 20:29:16 volumio volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 20:29:16 volumio volumio[760]: info: CURURI: music-library/NAS/music Apr 24 20:29:16 volumio volumio[760]: info: Preload queue cleared Apr 24 20:29:19 volumio volumio[760]: info: Preload queue cleared Apr 24 20:29:19 volumio volumio[760]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 20:29:19 volumio volumio[760]: info: CoreStateMachine::ClearQueue Apr 24 20:29:19 volumio volumio[760]: info: CoreStateMachine::stop Apr 24 20:29:19 volumio volumio[760]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 20:29:19 volumio volumio[760]: info: CorePlayQueue::clearPlayQueue Apr 24 20:29:19 volumio volumio[760]: info: CorePlayQueue::saveQueue Apr 24 20:29:19 volumio volumio[760]: info: CoreCommandRouter::volumioPushQueue Apr 24 20:29:19 volumio volumio[760]: info: CoreStateMachine::addQueueItems Apr 24 20:29:19 volumio volumio[760]: info: CorePlayQueue::addQueueItems Apr 24 20:29:19 volumio volumio[760]: info: Preload queue cleared Apr 24 20:29:19 volumio volumio[760]: info: Adding Item to queue: music-library/NAS/music/Andru Donalds (2CD) (1999, 2001) (FLAC)- Apr 24 20:29:19 volumio volumio[760]: info: Exploding uri music-library/NAS/music/Andru Donalds (2CD) (1999, 2001) (FLAC)- in service mpd Apr 24 20:29:19 volumio volumio[760]: info: ALBUMART /albumart?cacheid=292&web=Andru%20Donalds/Let's%20Talk%20About%20It/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2FAndru%20Donalds%20%20%20(2CD)%20(1999%2C%202001)%20(FLAC)-%2FAndru%20Donalds%20-%20Let's%20Talk%20About%20It%20(Virgin%207243%208%2050652%202%204)%2FAndru%20Donalds%20-%20Let's%20Talk%20About%20It.cue&metadata=false Apr 24 20:29:19 volumio volumio[760]: info: URI /mnt/NAS/music/Andru Donalds (2CD) (1999, 2001) (FLAC)-/Andru Donalds - Let's Talk About It (Virgin 7243 8 50652 2 4)/Andru Donalds - Let's Talk About It.cue Apr 24 20:29:19 volumio volumio[760]: info: ALBUMART /albumart?cacheid=292&web=Andru%20Donalds/Let's%20Talk%20About%20It/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2FAndru%20Donalds%20%20%20(2CD)%20(1999%2C%202001)%20(FLAC)-%2FAndru%20Donalds%20-%20Let's%20Talk%20About%20It%20(Virgin%207243%208%2050652%202%204)%2FAndru%20Donalds%20-%20Let's%20Talk%20About%20It.cue&metadata=false Apr 24 20:29:19 volumio volumio[760]: info: URI /mnt/NAS/music/Andru Donalds (2CD) (1999, 2001) (FLAC)-/Andru Donalds - Let's Talk About It (Virgin 7243 8 50652 2 4)/Andru Donalds - Let's Talk About It.cue Apr 24 20:29:19 volumio volumio[760]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 20:29:19 volumio volumio[760]: Error: Unable to resolve or reject the same promise twice Apr 24 20:29:19 volumio volumio[760]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 24 20:29:19 volumio volumio[760]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 24 20:29:19 volumio volumio[760]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 24 20:29:19 volumio volumio[760]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 24 20:29:19 volumio volumio[760]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 24 20:29:19 volumio volumio[760]: at Socket.emit (events.js:315:20) Apr 24 20:29:19 volumio volumio[760]: at addChunk (internal/streams/readable.js:309:12) Apr 24 20:29:19 volumio volumio[760]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 24 20:29:19 volumio volumio[760]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 24 20:29:19 volumio volumio[760]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 24 20:29:19 volumio volumio[760]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 20:29:20 volumio sudo[3029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-24 20:28 Apr 24 20:29:20 volumio sudo[3029]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"