2022-05-02 15:39:58,607 - sd:47(main) INFO: Starting SecureDrop Launcher 2022-05-02 15:39:58,609 - sd.sdw_updater_gui.Updater:474(should_launch_updater) INFO: Update interval expired: launching updater. 2022-05-02 15:40:01,158 - sd.sdw_updater_gui.UpdaterApp:136(_check_network_and_update) INFO: Network check successful; checking for updates. 2022-05-02 15:40:01,159 - sd.sdw_updater_gui.UpdaterApp:156(apply_all_updates) INFO: Starting UpgradeThread 2022-05-02 15:40:01,160 - sd.sdw_updater_gui.Updater:112(apply_updates) INFO: Applying all updates to VMs: ['dom0'] 2022-05-02 15:40:01,168 - sd.sdw_updater_gui.UpdaterApp:117(update_progress_bar) INFO: Signal: Progress 5% 2022-05-02 15:40:06,537 - sd.sdw_updater_gui.Updater:157(_check_updates_dom0) INFO: No updates available for dom0 2022-05-02 15:40:06,537 - sd.sdw_updater_gui.Updater:377(apply_dom0_state) INFO: Applying dom0 state 2022-05-02 15:40:06,537 - sd.sdw_updater_gui.UpdaterApp:117(update_progress_bar) INFO: Signal: Progress 10% 2022-05-02 15:40:06,537 - sd.sdw_updater_gui.UpdaterApp:117(update_progress_bar) INFO: Signal: Progress 10% 2022-05-02 15:47:17,292 - sd.sdw_updater_gui.Updater:382(apply_dom0_state) INFO: Dom0 state applied 2022-05-02 15:47:17,298 - sd.sdw_updater_gui.UpdaterApp:117(update_progress_bar) INFO: Signal: Progress 15% 2022-05-02 15:47:17,298 - sd.sdw_updater_gui.Updater:112(apply_updates) INFO: Applying all updates to VMs: {'whonix-gw-16', 'sd-large-buster-template', 'sd-small-buster-template', 'fedora-34'} 2022-05-02 15:47:17,299 - sd.sdw_updater_gui.Updater:183(_apply_updates_vm) INFO: Updating whonix-gw-16 2022-05-02 15:48:20,691 - sd.sdw_updater_gui.Updater:196(_apply_updates_vm) ERROR: An error has occurred updating whonix-gw-16. Please contact your administrator. 2022-05-02 15:48:20,691 - sd.sdw_updater_gui.Updater:199(_apply_updates_vm) ERROR: Command '['sudo', 'qubesctl', '--skip-dom0', '--targets', 'whonix-gw-16', 'state.sls', 'update.qubes-vm']' returned non-zero exit status 20. 2022-05-02 15:48:20,691 - sd.sdw_updater_gui.Updater:183(_apply_updates_vm) INFO: Updating sd-large-buster-template 2022-05-02 15:48:20,692 - sd.sdw_updater_gui.UpdaterApp:117(update_progress_bar) INFO: Signal: Progress 30% 2022-05-02 15:52:33,886 - sd.sdw_updater_gui.Updater:201(_apply_updates_vm) INFO: sd-large-buster-template update successful 2022-05-02 15:52:33,887 - sd.sdw_updater_gui.Updater:183(_apply_updates_vm) INFO: Updating sd-small-buster-template 2022-05-02 15:52:33,887 - sd.sdw_updater_gui.UpdaterApp:117(update_progress_bar) INFO: Signal: Progress 45% 2022-05-02 15:56:42,438 - sd.sdw_updater_gui.Updater:201(_apply_updates_vm) INFO: sd-small-buster-template update successful 2022-05-02 15:56:42,438 - sd.sdw_updater_gui.Updater:183(_apply_updates_vm) INFO: Updating fedora-34 2022-05-02 15:56:42,444 - sd.sdw_updater_gui.UpdaterApp:117(update_progress_bar) INFO: Signal: Progress 60% 2022-05-02 15:57:23,421 - sd.sdw_updater_gui.Updater:201(_apply_updates_vm) INFO: fedora-34 update successful 2022-05-02 15:57:23,422 - sd.sdw_updater_gui.Updater:409(shutdown_and_start_vms) INFO: Shutting down SDW TemplateVMs for updates 2022-05-02 15:57:23,422 - sd.sdw_updater_gui.UpdaterApp:117(update_progress_bar) INFO: Signal: Progress 75% 2022-05-02 15:57:23,846 - sd.sdw_updater_gui.Updater:413(shutdown_and_start_vms) INFO: Shutting down SDW AppVMs for updates 2022-05-02 15:57:24,347 - sd.sdw_updater_gui.Updater:421(shutdown_and_start_vms) INFO: Safely shutting down system VM: sys-usb 2022-05-02 15:57:27,935 - sd.sdw_updater_gui.Updater:421(shutdown_and_start_vms) INFO: Safely shutting down system VM: sys-whonix 2022-05-02 15:57:33,161 - sd.sdw_updater_gui.Updater:428(shutdown_and_start_vms) INFO: Killing system VM: sys-firewall 2022-05-02 15:57:34,755 - sd.sdw_updater_gui.Updater:428(shutdown_and_start_vms) INFO: Killing system VM: sys-net 2022-05-02 15:57:37,594 - sd.sdw_updater_gui.Updater:437(shutdown_and_start_vms) INFO: Starting fedora-based system VMs after updates 2022-05-02 15:57:37,689 - sd.sdw_updater_gui.Updater:461(_safely_start_vm) INFO: VMs running before start of sys-net: b'dom0\nsd-dev\n' 2022-05-02 15:57:46,271 - sd.sdw_updater_gui.Updater:461(_safely_start_vm) INFO: VMs running before start of sys-firewall: b'dom0\nsd-dev\nsys-net\n' 2022-05-02 15:57:53,212 - sd.sdw_updater_gui.Updater:461(_safely_start_vm) INFO: VMs running before start of sys-whonix: b'dom0\nsd-dev\nsys-firewall\nsys-net\n' 2022-05-02 15:57:59,883 - sd.sdw_updater_gui.Updater:461(_safely_start_vm) INFO: VMs running before start of sys-usb: b'dom0\nsd-dev\nsys-firewall\nsys-net\nsys-whonix\n' 2022-05-02 15:58:10,179 - sd.sdw_updater_gui.Updater:441(shutdown_and_start_vms) INFO: Starting SDW VMs after updates 2022-05-02 15:58:10,278 - sd.sdw_updater_gui.Updater:461(_safely_start_vm) INFO: VMs running before start of sd-log: b'dom0\nsd-dev\nsys-firewall\nsys-net\nsys-usb\nsys-whonix\n' 2022-05-02 15:58:28,667 - sd.sdw_updater_gui.Updater:461(_safely_start_vm) INFO: VMs running before start of sd-gpg: b'dom0\nsd-dev\nsd-log\nsys-firewall\nsys-net\nsys-usb\nsys-whonix\n' 2022-05-02 15:59:34,967 - sd.sdw_updater_gui.Updater:464(_safely_start_vm) ERROR: Error while starting sd-gpg 2022-05-02 15:59:34,968 - sd.sdw_updater_gui.Updater:465(_safely_start_vm) ERROR: Command '['qvm-start', '--skip-if-running', 'sd-gpg']' returned non-zero exit status 1. 2022-05-02 15:59:34,968 - sd.sdw_updater_gui.Updater:466(_safely_start_vm) ERROR: b'Cannot connect to qrexec agent for 60 seconds, see /var/log/xen/console/guest-sd-gpg.log for details\n' 2022-05-02 15:59:35,036 - sd.sdw_updater_gui.Updater:461(_safely_start_vm) INFO: VMs running before start of sd-whonix: b'dom0\nsd-dev\nsd-log\nsys-firewall\nsys-net\nsys-usb\nsys-whonix\n' 2022-05-02 15:59:41,422 - sd.sdw_updater_gui.Updater:461(_safely_start_vm) INFO: VMs running before start of sd-proxy: b'dom0\nsd-dev\nsd-log\nsd-whonix\nsys-firewall\nsys-net\nsys-usb\nsys-whonix\n' 2022-05-02 15:59:59,703 - sd.sdw_updater_gui.Updater:461(_safely_start_vm) INFO: VMs running before start of sd-app: b'dom0\nsd-dev\nsd-log\nsd-proxy\nsd-whonix\nsys-firewall\nsys-net\nsys-usb\nsys-whonix\n' 2022-05-02 16:00:14,763 - sd.sdw_updater_gui.Updater:247(_write_updates_status_flag_to_disk) INFO: Setting update flag to 3 in sd-app 2022-05-02 16:00:17,694 - sd.sdw_updater_gui.Updater:252(_write_updates_status_flag_to_disk) ERROR: Error writing update status flag to sd-app 2022-05-02 16:00:17,694 - sd.sdw_updater_gui.Updater:253(_write_updates_status_flag_to_disk) ERROR: Command '['qvm-run', 'sd-app', "echo '3' > /home/user/.securedrop_client/sdw-update-status"]' returned non-zero exit status 1. 2022-05-02 16:00:17,695 - sd.sdw_updater_gui.Updater:256(_write_updates_status_flag_to_disk) INFO: Setting update flag to 3 in dom0 2022-05-02 16:00:17,695 - sd.sdw_updater_gui.UpdaterApp:77(upgrade_status) INFO: Signal: upgrade_status {'dom0': , 'apply_dom0': , 'whonix-gw-16': , 'sd-large-buster-template': , 'sd-small-buster-template': , 'fedora-34': , 'recommended_action': } 2022-05-02 16:00:17,698 - sd.sdw_updater_gui.UpdaterApp:98(upgrade_status) INFO: Error upgrading VMs