-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Mon 2024-09-09 15:39:27 CST. -- Sep 09 15:38:00 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:00 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:00 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:00 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:00 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:01 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:01 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:01 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:01 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:01 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:01 volumio sudo[3020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/USB/music Sep 09 15:38:01 volumio sudo[3020]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:38:01 volumio sudo[3020]: pam_unix(sudo:session): session closed for user root Sep 09 15:38:01 volumio volumio[2669]: info: Command failed: /usr/bin/sudo /bin/umount /mnt/USB/music Sep 09 15:38:01 volumio volumio[2669]: umount: /mnt/USB/music: not mounted. Sep 09 15:38:01 volumio volumio[2669]: {"killed":false,"code":32,"signal":null,"cmd":"/usr/bin/sudo /bin/umount /mnt/USB/music"} Sep 09 15:38:02 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:02 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:02 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:02 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:02 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:03 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:03 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:03 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:03 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:03 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:04 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:04 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:04 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:04 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:04 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:04 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 15:38:04 volumio volumio[2669]: info: CURURI: music-library/USB Sep 09 15:38:04 volumio volumio[2669]: info: Preload queue cleared Sep 09 15:38:05 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:05 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:05 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:05 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:05 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:06 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:06 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:06 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:06 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:06 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:07 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:07 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:07 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:07 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:07 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:07 volumio volumio[2669]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Sep 09 15:38:07 volumio volumio[2669]: info: Retrying Login Due to Network Error Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand update Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:08 volumio volumio[2669]: info: Sep 09 15:38:08 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:08 volumio volumio[2669]: info: sendMpdCommand update took 1 milliseconds Sep 09 15:38:08 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:08 volumio volumio[2669]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:38:08 volumio volumio[2669]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:08 volumio volumio[2669]: info: Command Router : Notfying DB Updatetrue Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:08 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: 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} Sep 09 15:38:08 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: No code Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: ------------------------------ 54ms Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:08 volumio volumio[2669]: info: Sep 09 15:38:08 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:08 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:08 volumio volumio[2669]: info: Sep 09 15:38:08 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:08 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:08 volumio volumio[2669]: info: Sep 09 15:38:08 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:08 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:08 volumio volumio[2669]: info: sendMpdCommand status took 8 milliseconds Sep 09 15:38:08 volumio volumio[2669]: info: sendMpdCommand status took 7 milliseconds Sep 09 15:38:08 volumio volumio[2669]: info: sendMpdCommand status took 7 milliseconds Sep 09 15:38:08 volumio volumio[2669]: info: sendMpdCommand status took 7 milliseconds Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:08 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:08 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:08 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: 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} Sep 09 15:38:08 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: No code Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: 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} Sep 09 15:38:08 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: No code Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: ------------------------------ 92ms Sep 09 15:38:08 volumio volumio[2669]: info: ------------------------------ 92ms Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:08 volumio volumio[2669]: info: Sep 09 15:38:08 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:08 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:08 volumio volumio[2669]: info: Sep 09 15:38:08 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:08 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:08 volumio volumio[2669]: info: sendMpdCommand status took 103 milliseconds Sep 09 15:38:08 volumio volumio[2669]: info: sendMpdCommand status took 97 milliseconds Sep 09 15:38:08 volumio volumio[2669]: info: sendMpdCommand status took 12 milliseconds Sep 09 15:38:08 volumio volumio[2669]: info: sendMpdCommand status took 11 milliseconds Sep 09 15:38:08 volumio volumio[2669]: info: sendMpdCommand status took 11 milliseconds Sep 09 15:38:08 volumio volumio[2669]: info: sendMpdCommand status took 11 milliseconds Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:08 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:08 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:08 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:08 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:08 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: 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} Sep 09 15:38:08 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: No code Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: 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} Sep 09 15:38:08 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: No code Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: 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} Sep 09 15:38:08 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: No code Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:08 volumio volumio[2669]: info: ------------------------------ 205ms Sep 09 15:38:08 volumio volumio[2669]: info: ------------------------------ 115ms Sep 09 15:38:08 volumio volumio[2669]: info: ------------------------------ 114ms Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:08 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:08 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:09 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:09 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:09 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:09 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:09 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:10 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:10 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:10 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:10 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:10 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:11 volumio kernel: rc rc0: two consecutive events of type space Sep 09 15:38:11 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:11 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:11 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:11 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:11 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:12 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:12 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:12 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:12 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:12 volumio kernel: usb 2-1: USB disconnect, device number 2 Sep 09 15:38:13 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:13 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:13 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:13 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:13 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:13 volumio volumio[2669]: info: Partition removed: {"syspath":"/sys/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/000039ea-01 /dev/disk/by-uuid/3C7D-0383 /dev/disk/by-path/platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-label/Lexar /dev/disk/by-id/usb-Lexar_SL500_2024R30356000145-0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"29","ID_BUS":"usb","ID_FS_LABEL":"Lexar","ID_FS_LABEL_ENC":"Lexar","ID_FS_TYPE":"exfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"3C7D-0383","ID_FS_UUID_ENC":"3C7D-0383","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"SL500","ID_MODEL_ENC":"SL500\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"0050","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"4000795312","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"000039ea-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"000039ea","ID_PATH":"platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1000","ID_SERIAL":"Lexar_SL500_2024R30356000145-0:0","ID_SERIAL_SHORT":"2024R30356000145","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Lexar","ID_VENDOR_ENC":"Lexar\\x20\\x20\\x20","ID_VENDOR_ID":"21c4","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"2306","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"211299111"} Sep 09 15:38:13 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Sep 09 15:38:13 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK Sep 09 15:38:14 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:14 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:14 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:14 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:14 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:15 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:15 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:15 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:15 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:15 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:16 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:16 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:16 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:16 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:16 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:17 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:17 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:17 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:17 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:17 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:17 volumio volumio[2669]: info: MyVolumio login type: Token Sep 09 15:38:18 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:18 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:18 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:18 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:18 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:19 volumio kernel: usb 2-1: new SuperSpeed USB device number 3 using xhci-hcd Sep 09 15:38:19 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:19 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:19 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:19 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:19 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:19 volumio kernel: usb 2-1: New USB device found, idVendor=21c4, idProduct=0050, bcdDevice= 1.00 Sep 09 15:38:19 volumio kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Sep 09 15:38:19 volumio kernel: usb 2-1: Product: SL500 Sep 09 15:38:19 volumio kernel: usb 2-1: Manufacturer: Lexar Sep 09 15:38:19 volumio kernel: usb 2-1: SerialNumber: 2024R30356000145 Sep 09 15:38:19 volumio kernel: scsi host1: uas Sep 09 15:38:19 volumio kernel: scsi 1:0:0:0: Direct-Access Lexar SL500 1000 PQ: 0 ANSI: 6 Sep 09 15:38:19 volumio kernel: sd 1:0:0:0: Attached scsi generic sg0 type 0 Sep 09 15:38:19 volumio kernel: sd 1:0:0:0: [sdb] 4000797360 512-byte logical blocks: (2.05 TB/1.86 TiB) Sep 09 15:38:19 volumio kernel: sd 1:0:0:0: [sdb] Write Protect is off Sep 09 15:38:19 volumio kernel: sd 1:0:0:0: [sdb] Mode Sense: 43 00 00 00 Sep 09 15:38:19 volumio kernel: sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Sep 09 15:38:19 volumio kernel: sdb: sdb1 Sep 09 15:38:19 volumio kernel: sd 1:0:0:0: [sdb] Attached SCSI disk Sep 09 15:38:19 volumio volumio[2669]: info: Mounting Device Lexar Sep 09 15:38:19 volumio volumio[2669]: /bin/mkdir: cannot create directory ‘/mnt/USB/Lexar’: File exists Sep 09 15:38:19 volumio volumio[2669]: error: Failed to create folder Error: Command failed: /bin/mkdir -m 777 "/mnt/USB/Lexar" Sep 09 15:38:19 volumio volumio[2669]: /bin/mkdir: cannot create directory ‘/mnt/USB/Lexar’: File exists Sep 09 15:38:19 volumio sudo[3054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/Lexar -o noatime Sep 09 15:38:19 volumio sudo[3054]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:38:19 volumio mount.exfat[3056]: volume was not unmounted cleanly Sep 09 15:38:19 volumio sudo[3054]: pam_unix(sudo:session): session closed for user root Sep 09 15:38:19 volumio volumio[2669]: WARN: volume was not unmounted cleanly. Sep 09 15:38:19 volumio volumio[2669]: fuse: bad mount point `/mnt/USB/Lexar': Transport endpoint is not connected Sep 09 15:38:19 volumio volumio[2669]: error: Failed to mount Lexar: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdb1" "/mnt/USB/Lexar" -o noatime Sep 09 15:38:19 volumio volumio[2669]: WARN: volume was not unmounted cleanly. Sep 09 15:38:19 volumio volumio[2669]: fuse: bad mount point `/mnt/USB/Lexar': Transport endpoint is not connected Sep 09 15:38:20 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:20 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:20 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:20 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:20 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:21 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:21 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:21 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:21 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:21 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:22 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:22 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:22 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:22 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:22 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:23 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 15:38:23 volumio volumio[2669]: info: CURURI: music-library/USB Sep 09 15:38:23 volumio volumio[2669]: info: Preload queue cleared Sep 09 15:38:23 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:23 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:23 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:23 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:23 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:24 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:24 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:24 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:24 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:24 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:25 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:25 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:25 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:25 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:25 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:26 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:26 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:26 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:26 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:26 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:26 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Sep 09 15:38:26 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand update Sep 09 15:38:26 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:26 volumio volumio[2669]: info: Sep 09 15:38:26 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:26 volumio volumio[2669]: info: sendMpdCommand update took 1 milliseconds Sep 09 15:38:26 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:26 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:26 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:26 volumio volumio[2669]: info: Sep 09 15:38:26 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:26 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:26 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:26 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:26 volumio volumio[2669]: info: Sep 09 15:38:26 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:26 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:26 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:26 volumio volumio[2669]: info: sendMpdCommand status took 3 milliseconds Sep 09 15:38:26 volumio volumio[2669]: info: sendMpdCommand status took 2 milliseconds Sep 09 15:38:26 volumio volumio[2669]: info: sendMpdCommand status took 2 milliseconds Sep 09 15:38:26 volumio volumio[2669]: info: sendMpdCommand status took 2 milliseconds Sep 09 15:38:26 volumio volumio[2669]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:38:26 volumio volumio[2669]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:38:26 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:27 volumio volumio[2669]: info: Command Router : Notfying DB Updatetrue Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:27 volumio volumio[2669]: info: Command Router : Notfying DB Updatetrue Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:27 volumio volumio[2669]: info: Command Router : Notfying DB Updatetrue Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:27 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: 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} Sep 09 15:38:27 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: No code Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: 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} Sep 09 15:38:27 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: No code Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: 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} Sep 09 15:38:27 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: No code Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: ------------------------------ 108ms Sep 09 15:38:27 volumio volumio[2669]: info: ------------------------------ 107ms Sep 09 15:38:27 volumio volumio[2669]: info: ------------------------------ 107ms Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:27 volumio volumio[2669]: info: Sep 09 15:38:27 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:27 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:27 volumio volumio[2669]: info: Sep 09 15:38:27 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:27 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:27 volumio volumio[2669]: info: Sep 09 15:38:27 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:27 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:27 volumio volumio[2669]: info: sendMpdCommand status took 11 milliseconds Sep 09 15:38:27 volumio volumio[2669]: info: sendMpdCommand status took 11 milliseconds Sep 09 15:38:27 volumio volumio[2669]: info: sendMpdCommand status took 10 milliseconds Sep 09 15:38:27 volumio volumio[2669]: info: sendMpdCommand status took 10 milliseconds Sep 09 15:38:27 volumio volumio[2669]: info: sendMpdCommand status took 9 milliseconds Sep 09 15:38:27 volumio volumio[2669]: info: sendMpdCommand status took 10 milliseconds Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:27 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:27 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:27 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:27 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:27 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: 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} Sep 09 15:38:27 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: No code Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: 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} Sep 09 15:38:27 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: No code Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: 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} Sep 09 15:38:27 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: No code Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:27 volumio volumio[2669]: info: ------------------------------ 96ms Sep 09 15:38:27 volumio volumio[2669]: info: ------------------------------ 95ms Sep 09 15:38:27 volumio volumio[2669]: info: ------------------------------ 95ms Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:27 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:27 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:28 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 15:38:28 volumio volumio[2669]: info: CURURI: music-library/USB Sep 09 15:38:28 volumio volumio[2669]: info: Preload queue cleared Sep 09 15:38:28 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:28 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:28 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:28 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:28 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:29 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 15:38:29 volumio volumio[2669]: info: CURURI: music-library/USB/music Sep 09 15:38:29 volumio volumio[2669]: error: Failed LSINFO: null Sep 09 15:38:29 volumio volumio[2669]: info: Preload queue cleared Sep 09 15:38:29 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:29 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:29 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:29 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:29 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:30 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:30 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:30 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:30 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:30 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:31 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:31 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:31 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:31 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:31 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:32 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:32 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:32 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:32 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:32 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:33 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:33 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:33 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:33 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:33 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:34 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:34 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:34 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:34 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:34 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:35 volumio kernel: usb 2-1: USB disconnect, device number 3 Sep 09 15:38:35 volumio volumio[2669]: info: Partition removed: {"syspath":"/sys/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/000039ea-01 /dev/disk/by-uuid/3C7D-0383 /dev/disk/by-path/platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-label/Lexar /dev/disk/by-id/usb-Lexar_SL500_2024R30356000145-0:0-part1","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"30","ID_BUS":"usb","ID_FS_LABEL":"Lexar","ID_FS_LABEL_ENC":"Lexar","ID_FS_TYPE":"exfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"3C7D-0383","ID_FS_UUID_ENC":"3C7D-0383","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"SL500","ID_MODEL_ENC":"SL500\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"0050","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"4000795312","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"000039ea-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"000039ea","ID_PATH":"platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1000","ID_SERIAL":"Lexar_SL500_2024R30356000145-0:0","ID_SERIAL_SHORT":"2024R30356000145","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Lexar","ID_VENDOR_ENC":"Lexar\\x20\\x20\\x20","ID_VENDOR_ID":"21c4","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"2340","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"1477111091"} Sep 09 15:38:35 volumio kernel: sd 1:0:0:0: [sdb] Synchronizing SCSI cache Sep 09 15:38:35 volumio kernel: sd 1:0:0:0: [sdb] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK Sep 09 15:38:35 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:35 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:35 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:35 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:35 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:36 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:36 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:36 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:36 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:36 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:37 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:37 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:37 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:37 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:37 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:38 volumio kernel: usb 4-1: new SuperSpeed USB device number 3 using xhci-hcd Sep 09 15:38:38 volumio kernel: usb 4-1: New USB device found, idVendor=21c4, idProduct=0050, bcdDevice= 1.00 Sep 09 15:38:38 volumio kernel: usb 4-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Sep 09 15:38:38 volumio kernel: usb 4-1: Product: SL500 Sep 09 15:38:38 volumio kernel: usb 4-1: Manufacturer: Lexar Sep 09 15:38:38 volumio kernel: usb 4-1: SerialNumber: 2024R30356000145 Sep 09 15:38:38 volumio kernel: scsi host1: uas Sep 09 15:38:38 volumio kernel: scsi 1:0:0:0: Direct-Access Lexar SL500 1000 PQ: 0 ANSI: 6 Sep 09 15:38:38 volumio kernel: sd 1:0:0:0: Attached scsi generic sg0 type 0 Sep 09 15:38:38 volumio kernel: sd 1:0:0:0: [sdb] 4000797360 512-byte logical blocks: (2.05 TB/1.86 TiB) Sep 09 15:38:38 volumio kernel: sd 1:0:0:0: [sdb] Write Protect is off Sep 09 15:38:38 volumio kernel: sd 1:0:0:0: [sdb] Mode Sense: 43 00 00 00 Sep 09 15:38:38 volumio kernel: sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Sep 09 15:38:38 volumio kernel: sdb: sdb1 Sep 09 15:38:38 volumio kernel: sd 1:0:0:0: [sdb] Attached SCSI disk Sep 09 15:38:38 volumio volumio[2669]: info: Mounting Device Lexar Sep 09 15:38:38 volumio volumio[2669]: /bin/mkdir: cannot create directory ‘/mnt/USB/Lexar’: File exists Sep 09 15:38:38 volumio volumio[2669]: error: Failed to create folder Error: Command failed: /bin/mkdir -m 777 "/mnt/USB/Lexar" Sep 09 15:38:38 volumio volumio[2669]: /bin/mkdir: cannot create directory ‘/mnt/USB/Lexar’: File exists Sep 09 15:38:38 volumio sudo[3085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/Lexar -o noatime Sep 09 15:38:38 volumio sudo[3085]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:38:38 volumio mount.exfat[3087]: volume was not unmounted cleanly Sep 09 15:38:38 volumio sudo[3085]: pam_unix(sudo:session): session closed for user root Sep 09 15:38:38 volumio volumio[2669]: WARN: volume was not unmounted cleanly. Sep 09 15:38:38 volumio volumio[2669]: fuse: bad mount point `/mnt/USB/Lexar': Transport endpoint is not connected Sep 09 15:38:38 volumio volumio[2669]: error: Failed to mount Lexar: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdb1" "/mnt/USB/Lexar" -o noatime Sep 09 15:38:38 volumio volumio[2669]: WARN: volume was not unmounted cleanly. Sep 09 15:38:38 volumio volumio[2669]: fuse: bad mount point `/mnt/USB/Lexar': Transport endpoint is not connected Sep 09 15:38:38 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:38 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:38 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:38 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:38 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:39 volumio kernel: usb 4-1: USB disconnect, device number 3 Sep 09 15:38:39 volumio volumio[2669]: info: Partition removed: {"syspath":"/sys/devices/platform/axi/1000120000.pcie/1f00300000.usb/xhci-hcd.1/usb4/4-1/4-1:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/000039ea-01 /dev/disk/by-uuid/3C7D-0383 /dev/disk/by-label/Lexar /dev/disk/by-path/platform-xhci-hcd.1-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-id/usb-Lexar_SL500_2024R30356000145-0:0-part1","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/axi/1000120000.pcie/1f00300000.usb/xhci-hcd.1/usb4/4-1/4-1:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"31","ID_BUS":"usb","ID_FS_LABEL":"Lexar","ID_FS_LABEL_ENC":"Lexar","ID_FS_TYPE":"exfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"3C7D-0383","ID_FS_UUID_ENC":"3C7D-0383","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"SL500","ID_MODEL_ENC":"SL500\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"0050","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"4000795312","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"000039ea-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"000039ea","ID_PATH":"platform-xhci-hcd.1-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_1-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1000","ID_SERIAL":"Lexar_SL500_2024R30356000145-0:0","ID_SERIAL_SHORT":"2024R30356000145","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Lexar","ID_VENDOR_ENC":"Lexar\\x20\\x20\\x20","ID_VENDOR_ID":"21c4","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"2375","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"1496032711"} Sep 09 15:38:39 volumio kernel: sd 1:0:0:0: [sdb] Synchronizing SCSI cache Sep 09 15:38:39 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:39 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:39 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:39 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:39 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:39 volumio kernel: sd 1:0:0:0: [sdb] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK Sep 09 15:38:40 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:40 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:40 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:40 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:40 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:41 volumio kernel: usb 4-1: new SuperSpeed USB device number 4 using xhci-hcd Sep 09 15:38:41 volumio kernel: usb 4-1: New USB device found, idVendor=21c4, idProduct=0050, bcdDevice= 1.00 Sep 09 15:38:41 volumio kernel: usb 4-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Sep 09 15:38:41 volumio kernel: usb 4-1: Product: SL500 Sep 09 15:38:41 volumio kernel: usb 4-1: Manufacturer: Lexar Sep 09 15:38:41 volumio kernel: usb 4-1: SerialNumber: 2024R30356000145 Sep 09 15:38:41 volumio kernel: scsi host1: uas Sep 09 15:38:41 volumio kernel: scsi 1:0:0:0: Direct-Access Lexar SL500 1000 PQ: 0 ANSI: 6 Sep 09 15:38:41 volumio kernel: sd 1:0:0:0: Attached scsi generic sg0 type 0 Sep 09 15:38:41 volumio kernel: sd 1:0:0:0: [sdb] 4000797360 512-byte logical blocks: (2.05 TB/1.86 TiB) Sep 09 15:38:41 volumio kernel: sd 1:0:0:0: [sdb] Write Protect is off Sep 09 15:38:41 volumio kernel: sd 1:0:0:0: [sdb] Mode Sense: 43 00 00 00 Sep 09 15:38:41 volumio kernel: sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Sep 09 15:38:41 volumio kernel: sdb: sdb1 Sep 09 15:38:41 volumio kernel: sd 1:0:0:0: [sdb] Attached SCSI disk Sep 09 15:38:41 volumio volumio[2669]: info: Mounting Device Lexar Sep 09 15:38:41 volumio volumio[2669]: /bin/mkdir: cannot create directory ‘/mnt/USB/Lexar’: File exists Sep 09 15:38:41 volumio volumio[2669]: error: Failed to create folder Error: Command failed: /bin/mkdir -m 777 "/mnt/USB/Lexar" Sep 09 15:38:41 volumio volumio[2669]: /bin/mkdir: cannot create directory ‘/mnt/USB/Lexar’: File exists Sep 09 15:38:41 volumio sudo[3098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/Lexar -o noatime Sep 09 15:38:41 volumio sudo[3098]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:38:41 volumio mount.exfat[3100]: volume was not unmounted cleanly Sep 09 15:38:41 volumio sudo[3098]: pam_unix(sudo:session): session closed for user root Sep 09 15:38:41 volumio volumio[2669]: WARN: volume was not unmounted cleanly. Sep 09 15:38:41 volumio volumio[2669]: fuse: bad mount point `/mnt/USB/Lexar': Transport endpoint is not connected Sep 09 15:38:41 volumio volumio[2669]: error: Failed to mount Lexar: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdb1" "/mnt/USB/Lexar" -o noatime Sep 09 15:38:41 volumio volumio[2669]: WARN: volume was not unmounted cleanly. Sep 09 15:38:41 volumio volumio[2669]: fuse: bad mount point `/mnt/USB/Lexar': Transport endpoint is not connected Sep 09 15:38:41 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:41 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:41 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:41 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:41 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:42 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:42 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:42 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:42 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:42 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:43 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:43 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:43 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:43 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:43 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:44 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:44 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:44 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:44 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:44 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:45 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:45 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:45 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:45 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:45 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:46 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:46 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:46 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:46 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:46 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Sep 09 15:38:47 volumio volumio[2669]: info: Retrying Login Due to Network Error Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand update Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:47 volumio volumio[2669]: info: Sep 09 15:38:47 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:47 volumio volumio[2669]: info: sendMpdCommand update took 1 milliseconds Sep 09 15:38:47 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:47 volumio volumio[2669]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:38:47 volumio volumio[2669]: info: sendMpdCommand status took 0 milliseconds Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:47 volumio volumio[2669]: info: Command Router : Notfying DB Updatetrue Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:47 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: 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} Sep 09 15:38:47 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: No code Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: ------------------------------ 53ms Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:47 volumio volumio[2669]: info: Sep 09 15:38:47 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:47 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:47 volumio volumio[2669]: info: Sep 09 15:38:47 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:47 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:47 volumio volumio[2669]: info: Sep 09 15:38:47 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:47 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:47 volumio volumio[2669]: info: sendMpdCommand status took 2 milliseconds Sep 09 15:38:47 volumio volumio[2669]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:38:47 volumio volumio[2669]: info: sendMpdCommand status took 2 milliseconds Sep 09 15:38:47 volumio volumio[2669]: info: sendMpdCommand status took 2 milliseconds Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:47 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:47 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:47 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: 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} Sep 09 15:38:47 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: No code Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: 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} Sep 09 15:38:47 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: No code Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: ------------------------------ 65ms Sep 09 15:38:47 volumio volumio[2669]: info: ------------------------------ 65ms Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:47 volumio volumio[2669]: info: Sep 09 15:38:47 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:47 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:47 volumio volumio[2669]: info: Sep 09 15:38:47 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:38:47 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: sendMpdCommand status took 78 milliseconds Sep 09 15:38:47 volumio volumio[2669]: info: sendMpdCommand status took 78 milliseconds Sep 09 15:38:47 volumio volumio[2669]: info: sendMpdCommand status took 14 milliseconds Sep 09 15:38:47 volumio volumio[2669]: info: sendMpdCommand status took 13 milliseconds Sep 09 15:38:47 volumio volumio[2669]: info: sendMpdCommand status took 13 milliseconds Sep 09 15:38:47 volumio volumio[2669]: info: sendMpdCommand status took 11 milliseconds Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:47 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:47 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:47 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:38:47 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:38:47 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: 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} Sep 09 15:38:47 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: No code Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: 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} Sep 09 15:38:47 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: No code Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: 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} Sep 09 15:38:47 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: No code Sep 09 15:38:47 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:38:47 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:47 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:38:47 volumio volumio[2669]: info: ------------------------------ 157ms Sep 09 15:38:47 volumio volumio[2669]: info: ------------------------------ 94ms Sep 09 15:38:47 volumio volumio[2669]: info: ------------------------------ 93ms Sep 09 15:38:48 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:48 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:48 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:48 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:48 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:49 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:49 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:49 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:49 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:49 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:50 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:50 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:50 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:50 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:50 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:51 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:51 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:51 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:51 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:51 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:52 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:52 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:52 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:52 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:52 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:53 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:53 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:53 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:53 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:53 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:54 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:54 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:54 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:54 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:54 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:55 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:55 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:55 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:55 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:55 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:56 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:56 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:56 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:56 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:56 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:57 volumio volumio[2669]: info: MyVolumio login type: Token Sep 09 15:38:57 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:57 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:57 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:57 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:57 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:58 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:58 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:58 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:58 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:58 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:38:59 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:38:59 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:38:59 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:38:59 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:38:59 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:00 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:00 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:00 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:00 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:00 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:01 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:01 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:01 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:01 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:01 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:02 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:02 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:02 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:02 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:02 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:03 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:03 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:03 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:03 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:03 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:04 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:04 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:04 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:04 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:04 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:05 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:05 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:05 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:05 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:05 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:06 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:06 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:06 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:06 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:06 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:07 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:07 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:07 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:07 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:07 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:08 volumio sudo[3156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 09 15:39:08 volumio sudo[3156]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:39:08 volumio sudo[3156]: pam_unix(sudo:session): session closed for user root Sep 09 15:39:08 volumio sudo[3158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 09 15:39:08 volumio sudo[3158]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:39:08 volumio sudo[3158]: pam_unix(sudo:session): session closed for user root Sep 09 15:39:08 volumio volumio[2669]: verbose: New Socket.io Connection to 192.168.8.5 from 192.168.8.3 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.5.1 Mobile/15E148 Safari/604.1 Total Clients: 5 Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::volumioGetVisibleSources Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 09 15:39:08 volumio volumio[2669]: info: Received Get System Info Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 09 15:39:08 volumio volumio[2669]: info: Discovery: Getting this device information Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:08 volumio volumio[2669]: info: Listing playlists Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:08 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:08 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:08 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:08 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:08 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:08 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:09 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:09 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:09 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:09 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:09 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:09 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 15:39:09 volumio volumio[2669]: info: CURURI: music-library Sep 09 15:39:09 volumio volumio[2669]: info: Preload queue cleared Sep 09 15:39:10 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 09 15:39:10 volumio volumio[2669]: info: Received Get System Info Sep 09 15:39:10 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 09 15:39:10 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 09 15:39:10 volumio volumio[2669]: info: Discovery: Getting this device information Sep 09 15:39:10 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:10 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:10 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 09 15:39:10 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:10 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:10 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:10 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:10 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:11 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:11 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:11 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:11 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:11 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand update Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:39:12 volumio volumio[2669]: info: Sep 09 15:39:12 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:39:12 volumio volumio[2669]: info: sendMpdCommand update took 1 milliseconds Sep 09 15:39:12 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:39:12 volumio volumio[2669]: info: sendMpdCommand status took 0 milliseconds Sep 09 15:39:12 volumio volumio[2669]: info: sendMpdCommand status took 6 milliseconds Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:39:12 volumio volumio[2669]: info: Command Router : Notfying DB Updatetrue Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:39:12 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: 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} Sep 09 15:39:12 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: No code Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: ------------------------------ 86ms Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:39:12 volumio volumio[2669]: info: Sep 09 15:39:12 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:39:12 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:39:12 volumio volumio[2669]: info: Sep 09 15:39:12 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:39:12 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:39:12 volumio volumio[2669]: info: Sep 09 15:39:12 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:39:12 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:39:12 volumio volumio[2669]: info: sendMpdCommand status took 3 milliseconds Sep 09 15:39:12 volumio volumio[2669]: info: sendMpdCommand status took 2 milliseconds Sep 09 15:39:12 volumio volumio[2669]: info: sendMpdCommand status took 2 milliseconds Sep 09 15:39:12 volumio volumio[2669]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:39:12 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:39:12 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:39:12 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: 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} Sep 09 15:39:12 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: No code Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: 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} Sep 09 15:39:12 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: No code Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: ------------------------------ 82ms Sep 09 15:39:12 volumio volumio[2669]: info: ------------------------------ 81ms Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:39:12 volumio volumio[2669]: info: Sep 09 15:39:12 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:39:12 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:39:12 volumio volumio[2669]: info: Sep 09 15:39:12 volumio volumio[2669]: ---------------------------- MPD announces state update: update Sep 09 15:39:12 volumio volumio[2669]: info: ControllerMpd::getState Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:39:12 volumio volumio[2669]: info: sendMpdCommand status took 93 milliseconds Sep 09 15:39:12 volumio volumio[2669]: info: sendMpdCommand status took 92 milliseconds Sep 09 15:39:12 volumio volumio[2669]: info: sendMpdCommand status took 9 milliseconds Sep 09 15:39:12 volumio volumio[2669]: info: sendMpdCommand status took 8 milliseconds Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:39:12 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:39:12 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:39:12 volumio volumio[2669]: info: Command Router : Notfying DB Updatefalse Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:39:12 volumio volumio[2669]: verbose: ControllerMpd::parseState Sep 09 15:39:12 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: 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} Sep 09 15:39:12 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: No code Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: 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} Sep 09 15:39:12 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: No code Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: ControllerMpd::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::servicePushState Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: 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} Sep 09 15:39:12 volumio volumio[2669]: verbose: CURRENT POSITION 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::syncState stateService stop Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: No code Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::pushState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioPushState Sep 09 15:39:12 volumio volumio[2669]: info: ------------------------------ 178ms Sep 09 15:39:12 volumio volumio[2669]: info: ------------------------------ 94ms Sep 09 15:39:12 volumio volumio[2669]: info: ------------------------------ 94ms Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:12 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:12 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:12 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:13 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 15:39:13 volumio volumio[2669]: info: CURURI: music-library/USB Sep 09 15:39:13 volumio volumio[2669]: info: Preload queue cleared Sep 09 15:39:13 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:13 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:13 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:13 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:13 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:14 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 15:39:14 volumio volumio[2669]: info: CURURI: music-library/USB/music Sep 09 15:39:14 volumio volumio[2669]: error: Failed LSINFO: null Sep 09 15:39:14 volumio volumio[2669]: info: Preload queue cleared Sep 09 15:39:14 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:14 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:14 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:14 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:14 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:15 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:15 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:15 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:15 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:15 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:16 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:16 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:16 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:16 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:16 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:17 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:17 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:17 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:17 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:17 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:18 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:18 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:18 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:18 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:18 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:19 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:19 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:19 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:19 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:19 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:20 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:20 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:20 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:20 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:20 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:21 volumio volumio[2669]: verbose: New Socket.io Connection to 192.168.8.5 from 192.168.8.3 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.5.1 Mobile/15E148 Safari/604.1 Total Clients: 6 Sep 09 15:39:21 volumio volumio[2669]: info: Received Get System Info Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 09 15:39:21 volumio volumio[2669]: info: Discovery: Getting this device information Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:21 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:21 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::volumioGetVisibleSources Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:21 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 09 15:39:21 volumio volumio[2669]: info: Received Get System Info Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 09 15:39:21 volumio volumio[2669]: info: Discovery: Getting this device information Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:21 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:21 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:21 volumio volumio[2669]: info: Listing playlists Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:21 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:21 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:21 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:21 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:21 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:21 volumio volumio[2669]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 09 15:39:22 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:22 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:22 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:22 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:22 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:23 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:23 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:23 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:23 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:23 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:24 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:24 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:24 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:24 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:24 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:25 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:25 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:25 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:25 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:25 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:26 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:26 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:26 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:26 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:26 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:27 volumio volumio[2669]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Sep 09 15:39:27 volumio volumio[2669]: info: Retrying Login Due to Network Error Sep 09 15:39:27 volumio volumio[2669]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:39:27 volumio volumio[2669]: info: CoreStateMachine::getQueue Sep 09 15:39:27 volumio volumio[2669]: info: CorePlayQueue::getQueue Sep 09 15:39:27 volumio volumio[2669]: info: CoreCommandRouter::volumioGetState Sep 09 15:39:27 volumio volumio[2669]: info: CorePlayQueue::getTrack 0 Sep 09 15:39:27 volumio volumio[2669]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 09 15:39:27 volumio volumio[2669]: Error: connect ETIMEDOUT 199.96.61.1:80 Sep 09 15:39:27 volumio volumio[2669]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Sep 09 15:39:27 volumio volumio[2669]: errno: -110, Sep 09 15:39:27 volumio volumio[2669]: code: 'ETIMEDOUT', Sep 09 15:39:27 volumio volumio[2669]: syscall: 'connect', Sep 09 15:39:27 volumio volumio[2669]: address: '199.96.61.1', Sep 09 15:39:27 volumio volumio[2669]: port: 80 Sep 09 15:39:27 volumio volumio[2669]: } Sep 09 15:39:27 volumio volumio[2669]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 09 15:39:27 volumio sudo[3185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-09 15:38 Sep 09 15:39:27 volumio sudo[3185]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"