blob: e9098dedf0df71a4aaa68c07fd17bbe2842784d2 [file] [log] [blame]
Alex Deymoaea4c1c2015-08-19 20:24:43 -07001//
2// Copyright (C) 2012 The Android Open Source Project
3//
4// Licensed under the Apache License, Version 2.0 (the "License");
5// you may not use this file except in compliance with the License.
6// You may obtain a copy of the License at
7//
8// http://www.apache.org/licenses/LICENSE-2.0
9//
10// Unless required by applicable law or agreed to in writing, software
11// distributed under the License is distributed on an "AS IS" BASIS,
12// WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
13// See the License for the specific language governing permissions and
14// limitations under the License.
15//
Andrew de los Reyes4e9b9f42010-04-26 15:06:43 -070016
Amin Hassaniec7bc112020-10-29 16:47:58 -070017#include "update_engine/cros/update_attempter.h"
Andrew de los Reyes63b96d72010-05-10 13:08:54 -070018
Ben Chan9abb7632014-08-07 00:10:53 -070019#include <stdint.h>
20
Alex Vakulenko59e253e2014-02-24 10:40:21 -080021#include <algorithm>
Andrewe045aef2020-01-08 16:29:22 -080022#include <map>
Alex Deymobc91a272014-05-20 16:45:33 -070023#include <memory>
24#include <string>
Andrewa8d7df32020-03-15 20:10:01 -070025#include <unordered_set>
Alex Vakulenkod2779df2014-06-16 13:19:00 -070026#include <utility>
Alex Deymo44666f92014-07-22 20:29:24 -070027#include <vector>
Darin Petkov9d65b7b2010-07-20 09:13:01 -070028
Gilad Arnoldec7f9162014-07-15 13:24:46 -070029#include <base/bind.h>
Denis Nikitin8f2fa742019-05-29 10:36:52 -070030#include <base/compiler_specific.h>
Ben Chan06c76a42014-09-05 08:21:06 -070031#include <base/files/file_util.h>
David Zeuthen3c55abd2013-10-14 12:48:03 -070032#include <base/logging.h>
Andrew de los Reyes45168102010-11-22 11:13:50 -080033#include <base/rand_util.h>
Andrewe045aef2020-01-08 16:29:22 -080034#include <base/strings/string_number_conversions.h>
Daniel Erat65f1da02014-06-27 22:05:38 -070035#include <base/strings/string_util.h>
Alex Vakulenko75039d72014-03-25 12:36:28 -070036#include <base/strings/stringprintf.h>
May Lippert60aa3ca2018-08-15 16:55:29 -070037#include <base/time/time.h>
Sen Jiang2703ef42017-03-16 13:36:21 -070038#include <brillo/data_encoding.h>
Sen Jiange67bb5b2016-06-20 15:53:56 -070039#include <brillo/errors/error_codes.h>
Alex Vakulenko3f39d5c2015-10-13 09:27:13 -070040#include <brillo/message_loops/message_loop.h>
Patrick Dubroy7fbbe8a2011-08-01 17:28:22 +020041#include <policy/device_policy.h>
Alex Deymobc91a272014-05-20 16:45:33 -070042#include <policy/libpolicy.h>
Alex Deymod6deb1d2015-08-28 15:54:37 -070043#include <update_engine/dbus-constants.h>
Darin Petkov9d65b7b2010-07-20 09:13:01 -070044
Alex Deymo14c0da82016-07-20 16:45:45 -070045#include "update_engine/certificate_checker.h"
Alex Deymo39910dc2015-11-09 17:04:30 -080046#include "update_engine/common/boot_control_interface.h"
Alex Deymo39910dc2015-11-09 17:04:30 -080047#include "update_engine/common/clock_interface.h"
48#include "update_engine/common/constants.h"
Xiaochu Liu8ba486f2018-11-06 11:14:10 -080049#include "update_engine/common/dlcservice_interface.h"
Amin Hassaniec7bc112020-10-29 16:47:58 -070050#include "update_engine/common/download_action.h"
Jae Hoon Kim5e8e30b2020-05-06 14:59:06 -070051#include "update_engine/common/excluder_interface.h"
Alex Deymo39910dc2015-11-09 17:04:30 -080052#include "update_engine/common/hardware_interface.h"
Amin Hassaniec7bc112020-10-29 16:47:58 -070053#include "update_engine/common/metrics_reporter_interface.h"
Alex Deymo39910dc2015-11-09 17:04:30 -080054#include "update_engine/common/platform_constants.h"
Andrewe045aef2020-01-08 16:29:22 -080055#include "update_engine/common/prefs.h"
Alex Deymo39910dc2015-11-09 17:04:30 -080056#include "update_engine/common/prefs_interface.h"
57#include "update_engine/common/subprocess.h"
Amin Hassaniec7bc112020-10-29 16:47:58 -070058#include "update_engine/common/system_state.h"
Alex Deymo39910dc2015-11-09 17:04:30 -080059#include "update_engine/common/utils.h"
Amin Hassaniec7bc112020-10-29 16:47:58 -070060#include "update_engine/cros/omaha_request_action.h"
61#include "update_engine/cros/omaha_request_params.h"
62#include "update_engine/cros/omaha_response_handler_action.h"
63#include "update_engine/cros/omaha_utils.h"
64#include "update_engine/cros/p2p_manager.h"
65#include "update_engine/cros/payload_state_interface.h"
66#include "update_engine/cros/power_manager_interface.h"
Alex Deymo14c0da82016-07-20 16:45:45 -070067#include "update_engine/libcurl_http_fetcher.h"
Alex Deymo39910dc2015-11-09 17:04:30 -080068#include "update_engine/payload_consumer/filesystem_verifier_action.h"
69#include "update_engine/payload_consumer/postinstall_runner_action.h"
Amin Hassani0882a512018-04-05 16:25:44 -070070#include "update_engine/update_boot_flags_action.h"
Gilad Arnoldec7f9162014-07-15 13:24:46 -070071#include "update_engine/update_manager/policy.h"
Marton Hunyadye58bddb2018-04-10 20:27:26 +020072#include "update_engine/update_manager/policy_utils.h"
Gilad Arnoldec7f9162014-07-15 13:24:46 -070073#include "update_engine/update_manager/update_manager.h"
Christopher Wileycc8ce0e2015-10-01 16:48:47 -070074#include "update_engine/update_status_utils.h"
Andrew de los Reyes4e9b9f42010-04-26 15:06:43 -070075
Gilad Arnoldec7f9162014-07-15 13:24:46 -070076using base::Bind;
77using base::Callback;
Andrewe045aef2020-01-08 16:29:22 -080078using base::FilePath;
David Zeuthen3c55abd2013-10-14 12:48:03 -070079using base::Time;
Darin Petkovaf183052010-08-23 12:07:13 -070080using base::TimeDelta;
81using base::TimeTicks;
Alex Vakulenko3f39d5c2015-10-13 09:27:13 -070082using brillo::MessageLoop;
Amin Hassani7cc8bb02019-01-14 16:29:47 -080083using chromeos_update_manager::CalculateStagingCase;
Gilad Arnoldec7f9162014-07-15 13:24:46 -070084using chromeos_update_manager::EvalStatus;
85using chromeos_update_manager::Policy;
Adolfo Victoria497044c2018-07-18 07:51:42 -070086using chromeos_update_manager::StagingCase;
Amin Hassani7cc8bb02019-01-14 16:29:47 -080087using chromeos_update_manager::UpdateCheckParams;
Andrew065d78d2020-04-07 15:43:07 -070088using std::map;
Andrew de los Reyes4e9b9f42010-04-26 15:06:43 -070089using std::string;
90using std::vector;
Aaron Woodbf5a2522017-10-04 10:58:36 -070091using update_engine::UpdateAttemptFlags;
Aaron Wood7f92e2b2017-08-28 14:51:21 -070092using update_engine::UpdateEngineStatus;
Andrew de los Reyes4e9b9f42010-04-26 15:06:43 -070093
94namespace chromeos_update_engine {
95
Darin Petkov36275772010-10-01 11:40:57 -070096const int UpdateAttempter::kMaxDeltaUpdateFailures = 3;
97
Andrew de los Reyes45168102010-11-22 11:13:50 -080098namespace {
99const int kMaxConsecutiveObeyProxyRequests = 20;
Gilad Arnold70e476e2013-07-30 16:01:13 -0700100
Alex Deymo0d298542016-03-30 18:31:49 -0700101// Minimum threshold to broadcast an status update in progress and time.
102const double kBroadcastThresholdProgress = 0.01; // 1%
103const int kBroadcastThresholdSeconds = 10;
104
David Pursell02c18642014-11-06 11:26:11 -0800105// By default autest bypasses scattering. If we want to test scattering,
106// use kScheduledAUTestURLRequest. The URL used is same in both cases, but
107// different params are passed to CheckForUpdate().
108const char kAUTestURLRequest[] = "autest";
109const char kScheduledAUTestURLRequest[] = "autest-scheduled";
Alex Vakulenkod2779df2014-06-16 13:19:00 -0700110} // namespace
Andrew de los Reyes45168102010-11-22 11:13:50 -0800111
Sen Jiangdaeaa432018-10-09 18:18:45 -0700112ErrorCode GetErrorCodeForAction(AbstractAction* action, ErrorCode code) {
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700113 if (code != ErrorCode::kError)
Darin Petkov777dbfa2010-07-20 15:03:37 -0700114 return code;
115
116 const string type = action->Type();
117 if (type == OmahaRequestAction::StaticType())
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700118 return ErrorCode::kOmahaRequestError;
Darin Petkov777dbfa2010-07-20 15:03:37 -0700119 if (type == OmahaResponseHandlerAction::StaticType())
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700120 return ErrorCode::kOmahaResponseHandlerError;
Allie Woodeb9e6d82015-04-17 13:55:30 -0700121 if (type == FilesystemVerifierAction::StaticType())
122 return ErrorCode::kFilesystemVerifierError;
Darin Petkov777dbfa2010-07-20 15:03:37 -0700123 if (type == PostinstallRunnerAction::StaticType())
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700124 return ErrorCode::kPostinstallRunnerError;
Darin Petkov777dbfa2010-07-20 15:03:37 -0700125
126 return code;
127}
128
Sen Jiang18414082018-01-11 14:50:36 -0800129UpdateAttempter::UpdateAttempter(SystemState* system_state,
130 CertificateChecker* cert_checker)
Gilad Arnold1f847232014-04-07 12:07:49 -0700131 : processor_(new ActionProcessor()),
132 system_state_(system_state),
Colin Howes978c1082018-12-03 11:46:12 -0800133 cert_checker_(cert_checker),
134 is_install_(false) {}
Darin Petkovc6c135c2010-08-11 13:36:18 -0700135
Gilad Arnoldec7f9162014-07-15 13:24:46 -0700136UpdateAttempter::~UpdateAttempter() {
Alex Deymo33e91e72015-12-01 18:26:08 -0300137 // CertificateChecker might not be initialized in unittests.
138 if (cert_checker_)
139 cert_checker_->SetObserver(nullptr);
Alex Deymo2b4268c2015-12-04 13:56:25 -0800140 // Release ourselves as the ActionProcessor's delegate to prevent
141 // re-scheduling the updates due to the processing stopped.
142 processor_->set_delegate(nullptr);
Gilad Arnoldec7f9162014-07-15 13:24:46 -0700143}
144
Gilad Arnold1f847232014-04-07 12:07:49 -0700145void UpdateAttempter::Init() {
146 // Pulling from the SystemState can only be done after construction, since
147 // this is an aggregate of various objects (such as the UpdateAttempter),
148 // which requires them all to be constructed prior to it being used.
149 prefs_ = system_state_->prefs();
150 omaha_request_params_ = system_state_->request_params();
Alex Deymo906191f2015-10-12 12:22:44 -0700151
Alex Deymo33e91e72015-12-01 18:26:08 -0300152 if (cert_checker_)
153 cert_checker_->SetObserver(this);
154
Alex Deymo906191f2015-10-12 12:22:44 -0700155 // In case of update_engine restart without a reboot we need to restore the
156 // reboot needed state.
157 if (GetBootTimeAtUpdate(nullptr))
158 status_ = UpdateStatus::UPDATED_NEED_REBOOT;
159 else
160 status_ = UpdateStatus::IDLE;
Gilad Arnold1f847232014-04-07 12:07:49 -0700161}
162
Xiaochu Liu88d90382018-08-29 16:09:11 -0700163bool UpdateAttempter::ScheduleUpdates() {
Jae Hoon Kimba2fdce2019-07-11 13:18:58 -0700164 if (IsBusyOrUpdateScheduled())
Xiaochu Liu88d90382018-08-29 16:09:11 -0700165 return false;
Gilad Arnold54fa66d2014-09-29 13:14:29 -0700166
Gilad Arnoldec7f9162014-07-15 13:24:46 -0700167 chromeos_update_manager::UpdateManager* const update_manager =
168 system_state_->update_manager();
169 CHECK(update_manager);
Amin Hassani7cc8bb02019-01-14 16:29:47 -0800170 Callback<void(EvalStatus, const UpdateCheckParams&)> callback =
171 Bind(&UpdateAttempter::OnUpdateScheduled, base::Unretained(this));
Gilad Arnoldec7f9162014-07-15 13:24:46 -0700172 // We limit the async policy request to a reasonably short time, to avoid a
173 // starvation due to a transient bug.
Jae Hoon Kim504c3cb2019-07-02 11:17:24 -0700174 update_manager->AsyncPolicyRequestUpdateCheckAllowed(
175 callback, &Policy::UpdateCheckAllowed);
Gilad Arnoldec7f9162014-07-15 13:24:46 -0700176 waiting_for_scheduled_check_ = true;
Xiaochu Liu88d90382018-08-29 16:09:11 -0700177 return true;
Darin Petkovc6c135c2010-08-11 13:36:18 -0700178}
179
Alex Deymoc1c17b42015-11-23 03:53:15 -0300180void UpdateAttempter::CertificateChecked(ServerToCheck server_to_check,
181 CertificateCheckResult result) {
Tianjie Xu282aa1f2017-09-05 13:42:45 -0700182 system_state_->metrics_reporter()->ReportCertificateCheckMetrics(
183 server_to_check, result);
Alex Deymoc1c17b42015-11-23 03:53:15 -0300184}
185
David Zeuthen985b1122013-10-09 12:13:15 -0700186bool UpdateAttempter::CheckAndReportDailyMetrics() {
187 int64_t stored_value;
Alex Deymof329b932014-10-30 01:37:48 -0700188 Time now = system_state_->clock()->GetWallclockTime();
David Zeuthen985b1122013-10-09 12:13:15 -0700189 if (system_state_->prefs()->Exists(kPrefsDailyMetricsLastReportedAt) &&
190 system_state_->prefs()->GetInt64(kPrefsDailyMetricsLastReportedAt,
191 &stored_value)) {
Alex Deymof329b932014-10-30 01:37:48 -0700192 Time last_reported_at = Time::FromInternalValue(stored_value);
193 TimeDelta time_reported_since = now - last_reported_at;
David Zeuthen985b1122013-10-09 12:13:15 -0700194 if (time_reported_since.InSeconds() < 0) {
195 LOG(WARNING) << "Last reported daily metrics "
196 << utils::FormatTimeDelta(time_reported_since) << " ago "
197 << "which is negative. Either the system clock is wrong or "
198 << "the kPrefsDailyMetricsLastReportedAt state variable "
199 << "is wrong.";
200 // In this case, report daily metrics to reset.
201 } else {
Amin Hassani7cc8bb02019-01-14 16:29:47 -0800202 if (time_reported_since.InSeconds() < 24 * 60 * 60) {
David Zeuthen985b1122013-10-09 12:13:15 -0700203 LOG(INFO) << "Last reported daily metrics "
204 << utils::FormatTimeDelta(time_reported_since) << " ago.";
205 return false;
206 }
207 LOG(INFO) << "Last reported daily metrics "
208 << utils::FormatTimeDelta(time_reported_since) << " ago, "
209 << "which is more than 24 hours ago.";
210 }
211 }
212
213 LOG(INFO) << "Reporting daily metrics.";
214 system_state_->prefs()->SetInt64(kPrefsDailyMetricsLastReportedAt,
215 now.ToInternalValue());
216
217 ReportOSAge();
218
219 return true;
220}
221
222void UpdateAttempter::ReportOSAge() {
223 struct stat sb;
224
Alex Vakulenko88b591f2014-08-28 16:48:57 -0700225 if (system_state_ == nullptr)
David Zeuthen985b1122013-10-09 12:13:15 -0700226 return;
227
228 if (stat("/etc/lsb-release", &sb) != 0) {
David Zeuthend9aca3b2014-08-21 13:11:21 -0400229 PLOG(ERROR) << "Error getting file status for /etc/lsb-release "
230 << "(Note: this may happen in some unit tests)";
David Zeuthen985b1122013-10-09 12:13:15 -0700231 return;
232 }
233
Sen Jiang1c3db7d2019-01-10 15:48:55 -0800234 Time lsb_release_timestamp = Time::FromTimeSpec(sb.st_ctim);
Alex Deymof329b932014-10-30 01:37:48 -0700235 Time now = system_state_->clock()->GetWallclockTime();
236 TimeDelta age = now - lsb_release_timestamp;
David Zeuthen985b1122013-10-09 12:13:15 -0700237 if (age.InSeconds() < 0) {
238 LOG(ERROR) << "The OS age (" << utils::FormatTimeDelta(age)
David Zeuthend9aca3b2014-08-21 13:11:21 -0400239 << ") is negative. Maybe the clock is wrong? "
240 << "(Note: this may happen in some unit tests.)";
David Zeuthen985b1122013-10-09 12:13:15 -0700241 return;
242 }
243
Tianjie Xu282aa1f2017-09-05 13:42:45 -0700244 system_state_->metrics_reporter()->ReportDailyMetrics(age);
David Zeuthen985b1122013-10-09 12:13:15 -0700245}
246
Amin Hassanie8153632020-10-27 15:11:28 -0700247void UpdateAttempter::Update(const UpdateCheckParams& params) {
Gilad Arnoldec7f9162014-07-15 13:24:46 -0700248 // This is normally called frequently enough so it's appropriate to use as a
249 // hook for reporting daily metrics.
250 // TODO(garnold) This should be hooked to a separate (reliable and consistent)
251 // timeout event.
David Zeuthen985b1122013-10-09 12:13:15 -0700252 CheckAndReportDailyMetrics();
253
Andrew de los Reyesc1d5c932011-04-20 17:15:47 -0700254 fake_update_success_ = false;
Christopher Wileycc8ce0e2015-10-01 16:48:47 -0700255 if (status_ == UpdateStatus::UPDATED_NEED_REBOOT) {
Thieu Le116fda32011-04-19 11:01:54 -0700256 // Although we have applied an update, we still want to ping Omaha
257 // to ensure the number of active statistics is accurate.
David Zeuthen33bae492014-02-25 16:16:18 -0800258 //
259 // Also convey to the UpdateEngine.Check.Result metric that we're
260 // not performing an update check because of this.
Andrew de los Reyes6b78e292010-05-10 15:54:39 -0700261 LOG(INFO) << "Not updating b/c we already updated and we're waiting for "
Thieu Le116fda32011-04-19 11:01:54 -0700262 << "reboot, we'll ping Omaha instead";
Tianjie Xu282aa1f2017-09-05 13:42:45 -0700263 system_state_->metrics_reporter()->ReportUpdateCheckMetrics(
264 system_state_,
265 metrics::CheckResult::kRebootPending,
266 metrics::CheckReaction::kUnset,
267 metrics::DownloadErrorCode::kUnset);
Thieu Le116fda32011-04-19 11:01:54 -0700268 PingOmaha();
Andrew de los Reyes6b78e292010-05-10 15:54:39 -0700269 return;
270 }
Christopher Wileycc8ce0e2015-10-01 16:48:47 -0700271 if (status_ != UpdateStatus::IDLE) {
Andrew de los Reyes6b78e292010-05-10 15:54:39 -0700272 // Update in progress. Do nothing
273 return;
274 }
Jay Srinivasan480ddfa2012-06-01 19:15:26 -0700275
Amin Hassanie8153632020-10-27 15:11:28 -0700276 if (!CalculateUpdateParams(params)) {
Jay Srinivasan480ddfa2012-06-01 19:15:26 -0700277 return;
278 }
279
Amin Hassanie8153632020-10-27 15:11:28 -0700280 BuildUpdateActions(params.interactive);
Jay Srinivasan480ddfa2012-06-01 19:15:26 -0700281
Christopher Wileycc8ce0e2015-10-01 16:48:47 -0700282 SetStatusAndNotify(UpdateStatus::CHECKING_FOR_UPDATE);
Jay Srinivasan480ddfa2012-06-01 19:15:26 -0700283
Gilad Arnoldec7f9162014-07-15 13:24:46 -0700284 // Update the last check time here; it may be re-updated when an Omaha
285 // response is received, but this will prevent us from repeatedly scheduling
286 // checks in the case where a response is not received.
287 UpdateLastCheckedTime();
288
Amin Hassani0882a512018-04-05 16:25:44 -0700289 ScheduleProcessingStart();
Jay Srinivasan480ddfa2012-06-01 19:15:26 -0700290}
291
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700292void UpdateAttempter::RefreshDevicePolicy() {
293 // Lazy initialize the policy provider, or reload the latest policy data.
294 if (!policy_provider_.get())
295 policy_provider_.reset(new policy::PolicyProvider());
296 policy_provider_->Reload();
297
Alex Vakulenko88b591f2014-08-28 16:48:57 -0700298 const policy::DevicePolicy* device_policy = nullptr;
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700299 if (policy_provider_->device_policy_is_loaded())
300 device_policy = &policy_provider_->GetDevicePolicy();
301
302 if (device_policy)
303 LOG(INFO) << "Device policies/settings present";
304 else
305 LOG(INFO) << "No device policies/settings present.";
306
307 system_state_->set_device_policy(device_policy);
David Zeuthen92d9c8b2013-09-11 10:58:11 -0700308 system_state_->p2p_manager()->SetDevicePolicy(device_policy);
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700309}
310
David Zeuthen8f191b22013-08-06 12:27:50 -0700311void UpdateAttempter::CalculateP2PParams(bool interactive) {
312 bool use_p2p_for_downloading = false;
313 bool use_p2p_for_sharing = false;
314
Thiemo Nagel27d9d532017-05-26 16:35:20 +0200315 // Never use p2p for downloading in interactive checks unless the developer
316 // has opted in for it via a marker file.
David Zeuthen8f191b22013-08-06 12:27:50 -0700317 //
Thiemo Nagel27d9d532017-05-26 16:35:20 +0200318 // (Why would a developer want to opt in? If they are working on the
319 // update_engine or p2p codebases so they can actually test their code.)
David Zeuthen8f191b22013-08-06 12:27:50 -0700320
Alex Vakulenko88b591f2014-08-28 16:48:57 -0700321 if (system_state_ != nullptr) {
David Zeuthen8f191b22013-08-06 12:27:50 -0700322 if (!system_state_->p2p_manager()->IsP2PEnabled()) {
323 LOG(INFO) << "p2p is not enabled - disallowing p2p for both"
324 << " downloading and sharing.";
325 } else {
326 // Allow p2p for sharing, even in interactive checks.
327 use_p2p_for_sharing = true;
328 if (!interactive) {
329 LOG(INFO) << "Non-interactive check - allowing p2p for downloading";
330 use_p2p_for_downloading = true;
331 } else {
David Zeuthen052d2902013-09-06 11:41:30 -0700332 LOG(INFO) << "Forcibly disabling use of p2p for downloading "
333 << "since this update attempt is interactive.";
David Zeuthen8f191b22013-08-06 12:27:50 -0700334 }
335 }
336 }
337
Gilad Arnold74b5f552014-10-07 08:17:16 -0700338 PayloadStateInterface* const payload_state = system_state_->payload_state();
339 payload_state->SetUsingP2PForDownloading(use_p2p_for_downloading);
340 payload_state->SetUsingP2PForSharing(use_p2p_for_sharing);
David Zeuthen8f191b22013-08-06 12:27:50 -0700341}
342
Amin Hassanie8153632020-10-27 15:11:28 -0700343bool UpdateAttempter::CalculateUpdateParams(const UpdateCheckParams& params) {
Darin Petkov1023a602010-08-30 13:47:51 -0700344 http_response_code_ = 0;
Gilad Arnold74b5f552014-10-07 08:17:16 -0700345 PayloadStateInterface* const payload_state = system_state_->payload_state();
Patrick Dubroy7fbbe8a2011-08-01 17:28:22 +0200346
Alex Deymo749ecf12014-10-21 20:06:57 -0700347 // Refresh the policy before computing all the update parameters.
348 RefreshDevicePolicy();
349
Marton Hunyadye58bddb2018-04-10 20:27:26 +0200350 // Check whether we need to clear the rollback-happened preference after
351 // policy is available again.
352 UpdateRollbackHappened();
353
Amin Hassanie8153632020-10-27 15:11:28 -0700354 CalculateStagingParams(params.interactive);
Adolfo Victoria497044c2018-07-18 07:51:42 -0700355 // If staging_wait_time_ wasn't set, staging is off, use scattering instead.
356 if (staging_wait_time_.InSeconds() == 0) {
Amin Hassanie8153632020-10-27 15:11:28 -0700357 CalculateScatteringParams(params.interactive);
Adolfo Victoria497044c2018-07-18 07:51:42 -0700358 }
Patrick Dubroy7fbbe8a2011-08-01 17:28:22 +0200359
Amin Hassanie8153632020-10-27 15:11:28 -0700360 CalculateP2PParams(params.interactive);
Gilad Arnold74b5f552014-10-07 08:17:16 -0700361 if (payload_state->GetUsingP2PForDownloading() ||
362 payload_state->GetUsingP2PForSharing()) {
David Zeuthen8f191b22013-08-06 12:27:50 -0700363 // OK, p2p is to be used - start it and perform housekeeping.
364 if (!StartP2PAndPerformHousekeeping()) {
365 // If this fails, disable p2p for this attempt
366 LOG(INFO) << "Forcibly disabling use of p2p since starting p2p or "
367 << "performing housekeeping failed.";
Gilad Arnold74b5f552014-10-07 08:17:16 -0700368 payload_state->SetUsingP2PForDownloading(false);
369 payload_state->SetUsingP2PForSharing(false);
David Zeuthen8f191b22013-08-06 12:27:50 -0700370 }
371 }
372
Amin Hassanie8153632020-10-27 15:11:28 -0700373 if (!omaha_request_params_->Init(
374 forced_app_version_, forced_omaha_url_, params)) {
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700375 LOG(ERROR) << "Unable to initialize Omaha request params.";
Jay Srinivasan480ddfa2012-06-01 19:15:26 -0700376 return false;
Darin Petkova4a8a8c2010-07-15 22:21:12 -0700377 }
Darin Petkov3aefa862010-12-07 14:45:00 -0800378
Andrewe045aef2020-01-08 16:29:22 -0800379 // The function |CalculateDlcParams| makes use of the function |GetAppId| from
380 // |OmahaRequestParams|, so to ensure that the return from |GetAppId|
381 // doesn't change, no changes to the values |download_channel_|,
382 // |image_props_.product_id| and |image_props_.canary_product_id| from
383 // |omaha_request_params_| shall be made below this line.
384 CalculateDlcParams();
385
Amr Aboelkher21ac9962019-05-15 14:50:05 +0200386 // Set Quick Fix Build token if policy is set and the device is enterprise
387 // enrolled.
Askar Aitzhan570ca872019-04-24 11:16:12 +0200388 string token;
389 if (system_state_ && system_state_->device_policy()) {
390 if (!system_state_->device_policy()->GetDeviceQuickFixBuildToken(&token))
391 token.clear();
392 }
393 omaha_request_params_->set_autoupdate_token(token);
394
Gilad Arnoldafd70ed2014-09-30 16:27:06 -0700395 LOG(INFO) << "target_version_prefix = "
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700396 << omaha_request_params_->target_version_prefix()
Marton Hunyadyba51c3f2018-04-25 15:18:10 +0200397 << ", rollback_allowed = "
398 << omaha_request_params_->rollback_allowed()
Jay Srinivasan480ddfa2012-06-01 19:15:26 -0700399 << ", scatter_factor_in_seconds = "
400 << utils::FormatSecs(scatter_factor_.InSeconds());
401
402 LOG(INFO) << "Wall Clock Based Wait Enabled = "
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700403 << omaha_request_params_->wall_clock_based_wait_enabled()
Jay Srinivasan480ddfa2012-06-01 19:15:26 -0700404 << ", Update Check Count Wait Enabled = "
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700405 << omaha_request_params_->update_check_count_wait_enabled()
Amin Hassani7cc8bb02019-01-14 16:29:47 -0800406 << ", Waiting Period = "
407 << utils::FormatSecs(
408 omaha_request_params_->waiting_period().InSeconds());
Jay Srinivasan0a708742012-03-20 11:26:12 -0700409
David Zeuthen8f191b22013-08-06 12:27:50 -0700410 LOG(INFO) << "Use p2p For Downloading = "
Gilad Arnold74b5f552014-10-07 08:17:16 -0700411 << payload_state->GetUsingP2PForDownloading()
David Zeuthen8f191b22013-08-06 12:27:50 -0700412 << ", Use p2p For Sharing = "
Gilad Arnold74b5f552014-10-07 08:17:16 -0700413 << payload_state->GetUsingP2PForSharing();
David Zeuthen8f191b22013-08-06 12:27:50 -0700414
Andrew de los Reyes45168102010-11-22 11:13:50 -0800415 obeying_proxies_ = true;
Amin Hassanie8153632020-10-27 15:11:28 -0700416 if (proxy_manual_checks_ == 0) {
Andrew de los Reyes45168102010-11-22 11:13:50 -0800417 LOG(INFO) << "forced to obey proxies";
418 // If forced to obey proxies, every 20th request will not use proxies
419 proxy_manual_checks_++;
420 LOG(INFO) << "proxy manual checks: " << proxy_manual_checks_;
421 if (proxy_manual_checks_ >= kMaxConsecutiveObeyProxyRequests) {
422 proxy_manual_checks_ = 0;
423 obeying_proxies_ = false;
424 }
425 } else if (base::RandInt(0, 4) == 0) {
426 obeying_proxies_ = false;
427 }
Amin Hassani7cc8bb02019-01-14 16:29:47 -0800428 LOG_IF(INFO, !obeying_proxies_)
429 << "To help ensure updates work, this update check we are ignoring the "
430 << "proxy settings and using direct connections.";
Andrew de los Reyes45168102010-11-22 11:13:50 -0800431
Darin Petkov36275772010-10-01 11:40:57 -0700432 DisableDeltaUpdateIfNeeded();
Jay Srinivasan480ddfa2012-06-01 19:15:26 -0700433 return true;
434}
435
Gilad Arnoldb92f0df2013-01-10 16:32:45 -0800436void UpdateAttempter::CalculateScatteringParams(bool interactive) {
Jay Srinivasan21be0752012-07-25 15:44:56 -0700437 // Take a copy of the old scatter value before we update it, as
438 // we need to update the waiting period if this value changes.
439 TimeDelta old_scatter_factor = scatter_factor_;
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800440 const policy::DevicePolicy* device_policy = system_state_->device_policy();
Jay Srinivasan21be0752012-07-25 15:44:56 -0700441 if (device_policy) {
Ben Chan9abb7632014-08-07 00:10:53 -0700442 int64_t new_scatter_factor_in_secs = 0;
Jay Srinivasan21be0752012-07-25 15:44:56 -0700443 device_policy->GetScatterFactorInSeconds(&new_scatter_factor_in_secs);
Alex Vakulenkod2779df2014-06-16 13:19:00 -0700444 if (new_scatter_factor_in_secs < 0) // sanitize input, just in case.
Amin Hassani7cc8bb02019-01-14 16:29:47 -0800445 new_scatter_factor_in_secs = 0;
Jay Srinivasan21be0752012-07-25 15:44:56 -0700446 scatter_factor_ = TimeDelta::FromSeconds(new_scatter_factor_in_secs);
447 }
448
449 bool is_scatter_enabled = false;
450 if (scatter_factor_.InSeconds() == 0) {
451 LOG(INFO) << "Scattering disabled since scatter factor is set to 0";
Gilad Arnoldb92f0df2013-01-10 16:32:45 -0800452 } else if (interactive) {
453 LOG(INFO) << "Scattering disabled as this is an interactive update check";
Alex Deymo46a9aae2016-05-04 20:20:11 -0700454 } else if (system_state_->hardware()->IsOOBEEnabled() &&
455 !system_state_->hardware()->IsOOBEComplete(nullptr)) {
456 LOG(INFO) << "Scattering disabled since OOBE is enabled but not complete "
457 "yet";
Jay Srinivasan21be0752012-07-25 15:44:56 -0700458 } else {
459 is_scatter_enabled = true;
460 LOG(INFO) << "Scattering is enabled";
461 }
462
463 if (is_scatter_enabled) {
464 // This means the scattering policy is turned on.
465 // Now check if we need to update the waiting period. The two cases
466 // in which we'd need to update the waiting period are:
467 // 1. First time in process or a scheduled check after a user-initiated one.
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700468 // (omaha_request_params_->waiting_period will be zero in this case).
Jay Srinivasan21be0752012-07-25 15:44:56 -0700469 // 2. Admin has changed the scattering policy value.
470 // (new scattering value will be different from old one in this case).
Ben Chan9abb7632014-08-07 00:10:53 -0700471 int64_t wait_period_in_secs = 0;
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700472 if (omaha_request_params_->waiting_period().InSeconds() == 0) {
Jay Srinivasan21be0752012-07-25 15:44:56 -0700473 // First case. Check if we have a suitable value to set for
474 // the waiting period.
Adolfo Victoriad3a1e352018-07-16 11:40:47 -0700475 if (prefs_->GetInt64(kPrefsWallClockScatteringWaitPeriod,
476 &wait_period_in_secs) &&
Jay Srinivasan21be0752012-07-25 15:44:56 -0700477 wait_period_in_secs > 0 &&
478 wait_period_in_secs <= scatter_factor_.InSeconds()) {
479 // This means:
480 // 1. There's a persisted value for the waiting period available.
481 // 2. And that persisted value is still valid.
482 // So, in this case, we should reuse the persisted value instead of
483 // generating a new random value to improve the chances of a good
484 // distribution for scattering.
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700485 omaha_request_params_->set_waiting_period(
Amin Hassani7cc8bb02019-01-14 16:29:47 -0800486 TimeDelta::FromSeconds(wait_period_in_secs));
487 LOG(INFO) << "Using persisted wall-clock waiting period: "
488 << utils::FormatSecs(
489 omaha_request_params_->waiting_period().InSeconds());
Alex Vakulenkod2779df2014-06-16 13:19:00 -0700490 } else {
Jay Srinivasan21be0752012-07-25 15:44:56 -0700491 // This means there's no persisted value for the waiting period
492 // available or its value is invalid given the new scatter_factor value.
493 // So, we should go ahead and regenerate a new value for the
494 // waiting period.
495 LOG(INFO) << "Persisted value not present or not valid ("
496 << utils::FormatSecs(wait_period_in_secs)
497 << ") for wall-clock waiting period.";
498 GenerateNewWaitingPeriod();
499 }
500 } else if (scatter_factor_ != old_scatter_factor) {
501 // This means there's already a waiting period value, but we detected
502 // a change in the scattering policy value. So, we should regenerate the
503 // waiting period to make sure it's within the bounds of the new scatter
504 // factor value.
505 GenerateNewWaitingPeriod();
506 } else {
507 // Neither the first time scattering is enabled nor the scattering value
508 // changed. Nothing to do.
Amin Hassani7cc8bb02019-01-14 16:29:47 -0800509 LOG(INFO) << "Keeping current wall-clock waiting period: "
510 << utils::FormatSecs(
511 omaha_request_params_->waiting_period().InSeconds());
Jay Srinivasan21be0752012-07-25 15:44:56 -0700512 }
513
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700514 // The invariant at this point is that omaha_request_params_->waiting_period
Jay Srinivasan21be0752012-07-25 15:44:56 -0700515 // is non-zero no matter which path we took above.
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700516 LOG_IF(ERROR, omaha_request_params_->waiting_period().InSeconds() == 0)
Jay Srinivasan21be0752012-07-25 15:44:56 -0700517 << "Waiting Period should NOT be zero at this point!!!";
518
519 // Since scattering is enabled, wall clock based wait will always be
520 // enabled.
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700521 omaha_request_params_->set_wall_clock_based_wait_enabled(true);
Jay Srinivasan21be0752012-07-25 15:44:56 -0700522
523 // If we don't have any issues in accessing the file system to update
524 // the update check count value, we'll turn that on as well.
525 bool decrement_succeeded = DecrementUpdateCheckCount();
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700526 omaha_request_params_->set_update_check_count_wait_enabled(
Amin Hassani7cc8bb02019-01-14 16:29:47 -0800527 decrement_succeeded);
Jay Srinivasan21be0752012-07-25 15:44:56 -0700528 } else {
529 // This means the scattering feature is turned off or disabled for
530 // this particular update check. Make sure to disable
531 // all the knobs and artifacts so that we don't invoke any scattering
532 // related code.
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700533 omaha_request_params_->set_wall_clock_based_wait_enabled(false);
534 omaha_request_params_->set_update_check_count_wait_enabled(false);
535 omaha_request_params_->set_waiting_period(TimeDelta::FromSeconds(0));
Adolfo Victoriad3a1e352018-07-16 11:40:47 -0700536 prefs_->Delete(kPrefsWallClockScatteringWaitPeriod);
Jay Srinivasan21be0752012-07-25 15:44:56 -0700537 prefs_->Delete(kPrefsUpdateCheckCount);
538 // Don't delete the UpdateFirstSeenAt file as we don't want manual checks
539 // that result in no-updates (e.g. due to server side throttling) to
540 // cause update starvation by having the client generate a new
541 // UpdateFirstSeenAt for each scheduled check that follows a manual check.
542 }
543}
544
545void UpdateAttempter::GenerateNewWaitingPeriod() {
Amin Hassani7cc8bb02019-01-14 16:29:47 -0800546 omaha_request_params_->set_waiting_period(
547 TimeDelta::FromSeconds(base::RandInt(1, scatter_factor_.InSeconds())));
Jay Srinivasan21be0752012-07-25 15:44:56 -0700548
Amin Hassani7cc8bb02019-01-14 16:29:47 -0800549 LOG(INFO) << "Generated new wall-clock waiting period: "
550 << utils::FormatSecs(
551 omaha_request_params_->waiting_period().InSeconds());
Jay Srinivasan21be0752012-07-25 15:44:56 -0700552
553 // Do a best-effort to persist this in all cases. Even if the persistence
554 // fails, we'll still be able to scatter based on our in-memory value.
555 // The persistence only helps in ensuring a good overall distribution
556 // across multiple devices if they tend to reboot too often.
Gilad Arnold519cfc72014-10-02 10:34:54 -0700557 system_state_->payload_state()->SetScatteringWaitPeriod(
558 omaha_request_params_->waiting_period());
Jay Srinivasan21be0752012-07-25 15:44:56 -0700559}
560
Adolfo Victoria497044c2018-07-18 07:51:42 -0700561void UpdateAttempter::CalculateStagingParams(bool interactive) {
562 bool oobe_complete = system_state_->hardware()->IsOOBEEnabled() &&
563 system_state_->hardware()->IsOOBEComplete(nullptr);
564 auto device_policy = system_state_->device_policy();
565 StagingCase staging_case = StagingCase::kOff;
566 if (device_policy && !interactive && oobe_complete) {
567 staging_wait_time_ = omaha_request_params_->waiting_period();
568 staging_case = CalculateStagingCase(
569 device_policy, prefs_, &staging_wait_time_, &staging_schedule_);
570 }
571 switch (staging_case) {
572 case StagingCase::kOff:
573 // Staging is off, get rid of persisted value.
574 prefs_->Delete(kPrefsWallClockStagingWaitPeriod);
575 // Set |staging_wait_time_| to its default value so scattering can still
576 // be turned on
577 staging_wait_time_ = TimeDelta();
578 break;
579 // Let the cases fall through since they just add, and never remove, steps
580 // to turning staging on.
581 case StagingCase::kNoSavedValue:
582 prefs_->SetInt64(kPrefsWallClockStagingWaitPeriod,
583 staging_wait_time_.InDays());
Denis Nikitin8f2fa742019-05-29 10:36:52 -0700584 FALLTHROUGH;
Adolfo Victoria497044c2018-07-18 07:51:42 -0700585 case StagingCase::kSetStagingFromPref:
586 omaha_request_params_->set_waiting_period(staging_wait_time_);
Denis Nikitin8f2fa742019-05-29 10:36:52 -0700587 FALLTHROUGH;
Adolfo Victoria497044c2018-07-18 07:51:42 -0700588 case StagingCase::kNoAction:
589 // Staging is on, enable wallclock based wait so that its values get used.
590 omaha_request_params_->set_wall_clock_based_wait_enabled(true);
591 // Use UpdateCheckCount if possible to prevent devices updating all at
592 // once.
593 omaha_request_params_->set_update_check_count_wait_enabled(
594 DecrementUpdateCheckCount());
595 // Scattering should not be turned on if staging is on, delete the
596 // existing scattering configuration.
597 prefs_->Delete(kPrefsWallClockScatteringWaitPeriod);
598 scatter_factor_ = TimeDelta();
599 }
Chris Sosad317e402013-06-12 13:47:09 -0700600}
601
Andrew065d78d2020-04-07 15:43:07 -0700602bool UpdateAttempter::ResetDlcPrefs(const string& dlc_id) {
603 vector<string> failures;
604 PrefsInterface* prefs = system_state_->prefs();
605 for (auto& sub_key :
606 {kPrefsPingActive, kPrefsPingLastActive, kPrefsPingLastRollcall}) {
Jae Hoon Kimc1f36922020-05-11 18:20:18 -0700607 auto key = prefs->CreateSubKey({kDlcPrefsSubDir, dlc_id, sub_key});
Andrew065d78d2020-04-07 15:43:07 -0700608 if (!prefs->Delete(key))
609 failures.emplace_back(sub_key);
610 }
611 if (failures.size() != 0)
612 PLOG(ERROR) << "Failed to delete prefs (" << base::JoinString(failures, ",")
613 << " for DLC (" << dlc_id << ").";
614
615 return failures.size() == 0;
616}
617
Andrewa8d7df32020-03-15 20:10:01 -0700618bool UpdateAttempter::SetDlcActiveValue(bool is_active, const string& dlc_id) {
619 if (dlc_id.empty()) {
620 LOG(ERROR) << "Empty DLC ID passed.";
621 return false;
622 }
623 LOG(INFO) << "Set DLC (" << dlc_id << ") to "
624 << (is_active ? "Active" : "Inactive");
Andrew065d78d2020-04-07 15:43:07 -0700625 PrefsInterface* prefs = system_state_->prefs();
Andrewa8d7df32020-03-15 20:10:01 -0700626 if (is_active) {
Andrew065d78d2020-04-07 15:43:07 -0700627 auto ping_active_key =
Jae Hoon Kimc1f36922020-05-11 18:20:18 -0700628 prefs->CreateSubKey({kDlcPrefsSubDir, dlc_id, kPrefsPingActive});
Andrew065d78d2020-04-07 15:43:07 -0700629 if (!prefs->SetInt64(ping_active_key, kPingActiveValue)) {
Andrewa8d7df32020-03-15 20:10:01 -0700630 LOG(ERROR) << "Failed to set the value of ping metadata '"
631 << kPrefsPingActive << "'.";
632 return false;
633 }
634 } else {
Andrew065d78d2020-04-07 15:43:07 -0700635 return ResetDlcPrefs(dlc_id);
Andrewa8d7df32020-03-15 20:10:01 -0700636 }
637 return true;
638}
639
Andrew065d78d2020-04-07 15:43:07 -0700640int64_t UpdateAttempter::GetPingMetadata(const string& metadata_key) const {
Andrewe045aef2020-01-08 16:29:22 -0800641 // The first time a ping is sent, the metadata files containing the values
642 // sent back by the server still don't exist. A value of -1 is used to
643 // indicate this.
Andrew065d78d2020-04-07 15:43:07 -0700644 if (!system_state_->prefs()->Exists(metadata_key))
Andrewe045aef2020-01-08 16:29:22 -0800645 return kPingNeverPinged;
646
647 int64_t value;
Andrew065d78d2020-04-07 15:43:07 -0700648 if (system_state_->prefs()->GetInt64(metadata_key, &value))
Andrewe045aef2020-01-08 16:29:22 -0800649 return value;
650
651 // Return -2 when the file exists and there is a problem reading from it, or
652 // the value cannot be converted to an integer.
653 return kPingUnknownValue;
654}
655
656void UpdateAttempter::CalculateDlcParams() {
Amin Hassani2b68e6b2020-04-17 10:49:12 -0700657 // Set the |dlc_ids_| only for an update. This is required to get the
Andrewe045aef2020-01-08 16:29:22 -0800658 // currently installed DLC(s).
659 if (!is_install_ &&
Amin Hassani2b68e6b2020-04-17 10:49:12 -0700660 !system_state_->dlcservice()->GetDlcsToUpdate(&dlc_ids_)) {
Andrewe045aef2020-01-08 16:29:22 -0800661 LOG(INFO) << "Failed to retrieve DLC module IDs from dlcservice. Check the "
662 "state of dlcservice, will not update DLC modules.";
663 }
Andrew065d78d2020-04-07 15:43:07 -0700664 PrefsInterface* prefs = system_state_->prefs();
665 map<string, OmahaRequestParams::AppParams> dlc_apps_params;
Amin Hassani2b68e6b2020-04-17 10:49:12 -0700666 for (const auto& dlc_id : dlc_ids_) {
Andrewe045aef2020-01-08 16:29:22 -0800667 OmahaRequestParams::AppParams dlc_params{
668 .active_counting_type = OmahaRequestParams::kDateBased,
669 .name = dlc_id,
670 .send_ping = false};
Andrew065d78d2020-04-07 15:43:07 -0700671 if (is_install_) {
672 // In some cases, |SetDlcActiveValue| might fail to reset the DLC prefs
673 // when a DLC is uninstalled. To avoid having stale values from that
674 // scenario, we reset the metadata values on a new install request.
675 // Ignore failure to delete stale prefs.
676 ResetDlcPrefs(dlc_id);
677 SetDlcActiveValue(true, dlc_id);
678 } else {
679 // Only send the ping when the request is to update DLCs. When installing
680 // DLCs, we don't want to send the ping yet, since the DLCs might fail to
681 // install or might not really be active yet.
682 dlc_params.ping_active = kPingActiveValue;
683 auto ping_active_key =
Jae Hoon Kimc1f36922020-05-11 18:20:18 -0700684 prefs->CreateSubKey({kDlcPrefsSubDir, dlc_id, kPrefsPingActive});
Andrew065d78d2020-04-07 15:43:07 -0700685 if (!prefs->GetInt64(ping_active_key, &dlc_params.ping_active) ||
686 dlc_params.ping_active != kPingActiveValue) {
687 dlc_params.ping_active = kPingInactiveValue;
Andrewe045aef2020-01-08 16:29:22 -0800688 }
Andrew065d78d2020-04-07 15:43:07 -0700689 auto ping_last_active_key =
Jae Hoon Kimc1f36922020-05-11 18:20:18 -0700690 prefs->CreateSubKey({kDlcPrefsSubDir, dlc_id, kPrefsPingLastActive});
Andrew065d78d2020-04-07 15:43:07 -0700691 dlc_params.ping_date_last_active = GetPingMetadata(ping_last_active_key);
692
Jae Hoon Kimc1f36922020-05-11 18:20:18 -0700693 auto ping_last_rollcall_key = prefs->CreateSubKey(
694 {kDlcPrefsSubDir, dlc_id, kPrefsPingLastRollcall});
Andrew065d78d2020-04-07 15:43:07 -0700695 dlc_params.ping_date_last_rollcall =
696 GetPingMetadata(ping_last_rollcall_key);
697
698 dlc_params.send_ping = true;
Andrewe045aef2020-01-08 16:29:22 -0800699 }
700 dlc_apps_params[omaha_request_params_->GetDlcAppId(dlc_id)] = dlc_params;
701 }
702 omaha_request_params_->set_dlc_apps_params(dlc_apps_params);
Amin Hassanie8153632020-10-27 15:11:28 -0700703 omaha_request_params_->set_is_install(is_install_);
Andrewe045aef2020-01-08 16:29:22 -0800704}
705
Jay Srinivasan480ddfa2012-06-01 19:15:26 -0700706void UpdateAttempter::BuildUpdateActions(bool interactive) {
Darin Petkovf42cc1c2010-09-01 09:03:02 -0700707 CHECK(!processor_->IsRunning());
708 processor_->set_delegate(this);
Andrew de los Reyes4e9b9f42010-04-26 15:06:43 -0700709
Jae Hoon Kimedb65502019-06-14 11:52:17 -0700710 // The session ID needs to be kept throughout the update flow. The value
711 // of the session ID will reset/update only when it is a new update flow.
712 session_id_ = base::GenerateGUID();
713
Andrew de los Reyes4e9b9f42010-04-26 15:06:43 -0700714 // Actions:
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700715 auto update_check_fetcher = std::make_unique<LibcurlHttpFetcher>(
716 GetProxyResolver(), system_state_->hardware());
Alex Deymo33e91e72015-12-01 18:26:08 -0300717 update_check_fetcher->set_server_to_check(ServerToCheck::kUpdate);
Andrew de los Reyesfb2f4612011-06-09 18:21:49 -0700718 // Try harder to connect to the network, esp when not interactive.
719 // See comment in libcurl_http_fetcher.cc.
720 update_check_fetcher->set_no_network_max_retries(interactive ? 1 : 3);
Xiaochu Liu4a1173a2019-04-10 10:49:08 -0700721 update_check_fetcher->set_is_update_check(true);
Jae Hoon Kimedb65502019-06-14 11:52:17 -0700722 auto update_check_action =
723 std::make_unique<OmahaRequestAction>(system_state_,
724 nullptr,
725 std::move(update_check_fetcher),
726 false,
727 session_id_);
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700728 auto response_handler_action =
729 std::make_unique<OmahaResponseHandlerAction>(system_state_);
Amin Hassani0882a512018-04-05 16:25:44 -0700730 auto update_boot_flags_action =
731 std::make_unique<UpdateBootFlagsAction>(system_state_->boot_control());
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700732 auto download_started_action = std::make_unique<OmahaRequestAction>(
Sen Jiang18414082018-01-11 14:50:36 -0800733 system_state_,
734 new OmahaEvent(OmahaEvent::kTypeUpdateDownloadStarted),
735 std::make_unique<LibcurlHttpFetcher>(GetProxyResolver(),
736 system_state_->hardware()),
Jae Hoon Kimedb65502019-06-14 11:52:17 -0700737 false,
738 session_id_);
Alex Deymo33e91e72015-12-01 18:26:08 -0300739
Bruno Rocha7f9aea22011-09-12 14:31:24 -0700740 LibcurlHttpFetcher* download_fetcher =
Alex Deymo33e91e72015-12-01 18:26:08 -0300741 new LibcurlHttpFetcher(GetProxyResolver(), system_state_->hardware());
742 download_fetcher->set_server_to_check(ServerToCheck::kDownload);
Sen Jiangee174a12017-12-21 17:38:08 -0800743 if (interactive)
744 download_fetcher->set_max_retry_count(kDownloadMaxRetryCountInteractive);
Jae Hoon Kim0ae8fe12019-06-26 14:32:50 -0700745 download_fetcher->SetHeader(kXGoogleUpdateSessionId, session_id_);
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700746 auto download_action =
747 std::make_unique<DownloadAction>(prefs_,
748 system_state_->boot_control(),
749 system_state_->hardware(),
750 system_state_,
751 download_fetcher, // passes ownership
752 interactive);
Andrew de los Reyes63b96d72010-05-10 13:08:54 -0700753 download_action->set_delegate(this);
Andrew de los Reyes4e9b9f42010-04-26 15:06:43 -0700754
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700755 auto download_finished_action = std::make_unique<OmahaRequestAction>(
756 system_state_,
757 new OmahaEvent(OmahaEvent::kTypeUpdateDownloadFinished),
758 std::make_unique<LibcurlHttpFetcher>(GetProxyResolver(),
759 system_state_->hardware()),
Jae Hoon Kimedb65502019-06-14 11:52:17 -0700760 false,
761 session_id_);
Tianjie24f96092020-06-30 12:26:25 -0700762 auto filesystem_verifier_action = std::make_unique<FilesystemVerifierAction>(
763 system_state_->boot_control()->GetDynamicPartitionControl());
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700764 auto update_complete_action = std::make_unique<OmahaRequestAction>(
765 system_state_,
766 new OmahaEvent(OmahaEvent::kTypeUpdateComplete),
767 std::make_unique<LibcurlHttpFetcher>(GetProxyResolver(),
768 system_state_->hardware()),
Jae Hoon Kimedb65502019-06-14 11:52:17 -0700769 false,
770 session_id_);
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700771
772 auto postinstall_runner_action = std::make_unique<PostinstallRunnerAction>(
773 system_state_->boot_control(), system_state_->hardware());
774 postinstall_runner_action->set_delegate(this);
Andrew de los Reyes4e9b9f42010-04-26 15:06:43 -0700775
776 // Bond them together. We have to use the leaf-types when calling
777 // BondActions().
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700778 BondActions(update_check_action.get(), response_handler_action.get());
779 BondActions(response_handler_action.get(), download_action.get());
780 BondActions(download_action.get(), filesystem_verifier_action.get());
781 BondActions(filesystem_verifier_action.get(),
782 postinstall_runner_action.get());
Chris Sosad317e402013-06-12 13:47:09 -0700783
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700784 processor_->EnqueueAction(std::move(update_check_action));
785 processor_->EnqueueAction(std::move(response_handler_action));
Amin Hassani0882a512018-04-05 16:25:44 -0700786 processor_->EnqueueAction(std::move(update_boot_flags_action));
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700787 processor_->EnqueueAction(std::move(download_started_action));
788 processor_->EnqueueAction(std::move(download_action));
789 processor_->EnqueueAction(std::move(download_finished_action));
790 processor_->EnqueueAction(std::move(filesystem_verifier_action));
791 processor_->EnqueueAction(std::move(postinstall_runner_action));
792 processor_->EnqueueAction(std::move(update_complete_action));
Chris Sosad317e402013-06-12 13:47:09 -0700793}
794
Chris Sosa44b9b7e2014-04-02 13:53:46 -0700795bool UpdateAttempter::Rollback(bool powerwash) {
Colin Howes978c1082018-12-03 11:46:12 -0800796 is_install_ = false;
Chris Sosa44b9b7e2014-04-02 13:53:46 -0700797 if (!CanRollback()) {
798 return false;
799 }
Chris Sosad317e402013-06-12 13:47:09 -0700800
Chris Sosa44b9b7e2014-04-02 13:53:46 -0700801 // Extra check for enterprise-enrolled devices since they don't support
802 // powerwash.
803 if (powerwash) {
804 // Enterprise-enrolled devices have an empty owner in their device policy.
805 string owner;
806 RefreshDevicePolicy();
807 const policy::DevicePolicy* device_policy = system_state_->device_policy();
808 if (device_policy && (!device_policy->GetOwner(&owner) || owner.empty())) {
809 LOG(ERROR) << "Enterprise device detected. "
810 << "Cannot perform a powerwash for enterprise devices.";
811 return false;
812 }
813 }
814
815 processor_->set_delegate(this);
Chris Sosaaa18e162013-06-20 13:20:30 -0700816
Chris Sosa28e479c2013-07-12 11:39:53 -0700817 // Initialize the default request params.
Amin Hassanie8153632020-10-27 15:11:28 -0700818 if (!omaha_request_params_->Init("", "", {.interactive = true})) {
Chris Sosa28e479c2013-07-12 11:39:53 -0700819 LOG(ERROR) << "Unable to initialize Omaha request params.";
820 return false;
821 }
822
Chris Sosad317e402013-06-12 13:47:09 -0700823 LOG(INFO) << "Setting rollback options.";
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700824 install_plan_.reset(new InstallPlan());
825 install_plan_->target_slot = GetRollbackSlot();
826 install_plan_->source_slot = system_state_->boot_control()->GetCurrentSlot();
Chris Sosa76a29ae2013-07-11 17:59:24 -0700827
Alex Deymo706a5ab2015-11-23 17:48:30 -0300828 TEST_AND_RETURN_FALSE(
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700829 install_plan_->LoadPartitionsFromSlots(system_state_->boot_control()));
830 install_plan_->powerwash_required = powerwash;
Chris Sosad317e402013-06-12 13:47:09 -0700831
832 LOG(INFO) << "Using this install plan:";
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700833 install_plan_->Dump();
Chris Sosad317e402013-06-12 13:47:09 -0700834
Amin Hassanid3f4bea2018-04-30 14:52:40 -0700835 auto install_plan_action =
836 std::make_unique<InstallPlanAction>(*install_plan_);
837 auto postinstall_runner_action = std::make_unique<PostinstallRunnerAction>(
838 system_state_->boot_control(), system_state_->hardware());
839 postinstall_runner_action->set_delegate(this);
840 BondActions(install_plan_action.get(), postinstall_runner_action.get());
841 processor_->EnqueueAction(std::move(install_plan_action));
842 processor_->EnqueueAction(std::move(postinstall_runner_action));
Chris Sosaaa18e162013-06-20 13:20:30 -0700843
844 // Update the payload state for Rollback.
845 system_state_->payload_state()->Rollback();
846
Christopher Wileycc8ce0e2015-10-01 16:48:47 -0700847 SetStatusAndNotify(UpdateStatus::ATTEMPTING_ROLLBACK);
Chris Sosad317e402013-06-12 13:47:09 -0700848
Amin Hassani0882a512018-04-05 16:25:44 -0700849 ScheduleProcessingStart();
Chris Sosaaa18e162013-06-20 13:20:30 -0700850 return true;
Andrew de los Reyes4e9b9f42010-04-26 15:06:43 -0700851}
852
Alex Vakulenko59e253e2014-02-24 10:40:21 -0800853bool UpdateAttempter::CanRollback() const {
Chris Sosa44b9b7e2014-04-02 13:53:46 -0700854 // We can only rollback if the update_engine isn't busy and we have a valid
855 // rollback partition.
Christopher Wileycc8ce0e2015-10-01 16:48:47 -0700856 return (status_ == UpdateStatus::IDLE &&
Alex Deymo763e7db2015-08-27 21:08:08 -0700857 GetRollbackSlot() != BootControlInterface::kInvalidSlot);
Alex Vakulenko2bddadd2014-03-27 13:23:46 -0700858}
859
Alex Deymo763e7db2015-08-27 21:08:08 -0700860BootControlInterface::Slot UpdateAttempter::GetRollbackSlot() const {
861 LOG(INFO) << "UpdateAttempter::GetRollbackSlot";
862 const unsigned int num_slots = system_state_->boot_control()->GetNumSlots();
863 const BootControlInterface::Slot current_slot =
864 system_state_->boot_control()->GetCurrentSlot();
Alex Vakulenko59e253e2014-02-24 10:40:21 -0800865
Alex Deymo763e7db2015-08-27 21:08:08 -0700866 LOG(INFO) << " Installed slots: " << num_slots;
867 LOG(INFO) << " Booted from slot: "
868 << BootControlInterface::SlotName(current_slot);
Alex Vakulenko59e253e2014-02-24 10:40:21 -0800869
Alex Deymo763e7db2015-08-27 21:08:08 -0700870 if (current_slot == BootControlInterface::kInvalidSlot || num_slots < 2) {
871 LOG(INFO) << "Device is not updateable.";
872 return BootControlInterface::kInvalidSlot;
Alex Vakulenko59e253e2014-02-24 10:40:21 -0800873 }
874
Alex Deymo763e7db2015-08-27 21:08:08 -0700875 vector<BootControlInterface::Slot> bootable_slots;
Alex Deymof7ead812015-10-23 17:37:27 -0700876 for (BootControlInterface::Slot slot = 0; slot < num_slots; slot++) {
Alex Deymo763e7db2015-08-27 21:08:08 -0700877 if (slot != current_slot &&
878 system_state_->boot_control()->IsSlotBootable(slot)) {
879 LOG(INFO) << "Found bootable slot "
880 << BootControlInterface::SlotName(slot);
881 return slot;
Alex Vakulenko59e253e2014-02-24 10:40:21 -0800882 }
883 }
Alex Deymo763e7db2015-08-27 21:08:08 -0700884 LOG(INFO) << "No other bootable slot found.";
885 return BootControlInterface::kInvalidSlot;
Alex Vakulenko2bddadd2014-03-27 13:23:46 -0700886}
887
Aaron Wood081c0232017-10-19 17:14:58 -0700888bool UpdateAttempter::CheckForUpdate(const string& app_version,
Jay Srinivasane73acab2012-07-10 14:34:03 -0700889 const string& omaha_url,
Aaron Wood081c0232017-10-19 17:14:58 -0700890 UpdateAttemptFlags flags) {
Jae Hoon Kimc437ea52019-07-11 11:20:38 -0700891 if (status_ != UpdateStatus::IDLE) {
892 LOG(INFO) << "Refusing to do an update as there is an "
893 << (is_install_ ? "install" : "update")
894 << " already in progress.";
Aaron Wood081c0232017-10-19 17:14:58 -0700895 return false;
896 }
897
Jae Hoon Kimc437ea52019-07-11 11:20:38 -0700898 bool interactive = !(flags & UpdateAttemptFlags::kFlagNonInteractive);
Jae Hoon Kimc437ea52019-07-11 11:20:38 -0700899 is_install_ = false;
900
Gilad Arnoldec7f9162014-07-15 13:24:46 -0700901 LOG(INFO) << "Forced update check requested.";
David Pursell02c18642014-11-06 11:26:11 -0800902 forced_app_version_.clear();
903 forced_omaha_url_.clear();
904
905 // Certain conditions must be met to allow setting custom version and update
906 // server URLs. However, kScheduledAUTestURLRequest and kAUTestURLRequest are
907 // always allowed regardless of device state.
908 if (IsAnyUpdateSourceAllowed()) {
909 forced_app_version_ = app_version;
910 forced_omaha_url_ = omaha_url;
911 }
912 if (omaha_url == kScheduledAUTestURLRequest) {
Alex Deymoac41a822015-09-15 20:52:53 -0700913 forced_omaha_url_ = constants::kOmahaDefaultAUTestURL;
David Pursell02c18642014-11-06 11:26:11 -0800914 // Pretend that it's not user-initiated even though it is,
915 // so as to test scattering logic, etc. which get kicked off
916 // only in scheduled update checks.
917 interactive = false;
918 } else if (omaha_url == kAUTestURLRequest) {
Alex Deymoac41a822015-09-15 20:52:53 -0700919 forced_omaha_url_ = constants::kOmahaDefaultAUTestURL;
David Pursell02c18642014-11-06 11:26:11 -0800920 }
921
Aaron Wood081c0232017-10-19 17:14:58 -0700922 if (interactive) {
923 // Use the passed-in update attempt flags for this update attempt instead
924 // of the previously set ones.
925 current_update_attempt_flags_ = flags;
926 // Note: The caching for non-interactive update checks happens in
Jae Hoon Kim75daa382019-07-02 11:17:24 -0700927 // |OnUpdateScheduled()|.
Aaron Wood081c0232017-10-19 17:14:58 -0700928 }
929
Jae Hoon Kim2b73ac22019-07-02 11:17:24 -0700930 // |forced_update_pending_callback_| should always be set, but even in the
931 // case that it is not, we still return true indicating success because the
932 // scheduled periodic check will pick up these changes.
Gilad Arnold54fa66d2014-09-29 13:14:29 -0700933 if (forced_update_pending_callback_.get()) {
Jae Hoon Kim2b73ac22019-07-02 11:17:24 -0700934 // Always call |ScheduleUpdates()| before forcing an update. This is because
935 // we need an update to be scheduled for the
936 // |forced_update_pending_callback_| to have an effect. Here we don't need
937 // to care about the return value from |ScheduleUpdate()|.
Gilad Arnold54fa66d2014-09-29 13:14:29 -0700938 ScheduleUpdates();
Gilad Arnoldec7f9162014-07-15 13:24:46 -0700939 forced_update_pending_callback_->Run(true, interactive);
Gilad Arnold54fa66d2014-09-29 13:14:29 -0700940 }
Aaron Wood081c0232017-10-19 17:14:58 -0700941 return true;
Andrew de los Reyes63b96d72010-05-10 13:08:54 -0700942}
943
Amin Hassani2b68e6b2020-04-17 10:49:12 -0700944bool UpdateAttempter::CheckForInstall(const vector<string>& dlc_ids,
Xiaochu Liu88d90382018-08-29 16:09:11 -0700945 const string& omaha_url) {
Jae Hoon Kimc437ea52019-07-11 11:20:38 -0700946 if (status_ != UpdateStatus::IDLE) {
947 LOG(INFO) << "Refusing to do an install as there is an "
948 << (is_install_ ? "install" : "update")
949 << " already in progress.";
950 return false;
951 }
952
Amin Hassani2b68e6b2020-04-17 10:49:12 -0700953 dlc_ids_ = dlc_ids;
Xiaochu Liu88d90382018-08-29 16:09:11 -0700954 is_install_ = true;
955 forced_omaha_url_.clear();
956
957 // Certain conditions must be met to allow setting custom version and update
958 // server URLs. However, kScheduledAUTestURLRequest and kAUTestURLRequest are
959 // always allowed regardless of device state.
960 if (IsAnyUpdateSourceAllowed()) {
961 forced_omaha_url_ = omaha_url;
962 }
Jae Hoon Kimc43f6bb2019-07-03 12:56:52 -0700963
964 if (omaha_url == kScheduledAUTestURLRequest ||
965 omaha_url == kAUTestURLRequest) {
Xiaochu Liu88d90382018-08-29 16:09:11 -0700966 forced_omaha_url_ = constants::kOmahaDefaultAUTestURL;
967 }
968
Jae Hoon Kim2b73ac22019-07-02 11:17:24 -0700969 // |forced_update_pending_callback_| should always be set, but even in the
970 // case that it is not, we still return true indicating success because the
971 // scheduled periodic check will pick up these changes.
972 if (forced_update_pending_callback_.get()) {
973 // Always call |ScheduleUpdates()| before forcing an update. This is because
974 // we need an update to be scheduled for the
975 // |forced_update_pending_callback_| to have an effect. Here we don't need
976 // to care about the return value from |ScheduleUpdate()|.
977 ScheduleUpdates();
978 forced_update_pending_callback_->Run(true, true);
Xiaochu Liu88d90382018-08-29 16:09:11 -0700979 }
980 return true;
981}
982
Darin Petkov296889c2010-07-23 16:20:54 -0700983bool UpdateAttempter::RebootIfNeeded() {
Sen Jiangb8c6a8f2016-06-07 17:33:17 -0700984 if (system_state_->power_manager()->RequestReboot())
Daniel Erat65f1da02014-06-27 22:05:38 -0700985 return true;
986
987 return RebootDirectly();
Darin Petkov296889c2010-07-23 16:20:54 -0700988}
989
David Zeuthen3c55abd2013-10-14 12:48:03 -0700990void UpdateAttempter::WriteUpdateCompletedMarker() {
Alex Deymo906191f2015-10-12 12:22:44 -0700991 string boot_id;
992 if (!utils::GetBootId(&boot_id))
David Zeuthen3c55abd2013-10-14 12:48:03 -0700993 return;
Alex Deymo906191f2015-10-12 12:22:44 -0700994 prefs_->SetString(kPrefsUpdateCompletedOnBootId, boot_id);
David Zeuthen3c55abd2013-10-14 12:48:03 -0700995
996 int64_t value = system_state_->clock()->GetBootTime().ToInternalValue();
Alex Deymo906191f2015-10-12 12:22:44 -0700997 prefs_->SetInt64(kPrefsUpdateCompletedBootTime, value);
David Zeuthen3c55abd2013-10-14 12:48:03 -0700998}
999
Daniel Erat65f1da02014-06-27 22:05:38 -07001000bool UpdateAttempter::RebootDirectly() {
Amin Hassani3a4caa12019-11-06 11:12:28 -08001001 vector<string> command = {"/sbin/shutdown", "-r", "now"};
Daniel Erat65f1da02014-06-27 22:05:38 -07001002 int rc = 0;
Amin Hassani3a4caa12019-11-06 11:12:28 -08001003 Subprocess::SynchronousExec(command, &rc, nullptr, nullptr);
Daniel Erat65f1da02014-06-27 22:05:38 -07001004 return rc == 0;
1005}
1006
Gilad Arnoldec7f9162014-07-15 13:24:46 -07001007void UpdateAttempter::OnUpdateScheduled(EvalStatus status,
1008 const UpdateCheckParams& params) {
1009 waiting_for_scheduled_check_ = false;
1010
1011 if (status == EvalStatus::kSucceeded) {
1012 if (!params.updates_enabled) {
1013 LOG(WARNING) << "Updates permanently disabled.";
Gilad Arnold54fa66d2014-09-29 13:14:29 -07001014 // Signal disabled status, then switch right back to idle. This is
1015 // necessary for ensuring that observers waiting for a signal change will
1016 // actually notice one on subsequent calls. Note that we don't need to
1017 // re-schedule a check in this case as updates are permanently disabled;
1018 // further (forced) checks may still initiate a scheduling call.
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001019 SetStatusAndNotify(UpdateStatus::DISABLED);
1020 SetStatusAndNotify(UpdateStatus::IDLE);
Gilad Arnoldec7f9162014-07-15 13:24:46 -07001021 return;
1022 }
1023
Amin Hassanied37d682018-04-06 13:22:00 -07001024 LOG(INFO) << "Running " << (params.interactive ? "interactive" : "periodic")
Gilad Arnoldec7f9162014-07-15 13:24:46 -07001025 << " update.";
1026
Amin Hassanied37d682018-04-06 13:22:00 -07001027 if (!params.interactive) {
Aaron Wood081c0232017-10-19 17:14:58 -07001028 // Cache the update attempt flags that will be used by this update attempt
1029 // so that they can't be changed mid-way through.
1030 current_update_attempt_flags_ = update_attempt_flags_;
1031 }
1032
Aaron Woodbf5a2522017-10-04 10:58:36 -07001033 LOG(INFO) << "Update attempt flags in use = 0x" << std::hex
1034 << current_update_attempt_flags_;
1035
Amin Hassanie8153632020-10-27 15:11:28 -07001036 Update(params);
Alex Deymo71479082016-03-25 17:54:28 -07001037 // Always clear the forced app_version and omaha_url after an update attempt
1038 // so the next update uses the defaults.
1039 forced_app_version_.clear();
1040 forced_omaha_url_.clear();
Gilad Arnoldec7f9162014-07-15 13:24:46 -07001041 } else {
1042 LOG(WARNING)
1043 << "Update check scheduling failed (possibly timed out); retrying.";
1044 ScheduleUpdates();
1045 }
1046
1047 // This check ensures that future update checks will be or are already
1048 // scheduled. The check should never fail. A check failure means that there's
1049 // a bug that will most likely prevent further automatic update checks. It
1050 // seems better to crash in such cases and restart the update_engine daemon
1051 // into, hopefully, a known good state.
Jae Hoon Kimba2fdce2019-07-11 13:18:58 -07001052 CHECK(IsBusyOrUpdateScheduled());
Gilad Arnoldec7f9162014-07-15 13:24:46 -07001053}
1054
1055void UpdateAttempter::UpdateLastCheckedTime() {
1056 last_checked_time_ = system_state_->clock()->GetWallclockTime().ToTimeT();
1057}
1058
Marton Hunyadye58bddb2018-04-10 20:27:26 +02001059void UpdateAttempter::UpdateRollbackHappened() {
1060 DCHECK(system_state_);
1061 DCHECK(system_state_->payload_state());
1062 DCHECK(policy_provider_);
1063 if (system_state_->payload_state()->GetRollbackHappened() &&
1064 (policy_provider_->device_policy_is_loaded() ||
1065 policy_provider_->IsConsumerDevice())) {
1066 // Rollback happened, but we already went through OOBE and policy is
1067 // present or it's a consumer device.
1068 system_state_->payload_state()->SetRollbackHappened(false);
1069 }
1070}
1071
Jae Hoon Kimed3fcc02019-07-11 14:35:38 -07001072void UpdateAttempter::ProcessingDoneInternal(const ActionProcessor* processor,
1073 ErrorCode code) {
Chris Sosa4f8ee272012-11-30 13:01:54 -08001074 // Reset cpu shares back to normal.
Alex Deymoab0d9762016-02-02 10:52:56 -08001075 cpu_limiter_.StopLimiter();
Darin Petkovc6c135c2010-08-11 13:36:18 -07001076
Amin Hassaniecb60d32019-06-17 18:09:10 -07001077 ResetInteractivityFlags();
Adolfo Victoria20262ad2018-08-06 10:40:11 -07001078
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001079 if (status_ == UpdateStatus::REPORTING_ERROR_EVENT) {
Darin Petkov09f96c32010-07-20 09:24:57 -07001080 LOG(INFO) << "Error event sent.";
Gilad Arnold1ebd8132012-03-05 10:19:29 -08001081
Amin Hassaniecb60d32019-06-17 18:09:10 -07001082 // Inform scheduler of new status.
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001083 SetStatusAndNotify(UpdateStatus::IDLE);
Gilad Arnold54fa66d2014-09-29 13:14:29 -07001084 ScheduleUpdates();
Gilad Arnold1ebd8132012-03-05 10:19:29 -08001085
Andrew de los Reyesc1d5c932011-04-20 17:15:47 -07001086 if (!fake_update_success_) {
1087 return;
1088 }
1089 LOG(INFO) << "Booted from FW B and tried to install new firmware, "
Amin Hassani7cc8bb02019-01-14 16:29:47 -08001090 "so requesting reboot from user.";
Darin Petkov09f96c32010-07-20 09:24:57 -07001091 }
1092
Sen Jiang89e24c12018-03-22 18:05:44 -07001093 attempt_error_code_ = utils::GetBaseErrorCode(code);
1094
Jae Hoon Kimed3fcc02019-07-11 14:35:38 -07001095 if (code != ErrorCode::kSuccess) {
1096 if (ScheduleErrorEventAction()) {
Colin Howesac170d92018-11-20 16:29:28 -08001097 return;
1098 }
Jae Hoon Kimed3fcc02019-07-11 14:35:38 -07001099 LOG(INFO) << "No update.";
1100 SetStatusAndNotify(UpdateStatus::IDLE);
Gilad Arnold54fa66d2014-09-29 13:14:29 -07001101 ScheduleUpdates();
Darin Petkov09f96c32010-07-20 09:24:57 -07001102 return;
Andrew de los Reyes4e9b9f42010-04-26 15:06:43 -07001103 }
Darin Petkov09f96c32010-07-20 09:24:57 -07001104
Jae Hoon Kimed3fcc02019-07-11 14:35:38 -07001105 ReportTimeToUpdateAppliedMetric();
1106 prefs_->SetInt64(kPrefsDeltaUpdateFailures, 0);
1107 prefs_->SetString(kPrefsPreviousVersion,
1108 omaha_request_params_->app_version());
1109 DeltaPerformer::ResetUpdateProgress(prefs_, false);
1110
1111 system_state_->payload_state()->UpdateSucceeded();
1112
1113 // Since we're done with scattering fully at this point, this is the
1114 // safest point delete the state files, as we're sure that the status is
1115 // set to reboot (which means no more updates will be applied until reboot)
1116 // This deletion is required for correctness as we want the next update
1117 // check to re-create a new random number for the update check count.
1118 // Similarly, we also delete the wall-clock-wait period that was persisted
1119 // so that we start with a new random value for the next update check
1120 // after reboot so that the same device is not favored or punished in any
1121 // way.
1122 prefs_->Delete(kPrefsUpdateCheckCount);
1123 system_state_->payload_state()->SetScatteringWaitPeriod(TimeDelta());
1124 system_state_->payload_state()->SetStagingWaitPeriod(TimeDelta());
1125 prefs_->Delete(kPrefsUpdateFirstSeenAt);
1126
1127 // Note: below this comment should only be on |ErrorCode::kSuccess|.
1128 if (is_install_) {
1129 ProcessingDoneInstall(processor, code);
1130 } else {
1131 ProcessingDoneUpdate(processor, code);
Darin Petkov1023a602010-08-30 13:47:51 -07001132 }
Jae Hoon Kimed3fcc02019-07-11 14:35:38 -07001133}
1134
Jae Hoon Kim7fdfbf12020-04-10 18:15:50 -07001135vector<string> UpdateAttempter::GetSuccessfulDlcIds() {
1136 vector<string> dlc_ids;
1137 for (const auto& pr : omaha_request_params_->dlc_apps_params())
1138 if (pr.second.updated)
1139 dlc_ids.push_back(pr.second.name);
1140 return dlc_ids;
1141}
1142
Jae Hoon Kimed3fcc02019-07-11 14:35:38 -07001143void UpdateAttempter::ProcessingDoneInstall(const ActionProcessor* processor,
1144 ErrorCode code) {
Jae Hoon Kim7fdfbf12020-04-10 18:15:50 -07001145 if (!system_state_->dlcservice()->InstallCompleted(GetSuccessfulDlcIds()))
1146 LOG(WARNING) << "dlcservice didn't successfully handle install completion.";
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001147 SetStatusAndNotify(UpdateStatus::IDLE);
Gilad Arnold54fa66d2014-09-29 13:14:29 -07001148 ScheduleUpdates();
Jae Hoon Kimed3fcc02019-07-11 14:35:38 -07001149 LOG(INFO) << "DLC successfully installed, no reboot needed.";
1150}
1151
1152void UpdateAttempter::ProcessingDoneUpdate(const ActionProcessor* processor,
1153 ErrorCode code) {
1154 WriteUpdateCompletedMarker();
1155
Jae Hoon Kim7fdfbf12020-04-10 18:15:50 -07001156 if (!system_state_->dlcservice()->UpdateCompleted(GetSuccessfulDlcIds()))
1157 LOG(WARNING) << "dlcservice didn't successfully handle update completion.";
Jae Hoon Kimed3fcc02019-07-11 14:35:38 -07001158 SetStatusAndNotify(UpdateStatus::UPDATED_NEED_REBOOT);
1159 ScheduleUpdates();
1160 LOG(INFO) << "Update successfully applied, waiting to reboot.";
1161
1162 // |install_plan_| is null during rollback operations, and the stats don't
1163 // make much sense then anyway.
1164 if (install_plan_) {
1165 // Generate an unique payload identifier.
1166 string target_version_uid;
1167 for (const auto& payload : install_plan_->payloads) {
1168 target_version_uid += brillo::data_encoding::Base64Encode(payload.hash) +
1169 ":" + payload.metadata_signature + ":";
1170 }
1171
1172 // If we just downloaded a rollback image, we should preserve this fact
1173 // over the following powerwash.
1174 if (install_plan_->is_rollback) {
1175 system_state_->payload_state()->SetRollbackHappened(true);
1176 system_state_->metrics_reporter()->ReportEnterpriseRollbackMetrics(
1177 /*success=*/true, install_plan_->version);
1178 }
1179
1180 // Expect to reboot into the new version to send the proper metric during
1181 // next boot.
1182 system_state_->payload_state()->ExpectRebootInNewVersion(
1183 target_version_uid);
1184 } else {
1185 // If we just finished a rollback, then we expect to have no Omaha
1186 // response. Otherwise, it's an error.
1187 if (system_state_->payload_state()->GetRollbackVersion().empty()) {
1188 LOG(ERROR) << "Can't send metrics because there was no Omaha response";
1189 }
1190 }
1191}
1192
1193// Delegate methods:
1194void UpdateAttempter::ProcessingDone(const ActionProcessor* processor,
1195 ErrorCode code) {
1196 LOG(INFO) << "Processing Done.";
1197 ProcessingDoneInternal(processor, code);
1198
1199 // Note: do cleanups here for any variables that need to be reset after a
1200 // failure, error, update, or install.
1201 is_install_ = false;
Andrew de los Reyes63b96d72010-05-10 13:08:54 -07001202}
1203
1204void UpdateAttempter::ProcessingStopped(const ActionProcessor* processor) {
Chris Sosa4f8ee272012-11-30 13:01:54 -08001205 // Reset cpu shares back to normal.
Alex Deymoab0d9762016-02-02 10:52:56 -08001206 cpu_limiter_.StopLimiter();
Andrew de los Reyes63b96d72010-05-10 13:08:54 -07001207 download_progress_ = 0.0;
Amin Hassaniecb60d32019-06-17 18:09:10 -07001208
1209 ResetInteractivityFlags();
1210
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001211 SetStatusAndNotify(UpdateStatus::IDLE);
Gilad Arnold54fa66d2014-09-29 13:14:29 -07001212 ScheduleUpdates();
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001213 error_event_.reset(nullptr);
Andrew de los Reyes63b96d72010-05-10 13:08:54 -07001214}
1215
1216// Called whenever an action has finished processing, either successfully
1217// or otherwise.
1218void UpdateAttempter::ActionCompleted(ActionProcessor* processor,
1219 AbstractAction* action,
David Zeuthena99981f2013-04-29 13:42:47 -07001220 ErrorCode code) {
Darin Petkov1023a602010-08-30 13:47:51 -07001221 // Reset download progress regardless of whether or not the download
1222 // action succeeded. Also, get the response code from HTTP request
1223 // actions (update download as well as the initial update check
1224 // actions).
Andrew de los Reyes63b96d72010-05-10 13:08:54 -07001225 const string type = action->Type();
Darin Petkov1023a602010-08-30 13:47:51 -07001226 if (type == DownloadAction::StaticType()) {
Andrew de los Reyes63b96d72010-05-10 13:08:54 -07001227 download_progress_ = 0.0;
Gilad Arnoldcf175a02014-07-10 16:48:47 -07001228 DownloadAction* download_action = static_cast<DownloadAction*>(action);
Darin Petkov1023a602010-08-30 13:47:51 -07001229 http_response_code_ = download_action->GetHTTPResponseCode();
1230 } else if (type == OmahaRequestAction::StaticType()) {
1231 OmahaRequestAction* omaha_request_action =
Gilad Arnoldcf175a02014-07-10 16:48:47 -07001232 static_cast<OmahaRequestAction*>(action);
Darin Petkov1023a602010-08-30 13:47:51 -07001233 // If the request is not an event, then it's the update-check.
1234 if (!omaha_request_action->IsEvent()) {
1235 http_response_code_ = omaha_request_action->GetHTTPResponseCode();
Gilad Arnolda6dab942014-04-25 11:46:03 -07001236
1237 // Record the number of consecutive failed update checks.
1238 if (http_response_code_ == kHttpResponseInternalServerError ||
1239 http_response_code_ == kHttpResponseServiceUnavailable) {
1240 consecutive_failed_update_checks_++;
1241 } else {
1242 consecutive_failed_update_checks_ = 0;
1243 }
1244
Weidong Guo421ff332017-04-17 10:08:38 -07001245 const OmahaResponse& omaha_response =
1246 omaha_request_action->GetOutputObject();
Gilad Arnolda0258a52014-07-10 16:21:19 -07001247 // Store the server-dictated poll interval, if any.
1248 server_dictated_poll_interval_ =
Weidong Guo421ff332017-04-17 10:08:38 -07001249 std::max(0, omaha_response.poll_interval);
1250
1251 // This update is ignored by omaha request action because update over
1252 // cellular connection is not allowed. Needs to ask for user's permissions
1253 // to update.
1254 if (code == ErrorCode::kOmahaUpdateIgnoredOverCellular) {
1255 new_version_ = omaha_response.version;
1256 new_payload_size_ = 0;
1257 for (const auto& package : omaha_response.packages) {
1258 new_payload_size_ += package.size;
1259 }
1260 SetStatusAndNotify(UpdateStatus::NEED_PERMISSION_TO_UPDATE);
1261 }
Darin Petkov1023a602010-08-30 13:47:51 -07001262 }
Aaron Wood23bd3392017-10-06 14:48:25 -07001263 } else if (type == OmahaResponseHandlerAction::StaticType()) {
1264 // Depending on the returned error code, note that an update is available.
1265 if (code == ErrorCode::kOmahaUpdateDeferredPerPolicy ||
1266 code == ErrorCode::kSuccess) {
1267 // Note that the status will be updated to DOWNLOADING when some bytes
1268 // get actually downloaded from the server and the BytesReceived
1269 // callback is invoked. This avoids notifying the user that a download
1270 // has started in cases when the server and the client are unable to
1271 // initiate the download.
Amin Hassanid3f4bea2018-04-30 14:52:40 -07001272 auto omaha_response_handler_action =
1273 static_cast<OmahaResponseHandlerAction*>(action);
1274 install_plan_.reset(
1275 new InstallPlan(omaha_response_handler_action->install_plan()));
Aaron Wood23bd3392017-10-06 14:48:25 -07001276 UpdateLastCheckedTime();
Amin Hassanid3f4bea2018-04-30 14:52:40 -07001277 new_version_ = install_plan_->version;
Aaron Wood23bd3392017-10-06 14:48:25 -07001278 new_payload_size_ = 0;
Amin Hassanid3f4bea2018-04-30 14:52:40 -07001279 for (const auto& payload : install_plan_->payloads)
Aaron Wood23bd3392017-10-06 14:48:25 -07001280 new_payload_size_ += payload.size;
1281 cpu_limiter_.StartLimiter();
1282 SetStatusAndNotify(UpdateStatus::UPDATE_AVAILABLE);
1283 }
Darin Petkov1023a602010-08-30 13:47:51 -07001284 }
Aaron Wood23bd3392017-10-06 14:48:25 -07001285 // General failure cases.
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001286 if (code != ErrorCode::kSuccess) {
Darin Petkov7ed561b2011-10-04 02:59:03 -07001287 // If the current state is at or past the download phase, count the failure
1288 // in case a switch to full update becomes necessary. Ignore network
1289 // transfer timeouts and failures.
Amin Hassani89a37122018-03-23 12:59:24 -07001290 if (code != ErrorCode::kDownloadTransferError) {
1291 switch (status_) {
1292 case UpdateStatus::IDLE:
1293 case UpdateStatus::CHECKING_FOR_UPDATE:
1294 case UpdateStatus::UPDATE_AVAILABLE:
1295 case UpdateStatus::NEED_PERMISSION_TO_UPDATE:
1296 break;
1297 case UpdateStatus::DOWNLOADING:
1298 case UpdateStatus::VERIFYING:
1299 case UpdateStatus::FINALIZING:
1300 case UpdateStatus::UPDATED_NEED_REBOOT:
1301 case UpdateStatus::REPORTING_ERROR_EVENT:
1302 case UpdateStatus::ATTEMPTING_ROLLBACK:
1303 case UpdateStatus::DISABLED:
Amin Hassani70a90f52020-09-15 15:30:09 -07001304 case UpdateStatus::CLEANUP_PREVIOUS_UPDATE:
Amin Hassani89a37122018-03-23 12:59:24 -07001305 MarkDeltaUpdateFailure();
1306 break;
1307 }
Darin Petkov36275772010-10-01 11:40:57 -07001308 }
Sen Jiang89e24c12018-03-22 18:05:44 -07001309 if (code != ErrorCode::kNoUpdate) {
1310 // On failure, schedule an error event to be sent to Omaha.
1311 CreatePendingErrorEvent(action, code);
1312 }
Andrew de los Reyes63b96d72010-05-10 13:08:54 -07001313 return;
Darin Petkov09f96c32010-07-20 09:24:57 -07001314 }
Aaron Wood23bd3392017-10-06 14:48:25 -07001315 // Find out which action completed (successfully).
1316 if (type == DownloadAction::StaticType()) {
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001317 SetStatusAndNotify(UpdateStatus::FINALIZING);
Amin Hassaniafd8cea2017-12-04 14:20:00 -08001318 } else if (type == FilesystemVerifierAction::StaticType()) {
1319 // Log the system properties before the postinst and after the file system
1320 // is verified. It used to be done in the postinst itself. But postinst
1321 // cannot do this anymore. On the other hand, these logs are frequently
1322 // looked at and it is preferable not to scatter them in random location in
1323 // the log and rather log it right before the postinst. The reason not do
1324 // this in the |PostinstallRunnerAction| is to prevent dependency from
1325 // libpayload_consumer to libupdate_engine.
1326 LogImageProperties();
Andrew de los Reyes63b96d72010-05-10 13:08:54 -07001327 }
Andrew de los Reyes4e9b9f42010-04-26 15:06:43 -07001328}
1329
Alex Deymo542c19b2015-12-03 07:43:31 -03001330void UpdateAttempter::BytesReceived(uint64_t bytes_progressed,
1331 uint64_t bytes_received,
1332 uint64_t total) {
1333 // The PayloadState keeps track of how many bytes were actually downloaded
1334 // from a given URL for the URL skipping logic.
1335 system_state_->payload_state()->DownloadProgress(bytes_progressed);
1336
Alex Deymo0d298542016-03-30 18:31:49 -07001337 double progress = 0;
1338 if (total)
1339 progress = static_cast<double>(bytes_received) / static_cast<double>(total);
1340 if (status_ != UpdateStatus::DOWNLOADING || bytes_received == total) {
Darin Petkovaf183052010-08-23 12:07:13 -07001341 download_progress_ = progress;
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001342 SetStatusAndNotify(UpdateStatus::DOWNLOADING);
Alex Deymo0d298542016-03-30 18:31:49 -07001343 } else {
1344 ProgressUpdate(progress);
Andrew de los Reyes63b96d72010-05-10 13:08:54 -07001345 }
1346}
1347
Alex Deymo542c19b2015-12-03 07:43:31 -03001348void UpdateAttempter::DownloadComplete() {
1349 system_state_->payload_state()->DownloadComplete();
1350}
1351
Alex Deymo0d298542016-03-30 18:31:49 -07001352void UpdateAttempter::ProgressUpdate(double progress) {
1353 // Self throttle based on progress. Also send notifications if progress is
1354 // too slow.
1355 if (progress == 1.0 ||
1356 progress - download_progress_ >= kBroadcastThresholdProgress ||
1357 TimeTicks::Now() - last_notify_time_ >=
1358 TimeDelta::FromSeconds(kBroadcastThresholdSeconds)) {
1359 download_progress_ = progress;
1360 BroadcastStatus();
1361 }
1362}
1363
Amin Hassaniecb60d32019-06-17 18:09:10 -07001364void UpdateAttempter::ResetInteractivityFlags() {
1365 // Reset the state that's only valid for a single update pass.
1366 current_update_attempt_flags_ = UpdateAttemptFlags::kNone;
1367
1368 if (forced_update_pending_callback_.get())
1369 // Clear prior interactive requests once the processor is done.
1370 forced_update_pending_callback_->Run(false, false);
1371}
1372
Jay Srinivasanc1ba09a2012-08-14 14:15:57 -07001373bool UpdateAttempter::ResetStatus() {
1374 LOG(INFO) << "Attempting to reset state from "
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001375 << UpdateStatusToString(status_) << " to UpdateStatus::IDLE";
Jay Srinivasanc1ba09a2012-08-14 14:15:57 -07001376
1377 switch (status_) {
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001378 case UpdateStatus::IDLE:
Jay Srinivasanc1ba09a2012-08-14 14:15:57 -07001379 // no-op.
1380 return true;
1381
Amin Hassani7cc8bb02019-01-14 16:29:47 -08001382 case UpdateStatus::UPDATED_NEED_REBOOT: {
Jay Srinivasan1c0fe792013-03-28 16:45:25 -07001383 bool ret_value = true;
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001384 status_ = UpdateStatus::IDLE;
Jay Srinivasanc1ba09a2012-08-14 14:15:57 -07001385
Jay Srinivasan1c0fe792013-03-28 16:45:25 -07001386 // Remove the reboot marker so that if the machine is rebooted
Jay Srinivasanc1ba09a2012-08-14 14:15:57 -07001387 // after resetting to idle state, it doesn't go back to
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001388 // UpdateStatus::UPDATED_NEED_REBOOT state.
Alex Deymo906191f2015-10-12 12:22:44 -07001389 ret_value = prefs_->Delete(kPrefsUpdateCompletedOnBootId) && ret_value;
1390 ret_value = prefs_->Delete(kPrefsUpdateCompletedBootTime) && ret_value;
Jay Srinivasan1c0fe792013-03-28 16:45:25 -07001391
Alex Deymo9870c0e2015-09-23 13:58:31 -07001392 // Update the boot flags so the current slot has higher priority.
1393 BootControlInterface* boot_control = system_state_->boot_control();
1394 if (!boot_control->SetActiveBootSlot(boot_control->GetCurrentSlot()))
1395 ret_value = false;
1396
Alex Deymo52590332016-11-29 18:29:13 -08001397 // Mark the current slot as successful again, since marking it as active
1398 // may reset the successful bit. We ignore the result of whether marking
1399 // the current slot as successful worked.
Amin Hassani7cc8bb02019-01-14 16:29:47 -08001400 if (!boot_control->MarkBootSuccessfulAsync(Bind([](bool successful) {})))
Alex Deymo52590332016-11-29 18:29:13 -08001401 ret_value = false;
1402
Alex Deymo42432912013-07-12 20:21:15 -07001403 // Notify the PayloadState that the successful payload was canceled.
1404 system_state_->payload_state()->ResetUpdateStatus();
1405
Alex Deymo87c08862015-10-30 21:56:55 -07001406 // The previous version is used to report back to omaha after reboot that
1407 // we actually rebooted into the new version from this "prev-version". We
1408 // need to clear out this value now to prevent it being sent on the next
1409 // updatecheck request.
1410 ret_value = prefs_->SetString(kPrefsPreviousVersion, "") && ret_value;
1411
Alex Deymo906191f2015-10-12 12:22:44 -07001412 LOG(INFO) << "Reset status " << (ret_value ? "successful" : "failed");
Jay Srinivasan1c0fe792013-03-28 16:45:25 -07001413 return ret_value;
Jay Srinivasanc1ba09a2012-08-14 14:15:57 -07001414 }
1415
1416 default:
1417 LOG(ERROR) << "Reset not allowed in this state.";
1418 return false;
1419 }
1420}
1421
Aaron Wood7f92e2b2017-08-28 14:51:21 -07001422bool UpdateAttempter::GetStatus(UpdateEngineStatus* out_status) {
Aaron Wood795c5b42017-12-05 16:06:13 -08001423 out_status->last_checked_time = last_checked_time_;
Aaron Wood7f92e2b2017-08-28 14:51:21 -07001424 out_status->status = status_;
1425 out_status->current_version = omaha_request_params_->app_version();
Aaron Wood7f92e2b2017-08-28 14:51:21 -07001426 out_status->progress = download_progress_;
1427 out_status->new_size_bytes = new_payload_size_;
1428 out_status->new_version = new_version_;
Amin Hassani9be122e2019-08-29 09:20:12 -07001429 out_status->is_enterprise_rollback =
1430 install_plan_ && install_plan_->is_rollback;
Jae Hoon Kim2f78c1c2019-07-25 13:20:43 -07001431 out_status->is_install = is_install_;
Jae Hoon Kim051627a2019-09-03 12:56:32 -07001432
1433 string str_eol_date;
Jae Hoon Kim2dfd35d2020-06-02 10:53:13 -07001434 if (system_state_->prefs()->Exists(kPrefsOmahaEolDate) &&
1435 !system_state_->prefs()->GetString(kPrefsOmahaEolDate, &str_eol_date))
1436 LOG(ERROR) << "Failed to retrieve kPrefsOmahaEolDate pref.";
Jae Hoon Kim051627a2019-09-03 12:56:32 -07001437 out_status->eol_date = StringToEolDate(str_eol_date);
1438
Miriam Polzer0cf1acb2020-04-29 17:39:51 +02001439 // A powerwash will take place either if the install plan says it is required
1440 // or if an enterprise rollback is happening.
1441 out_status->will_powerwash_after_reboot =
1442 install_plan_ &&
1443 (install_plan_->powerwash_required || install_plan_->is_rollback);
1444
Andrew de los Reyes4e9b9f42010-04-26 15:06:43 -07001445 return true;
1446}
1447
Darin Petkov61635a92011-05-18 16:20:36 -07001448void UpdateAttempter::BroadcastStatus() {
Aaron Wood7f92e2b2017-08-28 14:51:21 -07001449 UpdateEngineStatus broadcast_status;
1450 // Use common method for generating the current status.
1451 GetStatus(&broadcast_status);
1452
Alex Deymofa78f142016-01-26 21:36:16 -08001453 for (const auto& observer : service_observers_) {
Aaron Wood7f92e2b2017-08-28 14:51:21 -07001454 observer->SendStatusUpdate(broadcast_status);
Alex Deymofa78f142016-01-26 21:36:16 -08001455 }
Darin Petkovaf183052010-08-23 12:07:13 -07001456 last_notify_time_ = TimeTicks::Now();
Alex Deymofa78f142016-01-26 21:36:16 -08001457}
1458
Amin Hassani7cc8bb02019-01-14 16:29:47 -08001459uint32_t UpdateAttempter::GetErrorCodeFlags() {
Jay Srinivasan55f50c22013-01-10 19:24:35 -08001460 uint32_t flags = 0;
1461
J. Richard Barnette056b0ab2013-10-29 15:24:56 -07001462 if (!system_state_->hardware()->IsNormalBootMode())
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001463 flags |= static_cast<uint32_t>(ErrorCode::kDevModeFlag);
Jay Srinivasan55f50c22013-01-10 19:24:35 -08001464
Amin Hassanid3f4bea2018-04-30 14:52:40 -07001465 if (install_plan_ && install_plan_->is_resume)
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001466 flags |= static_cast<uint32_t>(ErrorCode::kResumedFlag);
Jay Srinivasan55f50c22013-01-10 19:24:35 -08001467
J. Richard Barnette056b0ab2013-10-29 15:24:56 -07001468 if (!system_state_->hardware()->IsOfficialBuild())
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001469 flags |= static_cast<uint32_t>(ErrorCode::kTestImageFlag);
Jay Srinivasan55f50c22013-01-10 19:24:35 -08001470
Sen Jiangdaeaa432018-10-09 18:18:45 -07001471 if (!omaha_request_params_->IsUpdateUrlOfficial()) {
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001472 flags |= static_cast<uint32_t>(ErrorCode::kTestOmahaUrlFlag);
Alex Deymoac41a822015-09-15 20:52:53 -07001473 }
Jay Srinivasan55f50c22013-01-10 19:24:35 -08001474
1475 return flags;
1476}
1477
David Zeuthena99981f2013-04-29 13:42:47 -07001478bool UpdateAttempter::ShouldCancel(ErrorCode* cancel_reason) {
Jay Srinivasan1c0fe792013-03-28 16:45:25 -07001479 // Check if the channel we're attempting to update to is the same as the
1480 // target channel currently chosen by the user.
1481 OmahaRequestParams* params = system_state_->request_params();
1482 if (params->download_channel() != params->target_channel()) {
1483 LOG(ERROR) << "Aborting download as target channel: "
1484 << params->target_channel()
1485 << " is different from the download channel: "
1486 << params->download_channel();
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001487 *cancel_reason = ErrorCode::kUpdateCanceledByChannelChange;
Jay Srinivasan1c0fe792013-03-28 16:45:25 -07001488 return true;
1489 }
1490
1491 return false;
1492}
1493
Nam T. Nguyen7d623eb2014-05-13 16:06:28 -07001494void UpdateAttempter::SetStatusAndNotify(UpdateStatus status) {
Darin Petkov61635a92011-05-18 16:20:36 -07001495 status_ = status;
Darin Petkov61635a92011-05-18 16:20:36 -07001496 BroadcastStatus();
1497}
1498
Darin Petkov777dbfa2010-07-20 15:03:37 -07001499void UpdateAttempter::CreatePendingErrorEvent(AbstractAction* action,
David Zeuthena99981f2013-04-29 13:42:47 -07001500 ErrorCode code) {
Sen Jiang89e24c12018-03-22 18:05:44 -07001501 if (error_event_.get() || status_ == UpdateStatus::REPORTING_ERROR_EVENT) {
Darin Petkov09f96c32010-07-20 09:24:57 -07001502 // This shouldn't really happen.
1503 LOG(WARNING) << "There's already an existing pending error event.";
1504 return;
1505 }
Darin Petkov777dbfa2010-07-20 15:03:37 -07001506
Jay Srinivasan56d5aa42012-03-26 14:27:59 -07001507 // Classify the code to generate the appropriate result so that
1508 // the Borgmon charts show up the results correctly.
1509 // Do this before calling GetErrorCodeForAction which could potentially
1510 // augment the bit representation of code and thus cause no matches for
1511 // the switch cases below.
1512 OmahaEvent::Result event_result;
1513 switch (code) {
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001514 case ErrorCode::kOmahaUpdateIgnoredPerPolicy:
1515 case ErrorCode::kOmahaUpdateDeferredPerPolicy:
1516 case ErrorCode::kOmahaUpdateDeferredForBackoff:
Jay Srinivasan56d5aa42012-03-26 14:27:59 -07001517 event_result = OmahaEvent::kResultUpdateDeferred;
1518 break;
1519 default:
1520 event_result = OmahaEvent::kResultError;
1521 break;
1522 }
1523
Darin Petkov777dbfa2010-07-20 15:03:37 -07001524 code = GetErrorCodeForAction(action, code);
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001525 fake_update_success_ = code == ErrorCode::kPostinstallBootedFromFirmwareB;
Darin Petkov18c7bce2011-06-16 14:07:00 -07001526
Jay Srinivasan55f50c22013-01-10 19:24:35 -08001527 // Compute the final error code with all the bit flags to be sent to Omaha.
Amin Hassani7cc8bb02019-01-14 16:29:47 -08001528 code =
1529 static_cast<ErrorCode>(static_cast<uint32_t>(code) | GetErrorCodeFlags());
1530 error_event_.reset(
1531 new OmahaEvent(OmahaEvent::kTypeUpdateComplete, event_result, code));
Darin Petkov09f96c32010-07-20 09:24:57 -07001532}
1533
1534bool UpdateAttempter::ScheduleErrorEventAction() {
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001535 if (error_event_.get() == nullptr)
Darin Petkov09f96c32010-07-20 09:24:57 -07001536 return false;
1537
Jay Srinivasan6f6ea002012-12-14 11:26:28 -08001538 LOG(ERROR) << "Update failed.";
1539 system_state_->payload_state()->UpdateFailed(error_event_->error_code);
1540
Marton Hunyadya0302682018-05-16 18:52:13 +02001541 // Send metrics if it was a rollback.
Amin Hassanid3f4bea2018-04-30 14:52:40 -07001542 if (install_plan_ && install_plan_->is_rollback) {
1543 system_state_->metrics_reporter()->ReportEnterpriseRollbackMetrics(
1544 /*success=*/false, install_plan_->version);
Marton Hunyadya0302682018-05-16 18:52:13 +02001545 }
1546
Jay Srinivasan55f50c22013-01-10 19:24:35 -08001547 // Send it to Omaha.
Alex Deymoaf9a8632015-09-23 18:51:48 -07001548 LOG(INFO) << "Reporting the error event";
Amin Hassanid3f4bea2018-04-30 14:52:40 -07001549 auto error_event_action = std::make_unique<OmahaRequestAction>(
1550 system_state_,
1551 error_event_.release(), // Pass ownership.
1552 std::make_unique<LibcurlHttpFetcher>(GetProxyResolver(),
1553 system_state_->hardware()),
Jae Hoon Kimedb65502019-06-14 11:52:17 -07001554 false,
1555 session_id_);
Amin Hassanid3f4bea2018-04-30 14:52:40 -07001556 processor_->EnqueueAction(std::move(error_event_action));
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001557 SetStatusAndNotify(UpdateStatus::REPORTING_ERROR_EVENT);
Darin Petkovf42cc1c2010-09-01 09:03:02 -07001558 processor_->StartProcessing();
Darin Petkov09f96c32010-07-20 09:24:57 -07001559 return true;
1560}
1561
Darin Petkov58dd1342011-05-06 12:05:13 -07001562void UpdateAttempter::ScheduleProcessingStart() {
1563 LOG(INFO) << "Scheduling an action processor start.";
Alex Deymo60ca1a72015-06-18 18:19:15 -07001564 MessageLoop::current()->PostTask(
1565 FROM_HERE,
Luis Hector Chavezf1cf3482016-07-19 14:29:19 -07001566 Bind([](ActionProcessor* processor) { processor->StartProcessing(); },
1567 base::Unretained(processor_.get())));
Darin Petkov58dd1342011-05-06 12:05:13 -07001568}
1569
Darin Petkov36275772010-10-01 11:40:57 -07001570void UpdateAttempter::DisableDeltaUpdateIfNeeded() {
1571 int64_t delta_failures;
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001572 if (omaha_request_params_->delta_okay() &&
Darin Petkov36275772010-10-01 11:40:57 -07001573 prefs_->GetInt64(kPrefsDeltaUpdateFailures, &delta_failures) &&
1574 delta_failures >= kMaxDeltaUpdateFailures) {
1575 LOG(WARNING) << "Too many delta update failures, forcing full update.";
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001576 omaha_request_params_->set_delta_okay(false);
Darin Petkov36275772010-10-01 11:40:57 -07001577 }
1578}
1579
1580void UpdateAttempter::MarkDeltaUpdateFailure() {
Darin Petkov2dd01092010-10-08 15:43:05 -07001581 // Don't try to resume a failed delta update.
1582 DeltaPerformer::ResetUpdateProgress(prefs_, false);
Darin Petkov36275772010-10-01 11:40:57 -07001583 int64_t delta_failures;
1584 if (!prefs_->GetInt64(kPrefsDeltaUpdateFailures, &delta_failures) ||
1585 delta_failures < 0) {
1586 delta_failures = 0;
1587 }
1588 prefs_->SetInt64(kPrefsDeltaUpdateFailures, ++delta_failures);
1589}
1590
Thieu Le116fda32011-04-19 11:01:54 -07001591void UpdateAttempter::PingOmaha() {
Thieu Led88a8572011-05-26 09:09:19 -07001592 if (!processor_->IsRunning()) {
Amin Hassaniecb60d32019-06-17 18:09:10 -07001593 ResetInteractivityFlags();
1594
Amin Hassanid3f4bea2018-04-30 14:52:40 -07001595 auto ping_action = std::make_unique<OmahaRequestAction>(
Alex Deymoc1c17b42015-11-23 03:53:15 -03001596 system_state_,
1597 nullptr,
Ben Chanab5a0af2017-10-12 14:57:50 -07001598 std::make_unique<LibcurlHttpFetcher>(GetProxyResolver(),
Ben Chan5c02c132017-06-27 07:10:36 -07001599 system_state_->hardware()),
Jae Hoon Kimedb65502019-06-14 11:52:17 -07001600 true,
1601 "" /* session_id */);
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001602 processor_->set_delegate(nullptr);
Amin Hassanid3f4bea2018-04-30 14:52:40 -07001603 processor_->EnqueueAction(std::move(ping_action));
Thieu Led88a8572011-05-26 09:09:19 -07001604 // Call StartProcessing() synchronously here to avoid any race conditions
1605 // caused by multiple outstanding ping Omaha requests. If we call
1606 // StartProcessing() asynchronously, the device can be suspended before we
1607 // get a chance to callback to StartProcessing(). When the device resumes
1608 // (assuming the device sleeps longer than the next update check period),
1609 // StartProcessing() is called back and at the same time, the next update
1610 // check is fired which eventually invokes StartProcessing(). A crash
1611 // can occur because StartProcessing() checks to make sure that the
1612 // processor is idle which it isn't due to the two concurrent ping Omaha
1613 // requests.
1614 processor_->StartProcessing();
1615 } else {
Darin Petkov58dd1342011-05-06 12:05:13 -07001616 LOG(WARNING) << "Action processor running, Omaha ping suppressed.";
Darin Petkov58dd1342011-05-06 12:05:13 -07001617 }
Thieu Led88a8572011-05-26 09:09:19 -07001618
Gilad Arnoldec7f9162014-07-15 13:24:46 -07001619 // Update the last check time here; it may be re-updated when an Omaha
1620 // response is received, but this will prevent us from repeatedly scheduling
1621 // checks in the case where a response is not received.
1622 UpdateLastCheckedTime();
1623
Thieu Led88a8572011-05-26 09:09:19 -07001624 // Update the status which will schedule the next update check
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001625 SetStatusAndNotify(UpdateStatus::UPDATED_NEED_REBOOT);
Gilad Arnold54fa66d2014-09-29 13:14:29 -07001626 ScheduleUpdates();
Thieu Le116fda32011-04-19 11:01:54 -07001627}
1628
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001629bool UpdateAttempter::DecrementUpdateCheckCount() {
Ben Chan9abb7632014-08-07 00:10:53 -07001630 int64_t update_check_count_value;
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001631
1632 if (!prefs_->Exists(kPrefsUpdateCheckCount)) {
1633 // This file does not exist. This means we haven't started our update
1634 // check count down yet, so nothing more to do. This file will be created
1635 // later when we first satisfy the wall-clock-based-wait period.
1636 LOG(INFO) << "No existing update check count. That's normal.";
1637 return true;
1638 }
1639
1640 if (prefs_->GetInt64(kPrefsUpdateCheckCount, &update_check_count_value)) {
1641 // Only if we're able to read a proper integer value, then go ahead
1642 // and decrement and write back the result in the same file, if needed.
1643 LOG(INFO) << "Update check count = " << update_check_count_value;
1644
1645 if (update_check_count_value == 0) {
1646 // It could be 0, if, for some reason, the file didn't get deleted
1647 // when we set our status to waiting for reboot. so we just leave it
1648 // as is so that we can prevent another update_check wait for this client.
1649 LOG(INFO) << "Not decrementing update check count as it's already 0.";
1650 return true;
1651 }
1652
1653 if (update_check_count_value > 0)
1654 update_check_count_value--;
1655 else
1656 update_check_count_value = 0;
1657
1658 // Write out the new value of update_check_count_value.
1659 if (prefs_->SetInt64(kPrefsUpdateCheckCount, update_check_count_value)) {
Sen Jiang771f6482018-04-04 17:59:10 -07001660 // We successfully wrote out the new value, so enable the
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001661 // update check based wait.
1662 LOG(INFO) << "New update check count = " << update_check_count_value;
1663 return true;
1664 }
1665 }
1666
1667 LOG(INFO) << "Deleting update check count state due to read/write errors.";
1668
1669 // We cannot read/write to the file, so disable the update check based wait
1670 // so that we don't get stuck in this OS version by any chance (which could
1671 // happen if there's some bug that causes to read/write incorrectly).
1672 // Also attempt to delete the file to do our best effort to cleanup.
1673 prefs_->Delete(kPrefsUpdateCheckCount);
1674 return false;
1675}
Chris Sosad317e402013-06-12 13:47:09 -07001676
David Zeuthene4c58bf2013-06-18 17:26:50 -07001677void UpdateAttempter::UpdateEngineStarted() {
Alex Vakulenkodea2eac2014-03-14 15:56:59 -07001678 // If we just booted into a new update, keep the previous OS version
1679 // in case we rebooted because of a crash of the old version, so we
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001680 // can do a proper crash report with correct information.
Alex Vakulenkodea2eac2014-03-14 15:56:59 -07001681 // This must be done before calling
1682 // system_state_->payload_state()->UpdateEngineStarted() since it will
1683 // delete SystemUpdated marker file.
1684 if (system_state_->system_rebooted() &&
1685 prefs_->Exists(kPrefsSystemUpdatedMarker)) {
1686 if (!prefs_->GetString(kPrefsPreviousVersion, &prev_version_)) {
1687 // If we fail to get the version string, make sure it stays empty.
1688 prev_version_.clear();
1689 }
1690 }
1691
David Zeuthene4c58bf2013-06-18 17:26:50 -07001692 system_state_->payload_state()->UpdateEngineStarted();
David Zeuthen8f191b22013-08-06 12:27:50 -07001693 StartP2PAtStartup();
Jae Hoon Kim5e8e30b2020-05-06 14:59:06 -07001694
1695 excluder_ = CreateExcluder(system_state_->prefs());
David Zeuthen8f191b22013-08-06 12:27:50 -07001696}
1697
1698bool UpdateAttempter::StartP2PAtStartup() {
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001699 if (system_state_ == nullptr ||
David Zeuthen8f191b22013-08-06 12:27:50 -07001700 !system_state_->p2p_manager()->IsP2PEnabled()) {
1701 LOG(INFO) << "Not starting p2p at startup since it's not enabled.";
1702 return false;
1703 }
1704
1705 if (system_state_->p2p_manager()->CountSharedFiles() < 1) {
1706 LOG(INFO) << "Not starting p2p at startup since our application "
1707 << "is not sharing any files.";
1708 return false;
1709 }
1710
1711 return StartP2PAndPerformHousekeeping();
1712}
1713
1714bool UpdateAttempter::StartP2PAndPerformHousekeeping() {
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001715 if (system_state_ == nullptr)
David Zeuthen8f191b22013-08-06 12:27:50 -07001716 return false;
1717
1718 if (!system_state_->p2p_manager()->IsP2PEnabled()) {
1719 LOG(INFO) << "Not starting p2p since it's not enabled.";
1720 return false;
1721 }
1722
1723 LOG(INFO) << "Ensuring that p2p is running.";
1724 if (!system_state_->p2p_manager()->EnsureP2PRunning()) {
1725 LOG(ERROR) << "Error starting p2p.";
1726 return false;
1727 }
1728
1729 LOG(INFO) << "Performing p2p housekeeping.";
1730 if (!system_state_->p2p_manager()->PerformHousekeeping()) {
1731 LOG(ERROR) << "Error performing housekeeping for p2p.";
1732 return false;
1733 }
1734
1735 LOG(INFO) << "Done performing p2p housekeeping.";
1736 return true;
David Zeuthene4c58bf2013-06-18 17:26:50 -07001737}
1738
Amin Hassani7cc8bb02019-01-14 16:29:47 -08001739bool UpdateAttempter::GetBootTimeAtUpdate(Time* out_boot_time) {
Alex Deymo906191f2015-10-12 12:22:44 -07001740 // In case of an update_engine restart without a reboot, we stored the boot_id
1741 // when the update was completed by setting a pref, so we can check whether
1742 // the last update was on this boot or a previous one.
1743 string boot_id;
1744 TEST_AND_RETURN_FALSE(utils::GetBootId(&boot_id));
1745
1746 string update_completed_on_boot_id;
1747 if (!prefs_->Exists(kPrefsUpdateCompletedOnBootId) ||
1748 !prefs_->GetString(kPrefsUpdateCompletedOnBootId,
1749 &update_completed_on_boot_id) ||
1750 update_completed_on_boot_id != boot_id)
David Zeuthen3c55abd2013-10-14 12:48:03 -07001751 return false;
1752
Alex Deymo906191f2015-10-12 12:22:44 -07001753 // Short-circuit avoiding the read in case out_boot_time is nullptr.
1754 if (out_boot_time) {
1755 int64_t boot_time = 0;
1756 // Since the kPrefsUpdateCompletedOnBootId was correctly set, this pref
1757 // should not fail.
1758 TEST_AND_RETURN_FALSE(
1759 prefs_->GetInt64(kPrefsUpdateCompletedBootTime, &boot_time));
1760 *out_boot_time = Time::FromInternalValue(boot_time);
David Zeuthen3c55abd2013-10-14 12:48:03 -07001761 }
David Zeuthen3c55abd2013-10-14 12:48:03 -07001762 return true;
1763}
1764
Jae Hoon Kimba2fdce2019-07-11 13:18:58 -07001765bool UpdateAttempter::IsBusyOrUpdateScheduled() {
Christopher Wileycc8ce0e2015-10-01 16:48:47 -07001766 return ((status_ != UpdateStatus::IDLE &&
1767 status_ != UpdateStatus::UPDATED_NEED_REBOOT) ||
Gilad Arnold54fa66d2014-09-29 13:14:29 -07001768 waiting_for_scheduled_check_);
1769}
1770
Sen Jiangdaeaa432018-10-09 18:18:45 -07001771bool UpdateAttempter::IsAnyUpdateSourceAllowed() const {
David Pursell907b4fa2015-01-27 10:27:38 -08001772 // We allow updates from any source if either of these are true:
1773 // * The device is running an unofficial (dev/test) image.
1774 // * The debugd dev features are accessible (i.e. in devmode with no owner).
1775 // This protects users running a base image, while still allowing a specific
1776 // window (gated by the debug dev features) where `cros flash` is usable.
David Pursell02c18642014-11-06 11:26:11 -08001777 if (!system_state_->hardware()->IsOfficialBuild()) {
1778 LOG(INFO) << "Non-official build; allowing any update source.";
1779 return true;
1780 }
1781
Sen Jiange67bb5b2016-06-20 15:53:56 -07001782 if (system_state_->hardware()->AreDevFeaturesEnabled()) {
1783 LOG(INFO) << "Developer features enabled; allowing custom update sources.";
David Pursell02c18642014-11-06 11:26:11 -08001784 return true;
1785 }
Sen Jiange67bb5b2016-06-20 15:53:56 -07001786
1787 LOG(INFO)
1788 << "Developer features disabled; disallowing custom update sources.";
David Pursell02c18642014-11-06 11:26:11 -08001789 return false;
1790}
1791
May Lippert60aa3ca2018-08-15 16:55:29 -07001792void UpdateAttempter::ReportTimeToUpdateAppliedMetric() {
1793 const policy::DevicePolicy* device_policy = system_state_->device_policy();
1794 if (device_policy && device_policy->IsEnterpriseEnrolled()) {
1795 vector<policy::DevicePolicy::WeeklyTimeInterval> parsed_intervals;
1796 bool has_time_restrictions =
1797 device_policy->GetDisallowedTimeIntervals(&parsed_intervals);
1798
1799 int64_t update_first_seen_at_int;
1800 if (system_state_->prefs()->Exists(kPrefsUpdateFirstSeenAt)) {
1801 if (system_state_->prefs()->GetInt64(kPrefsUpdateFirstSeenAt,
1802 &update_first_seen_at_int)) {
1803 TimeDelta update_delay =
1804 system_state_->clock()->GetWallclockTime() -
1805 Time::FromInternalValue(update_first_seen_at_int);
1806 system_state_->metrics_reporter()
1807 ->ReportEnterpriseUpdateSeenToDownloadDays(has_time_restrictions,
1808 update_delay.InDays());
1809 }
1810 }
1811 }
1812}
1813
Andrew de los Reyes4e9b9f42010-04-26 15:06:43 -07001814} // namespace chromeos_update_engine