-- Logs begin at Sat 2024-07-06 15:08:21 CST, end at Sat 2024-07-06 15:40:51 CST. -- Jul 06 15:39:01 volumio volumio[6209]: info: MyVolumio login type: Token Jul 06 15:39:01 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:03 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:05 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:07 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:09 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:10 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Jul 06 15:39:10 volumio volumio[6209]: info: Adding a new share Jul 06 15:39:10 volumio volumio[6209]: info: No correspondence found in configuration for share share on IP 192.168.1.20 Jul 06 15:39:10 volumio sudo[6455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.20/share/shows/音乐 /mnt/NAS/share Jul 06 15:39:10 volumio sudo[6455]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 15:39:10 volumio kernel: CIFS: Attempting to mount //192.168.1.20/share/shows/音乐 Jul 06 15:39:10 volumio sudo[6455]: pam_unix(sudo:session): session closed for user root Jul 06 15:39:10 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Jul 06 15:39:10 volumio volumio[6209]: info: Permission denied for share on IP 192.168.1.20 Jul 06 15:39:11 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:11 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 06 15:39:13 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:15 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:17 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:19 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:21 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:23 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:25 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:27 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:29 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:31 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:31 volumio volumio[6209]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 06 15:39:31 volumio volumio[6209]: info: Retrying Login Due to Network Error Jul 06 15:39:33 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:35 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:39 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:41 volumio volumio[6209]: info: MyVolumio login type: Token Jul 06 15:39:41 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:43 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:45 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:47 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:49 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:51 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:53 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:55 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Jul 06 15:39:57 volumio volumio[6209]: info: Adding a new share Jul 06 15:39:57 volumio volumio[6209]: info: Checking key NasMounts.af1265c8-a11e-4e06-8d88-2fd2e7350a9b Jul 06 15:39:57 volumio volumio[6209]: info: No correspondence found in configuration for share share on IP 192.168.1.20 Jul 06 15:39:57 volumio sudo[6512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=joey,password=123,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.20/share/shows/音乐/ /mnt/NAS/share Jul 06 15:39:57 volumio sudo[6512]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 15:39:57 volumio kernel: CIFS: Attempting to mount //192.168.1.20/share/shows/音乐 Jul 06 15:39:57 volumio sudo[6512]: pam_unix(sudo:session): session closed for user root Jul 06 15:39:57 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:39:57 volumio volumio[6209]: info: Jul 06 15:39:57 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:39:57 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:39:57 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:39:57 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:39:57 volumio volumio[6209]: info: Jul 06 15:39:57 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:39:57 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:39:57 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:39:57 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:39:57 volumio volumio[6209]: info: Jul 06 15:39:57 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:39:57 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:39:57 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:39:57 volumio volumio[6209]: info: sendMpdCommand status took 11 milliseconds Jul 06 15:39:57 volumio volumio[6209]: info: sendMpdCommand status took 7 milliseconds Jul 06 15:39:57 volumio volumio[6209]: info: sendMpdCommand status took 6 milliseconds Jul 06 15:39:57 volumio volumio[6209]: info: sendMpdCommand status took 6 milliseconds Jul 06 15:39:57 volumio volumio[6209]: info: sendMpdCommand status took 5 milliseconds Jul 06 15:39:57 volumio volumio[6209]: info: sendMpdCommand status took 4 milliseconds Jul 06 15:39:57 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:39:57 volumio volumio[6209]: info: Command Router : Notfying DB Updatetrue Jul 06 15:39:57 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:39:57 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:39:57 volumio volumio[6209]: info: Command Router : Notfying DB Updatetrue Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:39:57 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:39:57 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:39:57 volumio volumio[6209]: info: Command Router : Notfying DB Updatetrue Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:39:57 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:39:57 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:39:57 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:39:57 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:39:57 volumio volumio[6209]: 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} Jul 06 15:39:57 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:39:57 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:39:57 volumio volumio[6209]: info: No code Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:39:57 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:39:57 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:39:57 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:39:57 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:39:57 volumio volumio[6209]: 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} Jul 06 15:39:57 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:39:57 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:39:57 volumio volumio[6209]: info: No code Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:39:57 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:39:57 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:39:57 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:39:57 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:39:57 volumio volumio[6209]: 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} Jul 06 15:39:57 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:39:57 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:39:57 volumio volumio[6209]: info: No code Jul 06 15:39:57 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:39:57 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:39:57 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:39:58 volumio volumio[6209]: info: ------------------------------ 254ms Jul 06 15:39:58 volumio volumio[6209]: info: ------------------------------ 250ms Jul 06 15:39:58 volumio volumio[6209]: info: ------------------------------ 249ms Jul 06 15:39:58 volumio volumio[6209]: info: [1720251598078] Database update started Jul 06 15:39:58 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 06 15:39:59 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:01 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:03 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:05 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:07 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:09 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:10 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jul 06 15:40:10 volumio sudo[6542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/share Jul 06 15:40:10 volumio sudo[6542]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 15:40:10 volumio sudo[6542]: pam_unix(sudo:session): session closed for user root Jul 06 15:40:10 volumio volumio[6209]: error: Mount point '/mnt/NAS/share' cannot be removed. Error: exec error Error: Command failed: /usr/bin/sudo /bin/umount '/mnt/NAS/share' Jul 06 15:40:10 volumio volumio[6209]: umount: /mnt/NAS/share: target is busy. Jul 06 15:40:11 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:11 volumio volumio[6209]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 06 15:40:11 volumio volumio[6209]: info: Retrying Login Due to Network Error Jul 06 15:40:11 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 06 15:40:13 volumio volumio[6209]: info: [1720251613429] Database update started Jul 06 15:40:13 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:15 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:17 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:19 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:21 volumio volumio[6209]: info: MyVolumio login type: Token Jul 06 15:40:21 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:22 volumio volumio[6209]: info: CoreCommandRouter::volumioPlay Jul 06 15:40:22 volumio volumio[6209]: info: CoreStateMachine::play index undefined Jul 06 15:40:22 volumio volumio[6209]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 06 15:40:22 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:22 volumio volumio[6209]: info: CoreStateMachine::startPlaybackTimer Jul 06 15:40:22 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:22 volumio volumio[6209]: verbose: ControllerMpd::clearAddPlayTracks NAS/share/音乐/2003-04-左麟右李2003演唱会 3CD[环球][WAV]/谭咏麟&李克勤.-.[左麟右李2003演唱会 CD1](2003)[WAV].wav Jul 06 15:40:22 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand stop Jul 06 15:40:22 volumio volumio[6209]: info: sendMpdCommand stop took 1 milliseconds Jul 06 15:40:22 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand clear Jul 06 15:40:22 volumio volumio[6209]: info: Jul 06 15:40:22 volumio volumio[6209]: ---------------------------- MPD announces system playlist update Jul 06 15:40:22 volumio volumio[6209]: info: Ignoring MPD Status Update Jul 06 15:40:22 volumio volumio[6209]: info: sendMpdCommand clear took 2 milliseconds Jul 06 15:40:22 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand add "NAS/share/音乐/2003-04-左麟右李2003演唱会 3CD[环球][WAV]/谭咏麟&李克勤.-.[左麟右李2003演唱会 CD1](2003)[WAV].wav" Jul 06 15:40:22 volumio volumio[6209]: info: Jul 06 15:40:22 volumio volumio[6209]: ---------------------------- MPD announces system playlist update Jul 06 15:40:22 volumio volumio[6209]: info: Ignoring MPD Status Update Jul 06 15:40:22 volumio volumio[6209]: info: Jul 06 15:40:22 volumio volumio[6209]: ---------------------------- MPD announces system playlist update Jul 06 15:40:22 volumio volumio[6209]: info: Ignoring MPD Status Update Jul 06 15:40:22 volumio volumio[6209]: error: updateQueue error: null Jul 06 15:40:22 volumio volumio[6209]: error: updateQueue error: null Jul 06 15:40:22 volumio volumio[6209]: error: updateQueue error: null Jul 06 15:40:22 volumio volumio[6209]: info: ------------------------------ 6ms Jul 06 15:40:22 volumio volumio[6209]: info: ------------------------------ 5ms Jul 06 15:40:22 volumio volumio[6209]: info: ------------------------------ 5ms Jul 06 15:40:23 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:25 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:27 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:29 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:30 volumio volumio[6209]: info: CoreCommandRouter::volumioGetState Jul 06 15:40:30 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:33 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:35 volumio volumio[6209]: info: CoreCommandRouter::volumioGetState Jul 06 15:40:35 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:36 volumio volumio[6209]: info: MPD Database updated - AlbumList cache refreshed Jul 06 15:40:36 volumio volumio[6209]: info: Jul 06 15:40:36 volumio volumio[6209]: ---------------------------- MPD announces state update: database Jul 06 15:40:36 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:36 volumio volumio[6209]: info: Jul 06 15:40:36 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:40:36 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:36 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:36 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:36 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:36 volumio volumio[6209]: info: MPD Database updated - AlbumList cache refreshed Jul 06 15:40:36 volumio volumio[6209]: info: Jul 06 15:40:36 volumio volumio[6209]: ---------------------------- MPD announces state update: database Jul 06 15:40:36 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:36 volumio volumio[6209]: info: Jul 06 15:40:36 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:40:36 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:36 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:36 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:36 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:36 volumio volumio[6209]: info: MPD Database updated - AlbumList cache refreshed Jul 06 15:40:36 volumio volumio[6209]: info: Jul 06 15:40:36 volumio volumio[6209]: ---------------------------- MPD announces state update: database Jul 06 15:40:36 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:36 volumio volumio[6209]: info: Jul 06 15:40:36 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:40:36 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:36 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:36 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:36 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:36 volumio volumio[6209]: info: sendMpdCommand status took 224 milliseconds Jul 06 15:40:36 volumio volumio[6209]: info: sendMpdCommand status took 222 milliseconds Jul 06 15:40:36 volumio volumio[6209]: info: sendMpdCommand status took 223 milliseconds Jul 06 15:40:36 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:36 volumio volumio[6209]: info: Command Router : Notfying DB Updatetrue Jul 06 15:40:36 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:40:36 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:36 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:36 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:36 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:36 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:36 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 15:40:36 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:36 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:36 volumio volumio[6209]: 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} Jul 06 15:40:36 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:36 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:36 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:36 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:36 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:36 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:36 volumio volumio[6209]: info: No code Jul 06 15:40:36 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:36 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:36 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:36 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:36 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:36 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:36 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:36 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:36 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:36 volumio volumio[6209]: 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} Jul 06 15:40:36 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:36 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:36 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:36 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:36 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:36 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:36 volumio volumio[6209]: info: No code Jul 06 15:40:36 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:36 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:36 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:36 volumio volumio[6209]: info: ------------------------------ 405ms Jul 06 15:40:36 volumio volumio[6209]: info: ------------------------------ 407ms Jul 06 15:40:36 volumio volumio[6209]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 06 15:40:36 volumio volumio[6209]: info: Retrieving Cloud Streaming UI Jul 06 15:40:36 volumio volumio[6209]: info: sendMpdCommand status took 679 milliseconds Jul 06 15:40:36 volumio volumio[6209]: info: sendMpdCommand status took 676 milliseconds Jul 06 15:40:36 volumio volumio[6209]: info: sendMpdCommand status took 675 milliseconds Jul 06 15:40:36 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:37 volumio volumio[6209]: info: Command Router : Notfying DB Updatetrue Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:40:37 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:37 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:37 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: 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} Jul 06 15:40:37 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:37 volumio volumio[6209]: info: No code Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:37 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: 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} Jul 06 15:40:37 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:37 volumio volumio[6209]: info: No code Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:37 volumio volumio[6209]: info: ------------------------------ 788ms Jul 06 15:40:37 volumio volumio[6209]: info: ------------------------------ 788ms Jul 06 15:40:37 volumio volumio[6209]: info: sendMpdCommand status took 907 milliseconds Jul 06 15:40:37 volumio volumio[6209]: info: sendMpdCommand status took 906 milliseconds Jul 06 15:40:37 volumio volumio[6209]: info: sendMpdCommand status took 905 milliseconds Jul 06 15:40:37 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:37 volumio volumio[6209]: info: Command Router : Notfying DB Updatetrue Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:40:37 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:37 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: 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} Jul 06 15:40:37 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:37 volumio volumio[6209]: info: No code Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:37 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: 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} Jul 06 15:40:37 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:37 volumio volumio[6209]: info: No code Jul 06 15:40:37 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:37 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:37 volumio volumio[6209]: info: ------------------------------ 1008ms Jul 06 15:40:37 volumio volumio[6209]: info: ------------------------------ 1007ms Jul 06 15:40:37 volumio volumio[6209]: info: Getting Tidal Cloud Configuration Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 06 15:40:37 volumio volumio[6209]: info: Getting Qobuz Cloud Configuration Jul 06 15:40:37 volumio volumio[6209]: info: Asking plugin for UI Config Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 06 15:40:37 volumio volumio[6209]: info: Getting Spotify Cloud Configuration Jul 06 15:40:37 volumio volumio[6209]: info: Asking plugin for UI Config Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 06 15:40:37 volumio volumio[6209]: info: Saving Spotify Acccount Jul 06 15:40:37 volumio volumio[6209]: info: Got Tidal Cloud Configuration Jul 06 15:40:37 volumio volumio[6209]: info: Got it Jul 06 15:40:37 volumio volumio[6209]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 06 15:40:37 volumio volumio[6209]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioGetBrowseSources Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioGetBrowseSources Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::volumioGetBrowseSources Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 06 15:40:37 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:38 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:38 volumio volumio[6209]: info: Jul 06 15:40:38 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:40:38 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:38 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:38 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:38 volumio volumio[6209]: info: Jul 06 15:40:38 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:40:38 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:38 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:38 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:38 volumio volumio[6209]: info: Jul 06 15:40:38 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:40:38 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:38 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:38 volumio volumio[6209]: info: sendMpdCommand status took 6 milliseconds Jul 06 15:40:38 volumio volumio[6209]: info: sendMpdCommand status took 5 milliseconds Jul 06 15:40:38 volumio volumio[6209]: info: sendMpdCommand status took 4 milliseconds Jul 06 15:40:38 volumio volumio[6209]: info: sendMpdCommand status took 4 milliseconds Jul 06 15:40:38 volumio volumio[6209]: info: sendMpdCommand status took 3 milliseconds Jul 06 15:40:38 volumio volumio[6209]: info: sendMpdCommand status took 3 milliseconds Jul 06 15:40:38 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:38 volumio volumio[6209]: info: Command Router : Notfying DB Updatefalse Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:40:38 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:38 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:38 volumio volumio[6209]: info: Command Router : Notfying DB Updatefalse Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:40:38 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:38 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:38 volumio volumio[6209]: info: Command Router : Notfying DB Updatefalse Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:40:38 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:38 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:38 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:38 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:38 volumio volumio[6209]: 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 06 15:40:38 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:38 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:38 volumio volumio[6209]: info: No code Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:38 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:38 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:38 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:38 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:38 volumio volumio[6209]: 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 06 15:40:38 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:38 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:38 volumio volumio[6209]: info: No code Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:38 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:38 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:38 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:38 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:38 volumio volumio[6209]: 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 06 15:40:38 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:38 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:38 volumio volumio[6209]: info: No code Jul 06 15:40:38 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:38 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:38 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:38 volumio volumio[6209]: info: ------------------------------ 198ms Jul 06 15:40:38 volumio volumio[6209]: info: ------------------------------ 198ms Jul 06 15:40:38 volumio volumio[6209]: info: ------------------------------ 198ms Jul 06 15:40:40 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jul 06 15:40:41 volumio sudo[6621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/share Jul 06 15:40:41 volumio sudo[6621]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 15:40:41 volumio systemd[1]: mnt-NAS-share.mount: Succeeded. Jul 06 15:40:41 volumio sudo[6621]: pam_unix(sudo:session): session closed for user root Jul 06 15:40:41 volumio volumio[6209]: info: Share share successfully unmounted Jul 06 15:40:41 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:41 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:42 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: info: Jul 06 15:40:44 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: info: Jul 06 15:40:44 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: info: Jul 06 15:40:44 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: info: MPD Database updated - AlbumList cache refreshed Jul 06 15:40:44 volumio volumio[6209]: info: Jul 06 15:40:44 volumio volumio[6209]: ---------------------------- MPD announces state update: database Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: info: Jul 06 15:40:44 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: info: MPD Database updated - AlbumList cache refreshed Jul 06 15:40:44 volumio volumio[6209]: info: Jul 06 15:40:44 volumio volumio[6209]: ---------------------------- MPD announces state update: database Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: info: Jul 06 15:40:44 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: info: MPD Database updated - AlbumList cache refreshed Jul 06 15:40:44 volumio volumio[6209]: info: Jul 06 15:40:44 volumio volumio[6209]: ---------------------------- MPD announces state update: database Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: info: Jul 06 15:40:44 volumio volumio[6209]: ---------------------------- MPD announces state update: update Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::getState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::sendMpdCommand status Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 88 milliseconds Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 87 milliseconds Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 87 milliseconds Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 86 milliseconds Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 85 milliseconds Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 84 milliseconds Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 43 milliseconds Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 42 milliseconds Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 42 milliseconds Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 40 milliseconds Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 39 milliseconds Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 40 milliseconds Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: info: Command Router : Notfying DB Updatefalse Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: info: Command Router : Notfying DB Updatefalse Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: info: Command Router : Notfying DB Updatefalse Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: info: Command Router : Notfying DB Updatefalse Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: info: Command Router : Notfying DB Updatefalse Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: 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 06 15:40:44 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: No code Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: 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 06 15:40:44 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: No code Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: 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 06 15:40:44 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: No code Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: 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 06 15:40:44 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: No code Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: 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 06 15:40:44 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: No code Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: 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 06 15:40:44 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: No code Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: 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 06 15:40:44 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: No code Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: ------------------------------ 527ms Jul 06 15:40:44 volumio volumio[6209]: info: ------------------------------ 526ms Jul 06 15:40:44 volumio volumio[6209]: info: ------------------------------ 525ms Jul 06 15:40:44 volumio volumio[6209]: info: ------------------------------ 484ms Jul 06 15:40:44 volumio volumio[6209]: info: ------------------------------ 483ms Jul 06 15:40:44 volumio volumio[6209]: info: ------------------------------ 482ms Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 483 milliseconds Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 450 milliseconds Jul 06 15:40:44 volumio volumio[6209]: info: sendMpdCommand status took 449 milliseconds Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: info: Command Router : Notfying DB Updatefalse Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::Close All Modals sent Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: verbose: ControllerMpd::parseState Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: 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 06 15:40:44 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: No code Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: ControllerMpd::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::servicePushState Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: 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 06 15:40:44 volumio volumio[6209]: verbose: CURRENT POSITION 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState stateService stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::syncState currentStatus stop Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: No code Jul 06 15:40:44 volumio volumio[6209]: info: CoreStateMachine::pushState Jul 06 15:40:44 volumio volumio[6209]: info: CorePlayQueue::getTrack 0 Jul 06 15:40:44 volumio volumio[6209]: info: CoreCommandRouter::volumioPushState Jul 06 15:40:44 volumio volumio[6209]: info: ------------------------------ 577ms Jul 06 15:40:44 volumio volumio[6209]: info: ------------------------------ 577ms Jul 06 15:40:44 volumio volumio[6209]: info: [1720251644705] Database update started Jul 06 15:40:45 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:45 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:49 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:49 volumio volumio[6209]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 15:40:50 volumio volumio[6209]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 06 15:40:50 volumio volumio[6209]: Error: connect ETIMEDOUT 199.59.149.234:443 Jul 06 15:40:50 volumio volumio[6209]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 06 15:40:50 volumio volumio[6209]: errno: -110, Jul 06 15:40:50 volumio volumio[6209]: code: 'ETIMEDOUT', Jul 06 15:40:50 volumio volumio[6209]: syscall: 'connect', Jul 06 15:40:50 volumio volumio[6209]: address: '199.59.149.234', Jul 06 15:40:50 volumio volumio[6209]: port: 443 Jul 06 15:40:50 volumio volumio[6209]: } Jul 06 15:40:50 volumio volumio[6209]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 06 15:40:51 volumio sudo[6652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-06 15:39 Jul 06 15:40:51 volumio sudo[6652]: 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"