-- Logs begin at Thu 2019-02-14 17:11:59 +07, end at Thu 2024-07-18 19:51:07 +07. -- Jul 18 19:50:01 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:50:05 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:50:06 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Jul 18 19:50:06 volumio volumio[967]: info: Share music successfully unmounted Jul 18 19:50:06 volumio sudo[1438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Richard,password=Lu001698,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.110/music /mnt/NAS/music Jul 18 19:50:06 volumio sudo[1438]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:50:06 volumio kernel: CIFS: Attempting to mount \\192.168.3.110\music Jul 18 19:50:07 volumio ntpd[789]: Soliciting pool server 2001:c38:2000:180:d82a:1aff:fe38:f84b Jul 18 19:50:09 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:50:14 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:50:16 volumio sudo[1438]: pam_unix(sudo:session): session closed for user root Jul 18 19:50:16 volumio volumio[967]: info: An error occurred mounting the new share. Rolling back configuration Jul 18 19:50:16 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jul 18 19:50:16 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Jul 18 19:50:17 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 18 19:50:17 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:50:18 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Jul 18 19:50:18 volumio volumio[967]: info: Share music successfully unmounted Jul 18 19:50:18 volumio sudo[1448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Richard,password=Lu001698,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.110//music /mnt/NAS/music Jul 18 19:50:18 volumio sudo[1448]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:50:18 volumio kernel: CIFS: Attempting to mount \\192.168.3.110\ Jul 18 19:50:22 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:50:24 volumio sudo[1448]: pam_unix(sudo:session): session closed for user root Jul 18 19:50:24 volumio volumio[967]: info: An error occurred mounting the new share. Rolling back configuration Jul 18 19:50:24 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jul 18 19:50:24 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jul 18 19:50:25 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 18 19:50:25 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:50:29 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:50:32 volumio volumio[967]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:50:32 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 18 19:50:32 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jul 18 19:50:33 volumio sudo[1459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Jul 18 19:50:33 volumio sudo[1459]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:50:33 volumio sudo[1459]: pam_unix(sudo:session): session closed for user root Jul 18 19:50:33 volumio sudo[1464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jul 18 19:50:33 volumio sudo[1464]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:50:33 volumio sudo[1464]: pam_unix(sudo:session): session closed for user root Jul 18 19:50:33 volumio sudo[1472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jul 18 19:50:33 volumio sudo[1472]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:50:33 volumio sudo[1472]: pam_unix(sudo:session): session closed for user root Jul 18 19:50:33 volumio sudo[1477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jul 18 19:50:33 volumio sudo[1477]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:50:33 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jul 18 19:50:33 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jul 18 19:50:33 volumio sudo[1477]: pam_unix(sudo:session): session closed for user root Jul 18 19:50:33 volumio sudo[1484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 18 19:50:33 volumio sudo[1484]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:50:33 volumio sudo[1487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 18 19:50:33 volumio sudo[1487]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:50:33 volumio sudo[1484]: pam_unix(sudo:session): session closed for user root Jul 18 19:50:33 volumio sudo[1487]: pam_unix(sudo:session): session closed for user root Jul 18 19:50:33 volumio sudo[1490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 18 19:50:33 volumio sudo[1490]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:50:33 volumio sudo[1490]: pam_unix(sudo:session): session closed for user root Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:50:38 volumio volumio[967]: info: Retrieving Cloud Streaming UI Jul 18 19:50:38 volumio volumio[967]: info: Getting Tidal Cloud Configuration Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:50:38 volumio volumio[967]: info: Getting Qobuz Cloud Configuration Jul 18 19:50:38 volumio volumio[967]: info: Asking plugin for UI Config Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:50:38 volumio volumio[967]: info: Getting Spotify Cloud Configuration Jul 18 19:50:38 volumio volumio[967]: info: Asking plugin for UI Config Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:50:38 volumio volumio[967]: info: Saving Spotify Acccount Jul 18 19:50:38 volumio volumio[967]: info: Got Tidal Cloud Configuration Jul 18 19:50:38 volumio volumio[967]: info: Got it Jul 18 19:50:38 volumio volumio[967]: info: Got it Jul 18 19:50:38 volumio volumio[967]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:50:38 volumio volumio[967]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::volumioGetBrowseSources Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::volumioGetBrowseSources Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::volumioGetBrowseSources Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:50:38 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 18 19:50:42 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:50:46 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:50:50 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:50:54 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:50:55 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Jul 18 19:50:55 volumio volumio[967]: info: Share music successfully unmounted Jul 18 19:50:55 volumio sudo[1537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Richard,password=Lu001698,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.110/music /mnt/NAS/music Jul 18 19:50:55 volumio sudo[1537]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:50:55 volumio kernel: CIFS: Attempting to mount \\192.168.3.110\music Jul 18 19:50:58 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:51:02 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand update Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: info: Jul 18 19:51:04 volumio volumio[967]: ---------------------------- MPD announces state update: update Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand update took 7 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::getState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: info: Jul 18 19:51:04 volumio volumio[967]: ---------------------------- MPD announces state update: update Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::getState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: info: Jul 18 19:51:04 volumio volumio[967]: ---------------------------- MPD announces state update: update Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::getState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 11 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 9 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 8 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 7 milliseconds Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:04 volumio volumio[967]: info: Command Router : Notfying DB Updatetrue Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:04 volumio volumio[967]: info: Command Router : Notfying DB Updatetrue Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::Close All Modals sent Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 19:51:04 volumio volumio[967]: info: Jul 18 19:51:04 volumio volumio[967]: ---------------------------- MPD announces system playlist update Jul 18 19:51:04 volumio volumio[967]: info: Ignoring MPD Status Update Jul 18 19:51:04 volumio volumio[967]: info: MPD Database updated - AlbumList cache refreshed Jul 18 19:51:04 volumio volumio[967]: info: Jul 18 19:51:04 volumio volumio[967]: ---------------------------- MPD announces state update: database Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: info: Jul 18 19:51:04 volumio volumio[967]: ---------------------------- MPD announces state update: update Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 92 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::getState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::getState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 92 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand playlistinfo took 43 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand playlistinfo took 21 milliseconds Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:04 volumio volumio[967]: info: Command Router : Notfying DB Updatefalse Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::Close All Modals sent Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseTrackInfo Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseTrackInfo Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::pushState Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::servicePushState Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: 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} Jul 18 19:51:04 volumio volumio[967]: verbose: CURRENT POSITION 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::syncState stateService stop Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::syncState currentStatus stop Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: No code Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 18 19:51:04 volumio volumio[967]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 18 19:51:04 volumio volumio[967]: info: ------------------------------ 166ms Jul 18 19:51:04 volumio volumio[967]: info: ------------------------------ 173ms Jul 18 19:51:04 volumio volumio[967]: info: ------------------------------ 169ms Jul 18 19:51:04 volumio volumio[967]: info: Jul 18 19:51:04 volumio volumio[967]: ---------------------------- MPD announces system playlist update Jul 18 19:51:04 volumio volumio[967]: info: Ignoring MPD Status Update Jul 18 19:51:04 volumio volumio[967]: info: MPD Database updated - AlbumList cache refreshed Jul 18 19:51:04 volumio volumio[967]: info: Jul 18 19:51:04 volumio volumio[967]: ---------------------------- MPD announces state update: database Jul 18 19:51:04 volumio volumio[967]: info: Jul 18 19:51:04 volumio volumio[967]: ---------------------------- MPD announces system playlist update Jul 18 19:51:04 volumio volumio[967]: info: Ignoring MPD Status Update Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: info: Jul 18 19:51:04 volumio volumio[967]: ---------------------------- MPD announces state update: update Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::getState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::getState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: error: updateQueue error: null Jul 18 19:51:04 volumio volumio[967]: error: updateQueue error: null Jul 18 19:51:04 volumio volumio[967]: error: updateQueue error: null Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 103 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: ------------------------------ 108ms Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 101 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 101 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: ------------------------------ 27ms Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 24 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 24 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: ------------------------------ 26ms Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 23 milliseconds Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:04 volumio volumio[967]: info: Command Router : Notfying DB Updatefalse Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::Close All Modals sent Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:04 volumio volumio[967]: info: Command Router : Notfying DB Updatefalse Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::Close All Modals sent Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::pushState Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::servicePushState Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: 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} Jul 18 19:51:04 volumio volumio[967]: verbose: CURRENT POSITION 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::syncState stateService stop Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::syncState currentStatus stop Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: No code Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::pushState Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::servicePushState Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: 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} Jul 18 19:51:04 volumio volumio[967]: verbose: CURRENT POSITION 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::syncState stateService stop Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::syncState currentStatus stop Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: No code Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::pushState Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::servicePushState Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: 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} Jul 18 19:51:04 volumio volumio[967]: verbose: CURRENT POSITION 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::syncState stateService stop Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::syncState currentStatus stop Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: No code Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::pushState Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::servicePushState Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: 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} Jul 18 19:51:04 volumio volumio[967]: verbose: CURRENT POSITION 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::syncState stateService stop Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::syncState currentStatus stop Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: No code Jul 18 19:51:04 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:04 volumio volumio[967]: info: ------------------------------ 293ms Jul 18 19:51:04 volumio volumio[967]: info: ------------------------------ 293ms Jul 18 19:51:04 volumio volumio[967]: info: ------------------------------ 215ms Jul 18 19:51:04 volumio volumio[967]: info: ------------------------------ 215ms Jul 18 19:51:04 volumio volumio[967]: info: MPD Database updated - AlbumList cache refreshed Jul 18 19:51:04 volumio volumio[967]: info: Jul 18 19:51:04 volumio volumio[967]: ---------------------------- MPD announces state update: database Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: info: Jul 18 19:51:04 volumio volumio[967]: ---------------------------- MPD announces state update: update Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::getState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: info: ControllerMpd::getState Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Jul 18 19:51:04 volumio volumio[967]: error: Upnp client error: Error: This socket has been ended by the other party Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 7 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 7 milliseconds Jul 18 19:51:04 volumio volumio[967]: info: sendMpdCommand status took 6 milliseconds Jul 18 19:51:04 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:04 volumio volumio[967]: info: Command Router : Notfying DB Updatefalse Jul 18 19:51:04 volumio volumio[967]: info: CoreCommandRouter::Close All Modals sent Jul 18 19:51:05 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:05 volumio volumio[967]: verbose: ControllerMpd::parseState Jul 18 19:51:05 volumio volumio[967]: info: ControllerMpd::pushState Jul 18 19:51:05 volumio volumio[967]: info: CoreCommandRouter::servicePushState Jul 18 19:51:05 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:05 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:05 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 19:51:05 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:05 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:05 volumio volumio[967]: 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} Jul 18 19:51:05 volumio volumio[967]: verbose: CURRENT POSITION 0 Jul 18 19:51:05 volumio volumio[967]: info: CoreStateMachine::syncState stateService stop Jul 18 19:51:05 volumio volumio[967]: info: CoreStateMachine::syncState currentStatus stop Jul 18 19:51:05 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:05 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:05 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:05 volumio volumio[967]: info: No code Jul 18 19:51:05 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:05 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:05 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:05 volumio volumio[967]: info: ControllerMpd::pushState Jul 18 19:51:05 volumio volumio[967]: info: CoreCommandRouter::servicePushState Jul 18 19:51:05 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:05 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:05 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:05 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:05 volumio volumio[967]: 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} Jul 18 19:51:05 volumio volumio[967]: verbose: CURRENT POSITION 0 Jul 18 19:51:05 volumio volumio[967]: info: CoreStateMachine::syncState stateService stop Jul 18 19:51:05 volumio volumio[967]: info: CoreStateMachine::syncState currentStatus stop Jul 18 19:51:05 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:05 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:05 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:05 volumio volumio[967]: info: No code Jul 18 19:51:05 volumio volumio[967]: info: CoreStateMachine::pushState Jul 18 19:51:05 volumio volumio[967]: info: CorePlayQueue::getTrack 0 Jul 18 19:51:05 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Jul 18 19:51:05 volumio volumio[967]: info: ------------------------------ 102ms Jul 18 19:51:05 volumio volumio[967]: info: ------------------------------ 102ms Jul 18 19:51:06 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jul 18 19:51:06 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jul 18 19:51:06 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:51:07 volumio volumio[967]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 18 19:51:07 volumio volumio[967]: Error: getaddrinfo -3007 Jul 18 19:51:07 volumio volumio[967]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Jul 18 19:51:07 volumio volumio[967]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Jul 18 19:51:07 volumio volumio[967]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Jul 18 19:51:07 volumio volumio[967]: code: -3007, Jul 18 19:51:07 volumio volumio[967]: errno: -3007, Jul 18 19:51:07 volumio volumio[967]: syscall: 'getaddrinfo' Jul 18 19:51:07 volumio volumio[967]: } Jul 18 19:51:07 volumio volumio[967]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 18 19:51:07 volumio sudo[1589]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-18 19:50 Jul 18 19:51:07 volumio sudo[1589]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"