blob: f785760ef82043428a76673dad34d18219e259c6 [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//
rspangler@google.com49fdf182009-10-10 00:57:34 +000016
Darin Petkov6a5b3222010-07-13 14:55:28 -070017#include "update_engine/omaha_request_action.h"
Darin Petkov85ced132010-09-01 10:20:56 -070018
Andrew de los Reyes08c4e272010-04-15 14:02:17 -070019#include <inttypes.h>
Darin Petkov85ced132010-09-01 10:20:56 -070020
David Zeuthene8ed8632014-07-24 13:38:10 -040021#include <map>
rspangler@google.com49fdf182009-10-10 00:57:34 +000022#include <sstream>
Jay Srinivasan480ddfa2012-06-01 19:15:26 -070023#include <string>
David Zeuthene8ed8632014-07-24 13:38:10 -040024#include <vector>
rspangler@google.com49fdf182009-10-10 00:57:34 +000025
David Zeuthen8f191b22013-08-06 12:27:50 -070026#include <base/bind.h>
Jay Srinivasan480ddfa2012-06-01 19:15:26 -070027#include <base/logging.h>
28#include <base/rand_util.h>
Alex Vakulenko75039d72014-03-25 12:36:28 -070029#include <base/strings/string_number_conversions.h>
30#include <base/strings/string_util.h>
31#include <base/strings/stringprintf.h>
32#include <base/time/time.h>
David Zeuthene8ed8632014-07-24 13:38:10 -040033#include <expat.h>
Alex Deymoa2591792015-11-17 00:39:40 -030034#include <metrics/metrics_library.h>
rspangler@google.com49fdf182009-10-10 00:57:34 +000035
Alex Deymo39910dc2015-11-09 17:04:30 -080036#include "update_engine/common/action_pipe.h"
37#include "update_engine/common/constants.h"
38#include "update_engine/common/hardware_interface.h"
39#include "update_engine/common/hash_calculator.h"
40#include "update_engine/common/platform_constants.h"
41#include "update_engine/common/prefs_interface.h"
42#include "update_engine/common/utils.h"
Alex Deymof6ee0162015-07-31 12:35:22 -070043#include "update_engine/connection_manager.h"
Alex Deymo38429cf2015-11-11 18:27:22 -080044#include "update_engine/metrics.h"
45#include "update_engine/metrics_utils.h"
Darin Petkova4a8a8c2010-07-15 22:21:12 -070046#include "update_engine/omaha_request_params.h"
David Zeuthen8f191b22013-08-06 12:27:50 -070047#include "update_engine/p2p_manager.h"
Jay Srinivasan55f50c22013-01-10 19:24:35 -080048#include "update_engine/payload_state_interface.h"
rspangler@google.com49fdf182009-10-10 00:57:34 +000049
Darin Petkov1cbd78f2010-07-29 12:38:34 -070050using base::Time;
51using base::TimeDelta;
David Zeuthene8ed8632014-07-24 13:38:10 -040052using std::map;
rspangler@google.com49fdf182009-10-10 00:57:34 +000053using std::string;
David Zeuthene8ed8632014-07-24 13:38:10 -040054using std::vector;
rspangler@google.com49fdf182009-10-10 00:57:34 +000055
56namespace chromeos_update_engine {
57
Jay Srinivasan2b5a0f02012-12-19 17:25:56 -080058// List of custom pair tags that we interpret in the Omaha Response:
59static const char* kTagDeadline = "deadline";
Jay Srinivasan08262882012-12-28 19:29:43 -080060static const char* kTagDisablePayloadBackoff = "DisablePayloadBackoff";
Chris Sosa3b748432013-06-20 16:42:59 -070061static const char* kTagVersion = "version";
Jay Srinivasand671e972013-01-11 17:17:19 -080062// Deprecated: "IsDelta"
63static const char* kTagIsDeltaPayload = "IsDeltaPayload";
Jay Srinivasan2b5a0f02012-12-19 17:25:56 -080064static const char* kTagMaxFailureCountPerUrl = "MaxFailureCountPerUrl";
65static const char* kTagMaxDaysToScatter = "MaxDaysToScatter";
66// Deprecated: "ManifestSignatureRsa"
67// Deprecated: "ManifestSize"
68static const char* kTagMetadataSignatureRsa = "MetadataSignatureRsa";
69static const char* kTagMetadataSize = "MetadataSize";
70static const char* kTagMoreInfo = "MoreInfo";
Don Garrett42bd3aa2013-04-10 18:14:56 -070071// Deprecated: "NeedsAdmin"
Jay Srinivasan2b5a0f02012-12-19 17:25:56 -080072static const char* kTagPrompt = "Prompt";
73static const char* kTagSha256 = "sha256";
David Zeuthen8f191b22013-08-06 12:27:50 -070074static const char* kTagDisableP2PForDownloading = "DisableP2PForDownloading";
75static const char* kTagDisableP2PForSharing = "DisableP2PForSharing";
David Zeuthene7f89172013-10-31 10:21:04 -070076static const char* kTagPublicKeyRsa = "PublicKeyRsa";
Jay Srinivasan2b5a0f02012-12-19 17:25:56 -080077
Alex Deymoac41a822015-09-15 20:52:53 -070078static const char* kOmahaUpdaterVersion = "0.1.0.0";
rspangler@google.com49fdf182009-10-10 00:57:34 +000079
Alex Deymoac41a822015-09-15 20:52:53 -070080namespace {
rspangler@google.com49fdf182009-10-10 00:57:34 +000081
Darin Petkov1cbd78f2010-07-29 12:38:34 -070082// Returns an XML ping element attribute assignment with attribute
83// |name| and value |ping_days| if |ping_days| has a value that needs
84// to be sent, or an empty string otherwise.
85string GetPingAttribute(const string& name, int ping_days) {
Alex Deymoebbe7ef2014-10-30 13:02:49 -070086 if (ping_days > 0 || ping_days == OmahaRequestAction::kNeverPinged)
Alex Vakulenko75039d72014-03-25 12:36:28 -070087 return base::StringPrintf(" %s=\"%d\"", name.c_str(), ping_days);
Darin Petkov1cbd78f2010-07-29 12:38:34 -070088 return "";
89}
90
91// Returns an XML ping element if any of the elapsed days need to be
92// sent, or an empty string otherwise.
Jay Srinivasanae4697c2013-03-18 17:08:08 -070093string GetPingXml(int ping_active_days, int ping_roll_call_days) {
Darin Petkov1cbd78f2010-07-29 12:38:34 -070094 string ping_active = GetPingAttribute("a", ping_active_days);
95 string ping_roll_call = GetPingAttribute("r", ping_roll_call_days);
96 if (!ping_active.empty() || !ping_roll_call.empty()) {
Alex Vakulenko75039d72014-03-25 12:36:28 -070097 return base::StringPrintf(" <ping active=\"1\"%s%s></ping>\n",
Alex Deymoebbe7ef2014-10-30 13:02:49 -070098 ping_active.c_str(),
99 ping_roll_call.c_str());
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700100 }
101 return "";
102}
103
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700104// Returns an XML that goes into the body of the <app> element of the Omaha
105// request based on the given parameters.
106string GetAppBody(const OmahaEvent* event,
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700107 OmahaRequestParams* params,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700108 bool ping_only,
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700109 bool include_ping,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700110 int ping_active_days,
111 int ping_roll_call_days,
112 PrefsInterface* prefs) {
113 string app_body;
Alex Vakulenko88b591f2014-08-28 16:48:57 -0700114 if (event == nullptr) {
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700115 if (include_ping)
116 app_body = GetPingXml(ping_active_days, ping_roll_call_days);
Darin Petkov265f2902011-05-09 15:17:40 -0700117 if (!ping_only) {
Alex Vakulenko75039d72014-03-25 12:36:28 -0700118 app_body += base::StringPrintf(
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700119 " <updatecheck targetversionprefix=\"%s\""
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700120 "></updatecheck>\n",
Alex Deymob0d74eb2015-03-30 17:59:17 -0700121 XmlEncodeWithDefault(params->target_version_prefix(), "").c_str());
Jay Srinivasan0a708742012-03-20 11:26:12 -0700122
Darin Petkov265f2902011-05-09 15:17:40 -0700123 // If this is the first update check after a reboot following a previous
124 // update, generate an event containing the previous version number. If
125 // the previous version preference file doesn't exist the event is still
126 // generated with a previous version of 0.0.0.0 -- this is relevant for
127 // older clients or new installs. The previous version event is not sent
128 // for ping-only requests because they come before the client has
Alex Deymo87c08862015-10-30 21:56:55 -0700129 // rebooted. The previous version event is also not sent if it was already
130 // sent for this new version with a previous updatecheck.
Darin Petkov265f2902011-05-09 15:17:40 -0700131 string prev_version;
132 if (!prefs->GetString(kPrefsPreviousVersion, &prev_version)) {
133 prev_version = "0.0.0.0";
134 }
Alex Deymo87c08862015-10-30 21:56:55 -0700135 // We only store a non-empty previous version value after a successful
136 // update in the previous boot. After reporting it back to the server,
137 // we clear the previous version value so it doesn't get reported again.
138 if (!prev_version.empty()) {
139 app_body += base::StringPrintf(
140 " <event eventtype=\"%d\" eventresult=\"%d\" "
141 "previousversion=\"%s\"></event>\n",
Alex Deymo9fded1e2015-11-05 12:31:19 -0800142 OmahaEvent::kTypeRebootedAfterUpdate,
143 OmahaEvent::kResultSuccess,
Alex Deymo87c08862015-10-30 21:56:55 -0700144 XmlEncodeWithDefault(prev_version, "0.0.0.0").c_str());
145 LOG_IF(WARNING, !prefs->SetString(kPrefsPreviousVersion, ""))
146 << "Unable to reset the previous version.";
147 }
Darin Petkov95508da2011-01-05 12:42:29 -0800148 }
Darin Petkov0dc8e9a2010-07-14 14:51:57 -0700149 } else {
Darin Petkovc91dd6b2011-01-10 12:31:34 -0800150 // The error code is an optional attribute so append it only if the result
151 // is not success.
Darin Petkove17f86b2010-07-20 09:12:01 -0700152 string error_code;
153 if (event->result != OmahaEvent::kResultSuccess) {
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700154 error_code = base::StringPrintf(" errorcode=\"%d\"",
155 static_cast<int>(event->error_code));
Darin Petkove17f86b2010-07-20 09:12:01 -0700156 }
Alex Vakulenko75039d72014-03-25 12:36:28 -0700157 app_body = base::StringPrintf(
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700158 " <event eventtype=\"%d\" eventresult=\"%d\"%s></event>\n",
Darin Petkove17f86b2010-07-20 09:12:01 -0700159 event->type, event->result, error_code.c_str());
Darin Petkov0dc8e9a2010-07-14 14:51:57 -0700160 }
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700161
162 return app_body;
163}
164
Alex Deymo8e18f932015-03-27 16:16:59 -0700165// Returns the cohort* argument to include in the <app> tag for the passed
166// |arg_name| and |prefs_key|, if any. The return value is suitable to
167// concatenate to the list of arguments and includes a space at the end.
168string GetCohortArgXml(PrefsInterface* prefs,
Alex Deymob0d74eb2015-03-30 17:59:17 -0700169 const string arg_name,
170 const string prefs_key) {
Alex Deymo8e18f932015-03-27 16:16:59 -0700171 // There's nothing wrong with not having a given cohort setting, so we check
172 // existance first to avoid the warning log message.
173 if (!prefs->Exists(prefs_key))
174 return "";
175 string cohort_value;
176 if (!prefs->GetString(prefs_key, &cohort_value) || cohort_value.empty())
177 return "";
178 // This is a sanity check to avoid sending a huge XML file back to Ohama due
179 // to a compromised stateful partition making the update check fail in low
180 // network environments envent after a reboot.
181 if (cohort_value.size() > 1024) {
182 LOG(WARNING) << "The omaha cohort setting " << arg_name
183 << " has a too big value, which must be an error or an "
184 "attacker trying to inhibit updates.";
185 return "";
186 }
187
Alex Deymob0d74eb2015-03-30 17:59:17 -0700188 string escaped_xml_value;
189 if (!XmlEncode(cohort_value, &escaped_xml_value)) {
190 LOG(WARNING) << "The omaha cohort setting " << arg_name
191 << " is ASCII-7 invalid, ignoring it.";
192 return "";
193 }
194
Alex Deymo8e18f932015-03-27 16:16:59 -0700195 return base::StringPrintf("%s=\"%s\" ",
Alex Deymob0d74eb2015-03-30 17:59:17 -0700196 arg_name.c_str(), escaped_xml_value.c_str());
Alex Deymo8e18f932015-03-27 16:16:59 -0700197}
198
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700199// Returns an XML that corresponds to the entire <app> node of the Omaha
200// request based on the given parameters.
201string GetAppXml(const OmahaEvent* event,
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700202 OmahaRequestParams* params,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700203 bool ping_only,
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700204 bool include_ping,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700205 int ping_active_days,
206 int ping_roll_call_days,
David Zeuthen639aa362014-02-03 16:23:44 -0800207 int install_date_in_days,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700208 SystemState* system_state) {
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700209 string app_body = GetAppBody(event, params, ping_only, include_ping,
210 ping_active_days, ping_roll_call_days,
211 system_state->prefs());
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700212 string app_versions;
213
214 // If we are upgrading to a more stable channel and we are allowed to do
215 // powerwash, then pass 0.0.0.0 as the version. This is needed to get the
216 // highest-versioned payload on the destination channel.
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700217 if (params->to_more_stable_channel() && params->is_powerwash_allowed()) {
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700218 LOG(INFO) << "Passing OS version as 0.0.0.0 as we are set to powerwash "
219 << "on downgrading to the version in the more stable channel";
220 app_versions = "version=\"0.0.0.0\" from_version=\"" +
Alex Deymob0d74eb2015-03-30 17:59:17 -0700221 XmlEncodeWithDefault(params->app_version(), "0.0.0.0") + "\" ";
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700222 } else {
Alex Deymob0d74eb2015-03-30 17:59:17 -0700223 app_versions = "version=\"" +
224 XmlEncodeWithDefault(params->app_version(), "0.0.0.0") + "\" ";
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700225 }
226
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700227 string download_channel = params->download_channel();
Alex Deymob0d74eb2015-03-30 17:59:17 -0700228 string app_channels =
229 "track=\"" + XmlEncodeWithDefault(download_channel, "") + "\" ";
230 if (params->current_channel() != download_channel) {
231 app_channels += "from_track=\"" + XmlEncodeWithDefault(
232 params->current_channel(), "") + "\" ";
233 }
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700234
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700235 string delta_okay_str = params->delta_okay() ? "true" : "false";
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700236
David Zeuthen639aa362014-02-03 16:23:44 -0800237 // If install_date_days is not set (e.g. its value is -1 ), don't
238 // include the attribute.
239 string install_date_in_days_str = "";
240 if (install_date_in_days >= 0) {
Alex Vakulenko75039d72014-03-25 12:36:28 -0700241 install_date_in_days_str = base::StringPrintf("installdate=\"%d\" ",
242 install_date_in_days);
David Zeuthen639aa362014-02-03 16:23:44 -0800243 }
244
Alex Deymo8e18f932015-03-27 16:16:59 -0700245 string app_cohort_args;
246 app_cohort_args += GetCohortArgXml(system_state->prefs(),
247 "cohort", kPrefsOmahaCohort);
248 app_cohort_args += GetCohortArgXml(system_state->prefs(),
249 "cohorthint", kPrefsOmahaCohortHint);
250 app_cohort_args += GetCohortArgXml(system_state->prefs(),
251 "cohortname", kPrefsOmahaCohortName);
252
Alex Deymob0d74eb2015-03-30 17:59:17 -0700253 string app_xml = " <app "
254 "appid=\"" + XmlEncodeWithDefault(params->GetAppId(), "") + "\" " +
255 app_cohort_args +
256 app_versions +
257 app_channels +
258 "lang=\"" + XmlEncodeWithDefault(params->app_lang(), "en-US") + "\" " +
259 "board=\"" + XmlEncodeWithDefault(params->os_board(), "") + "\" " +
260 "hardware_class=\"" + XmlEncodeWithDefault(params->hwid(), "") + "\" " +
261 "delta_okay=\"" + delta_okay_str + "\" "
262 "fw_version=\"" + XmlEncodeWithDefault(params->fw_version(), "") + "\" " +
263 "ec_version=\"" + XmlEncodeWithDefault(params->ec_version(), "") + "\" " +
264 install_date_in_days_str +
265 ">\n" +
266 app_body +
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700267 " </app>\n";
268
269 return app_xml;
270}
271
272// Returns an XML that corresponds to the entire <os> node of the Omaha
273// request based on the given parameters.
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700274string GetOsXml(OmahaRequestParams* params) {
Alex Deymob0d74eb2015-03-30 17:59:17 -0700275 string os_xml =" <os "
276 "version=\"" + XmlEncodeWithDefault(params->os_version(), "") + "\" " +
277 "platform=\"" + XmlEncodeWithDefault(params->os_platform(), "") + "\" " +
278 "sp=\"" + XmlEncodeWithDefault(params->os_sp(), "") + "\">"
279 "</os>\n";
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700280 return os_xml;
281}
282
283// Returns an XML that corresponds to the entire Omaha request based on the
284// given parameters.
285string GetRequestXml(const OmahaEvent* event,
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700286 OmahaRequestParams* params,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700287 bool ping_only,
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700288 bool include_ping,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700289 int ping_active_days,
290 int ping_roll_call_days,
David Zeuthen639aa362014-02-03 16:23:44 -0800291 int install_date_in_days,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700292 SystemState* system_state) {
293 string os_xml = GetOsXml(params);
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700294 string app_xml = GetAppXml(event, params, ping_only, include_ping,
295 ping_active_days, ping_roll_call_days,
296 install_date_in_days, system_state);
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700297
Alex Vakulenko75039d72014-03-25 12:36:28 -0700298 string install_source = base::StringPrintf("installsource=\"%s\" ",
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700299 (params->interactive() ? "ondemandupdate" : "scheduler"));
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700300
Alex Deymoac41a822015-09-15 20:52:53 -0700301 string updater_version = XmlEncodeWithDefault(
302 base::StringPrintf("%s-%s",
303 constants::kOmahaUpdaterID,
304 kOmahaUpdaterVersion), "");
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700305 string request_xml =
306 "<?xml version=\"1.0\" encoding=\"UTF-8\"?>\n"
Alex Deymob0d74eb2015-03-30 17:59:17 -0700307 "<request protocol=\"3.0\" " + (
Alex Deymoac41a822015-09-15 20:52:53 -0700308 "version=\"" + updater_version + "\" "
309 "updaterversion=\"" + updater_version + "\" " +
Alex Deymob0d74eb2015-03-30 17:59:17 -0700310 install_source +
311 "ismachine=\"1\">\n") +
312 os_xml +
313 app_xml +
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700314 "</request>\n";
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700315
316 return request_xml;
rspangler@google.com49fdf182009-10-10 00:57:34 +0000317}
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700318
Alex Vakulenkod2779df2014-06-16 13:19:00 -0700319} // namespace
rspangler@google.com49fdf182009-10-10 00:57:34 +0000320
David Zeuthene8ed8632014-07-24 13:38:10 -0400321// Struct used for holding data obtained when parsing the XML.
322struct OmahaParserData {
David Zeuthenf3e28012014-08-26 18:23:52 -0400323 explicit OmahaParserData(XML_Parser _xml_parser) : xml_parser(_xml_parser) {}
324
325 // Pointer to the expat XML_Parser object.
326 XML_Parser xml_parser;
327
David Zeuthene8ed8632014-07-24 13:38:10 -0400328 // This is the state of the parser as it's processing the XML.
329 bool failed = false;
David Zeuthenf3e28012014-08-26 18:23:52 -0400330 bool entity_decl = false;
David Zeuthene8ed8632014-07-24 13:38:10 -0400331 string current_path;
332
333 // These are the values extracted from the XML.
Alex Deymo8e18f932015-03-27 16:16:59 -0700334 string app_cohort;
335 string app_cohorthint;
336 string app_cohortname;
337 bool app_cohort_set = false;
338 bool app_cohorthint_set = false;
339 bool app_cohortname_set = false;
David Zeuthene8ed8632014-07-24 13:38:10 -0400340 string updatecheck_status;
341 string updatecheck_poll_interval;
342 string daystart_elapsed_days;
343 string daystart_elapsed_seconds;
344 vector<string> url_codebase;
345 string package_name;
346 string package_size;
347 string manifest_version;
348 map<string, string> action_postinstall_attrs;
349};
350
351namespace {
352
353// Callback function invoked by expat.
354void ParserHandlerStart(void* user_data, const XML_Char* element,
355 const XML_Char** attr) {
356 OmahaParserData* data = reinterpret_cast<OmahaParserData*>(user_data);
357
358 if (data->failed)
359 return;
360
361 data->current_path += string("/") + element;
362
363 map<string, string> attrs;
364 if (attr != nullptr) {
365 for (int n = 0; attr[n] != nullptr && attr[n+1] != nullptr; n += 2) {
366 string key = attr[n];
367 string value = attr[n + 1];
368 attrs[key] = value;
369 }
370 }
371
Alex Deymo8e18f932015-03-27 16:16:59 -0700372 if (data->current_path == "/response/app") {
373 if (attrs.find("cohort") != attrs.end()) {
374 data->app_cohort_set = true;
375 data->app_cohort = attrs["cohort"];
376 }
377 if (attrs.find("cohorthint") != attrs.end()) {
378 data->app_cohorthint_set = true;
379 data->app_cohorthint = attrs["cohorthint"];
380 }
381 if (attrs.find("cohortname") != attrs.end()) {
382 data->app_cohortname_set = true;
383 data->app_cohortname = attrs["cohortname"];
384 }
385 } else if (data->current_path == "/response/app/updatecheck") {
David Zeuthene8ed8632014-07-24 13:38:10 -0400386 // There is only supposed to be a single <updatecheck> element.
387 data->updatecheck_status = attrs["status"];
388 data->updatecheck_poll_interval = attrs["PollInterval"];
389 } else if (data->current_path == "/response/daystart") {
390 // Get the install-date.
391 data->daystart_elapsed_days = attrs["elapsed_days"];
392 data->daystart_elapsed_seconds = attrs["elapsed_seconds"];
393 } else if (data->current_path == "/response/app/updatecheck/urls/url") {
394 // Look at all <url> elements.
395 data->url_codebase.push_back(attrs["codebase"]);
396 } else if (data->package_name.empty() && data->current_path ==
397 "/response/app/updatecheck/manifest/packages/package") {
398 // Only look at the first <package>.
399 data->package_name = attrs["name"];
400 data->package_size = attrs["size"];
401 } else if (data->current_path == "/response/app/updatecheck/manifest") {
402 // Get the version.
403 data->manifest_version = attrs[kTagVersion];
404 } else if (data->current_path ==
405 "/response/app/updatecheck/manifest/actions/action") {
406 // We only care about the postinstall action.
407 if (attrs["event"] == "postinstall") {
408 data->action_postinstall_attrs = attrs;
409 }
410 }
411}
412
413// Callback function invoked by expat.
414void ParserHandlerEnd(void* user_data, const XML_Char* element) {
415 OmahaParserData* data = reinterpret_cast<OmahaParserData*>(user_data);
416 if (data->failed)
417 return;
418
419 const string path_suffix = string("/") + element;
420
Alex Vakulenko0103c362016-01-20 07:56:15 -0800421 if (!base::EndsWith(data->current_path, path_suffix,
422 base::CompareCase::SENSITIVE)) {
David Zeuthene8ed8632014-07-24 13:38:10 -0400423 LOG(ERROR) << "Unexpected end element '" << element
424 << "' with current_path='" << data->current_path << "'";
425 data->failed = true;
426 return;
427 }
428 data->current_path.resize(data->current_path.size() - path_suffix.size());
429}
430
David Zeuthenf3e28012014-08-26 18:23:52 -0400431// Callback function invoked by expat.
432//
433// This is called for entity declarations. Since Omaha is guaranteed
434// to never return any XML with entities our course of action is to
435// just stop parsing. This avoids potential resource exhaustion
436// problems AKA the "billion laughs". CVE-2013-0340.
437void ParserHandlerEntityDecl(void *user_data,
438 const XML_Char *entity_name,
439 int is_parameter_entity,
440 const XML_Char *value,
441 int value_length,
442 const XML_Char *base,
443 const XML_Char *system_id,
444 const XML_Char *public_id,
445 const XML_Char *notation_name) {
446 OmahaParserData* data = reinterpret_cast<OmahaParserData*>(user_data);
447
448 LOG(ERROR) << "XML entities are not supported. Aborting parsing.";
449 data->failed = true;
450 data->entity_decl = true;
451 XML_StopParser(data->xml_parser, false);
452}
453
David Zeuthene8ed8632014-07-24 13:38:10 -0400454} // namespace
455
Alex Deymob0d74eb2015-03-30 17:59:17 -0700456bool XmlEncode(const string& input, string* output) {
457 if (std::find_if(input.begin(), input.end(),
458 [](const char c){return c & 0x80;}) != input.end()) {
459 LOG(WARNING) << "Invalid ASCII-7 string passed to the XML encoder:";
460 utils::HexDumpString(input);
461 return false;
462 }
Alex Deymocc457852015-06-18 18:35:50 -0700463 output->clear();
464 // We need at least input.size() space in the output, but the code below will
465 // handle it if we need more.
466 output->reserve(input.size());
467 for (char c : input) {
468 switch (c) {
469 case '\"':
470 output->append("&quot;");
471 break;
472 case '\'':
473 output->append("&apos;");
474 break;
475 case '&':
476 output->append("&amp;");
477 break;
478 case '<':
479 output->append("&lt;");
480 break;
481 case '>':
482 output->append("&gt;");
483 break;
484 default:
485 output->push_back(c);
486 }
487 }
Alex Deymob0d74eb2015-03-30 17:59:17 -0700488 return true;
489}
490
491string XmlEncodeWithDefault(const string& input, const string& default_value) {
492 string output;
493 if (XmlEncode(input, &output))
494 return output;
495 return default_value;
rspangler@google.com49fdf182009-10-10 00:57:34 +0000496}
497
Alex Deymoc1c17b42015-11-23 03:53:15 -0300498OmahaRequestAction::OmahaRequestAction(
499 SystemState* system_state,
500 OmahaEvent* event,
501 std::unique_ptr<HttpFetcher> http_fetcher,
502 bool ping_only)
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800503 : system_state_(system_state),
Darin Petkova4a8a8c2010-07-15 22:21:12 -0700504 event_(event),
Alex Deymoc1c17b42015-11-23 03:53:15 -0300505 http_fetcher_(std::move(http_fetcher)),
Thieu Le116fda32011-04-19 11:01:54 -0700506 ping_only_(ping_only),
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700507 ping_active_days_(0),
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700508 ping_roll_call_days_(0) {
509 params_ = system_state->request_params();
510}
rspangler@google.com49fdf182009-10-10 00:57:34 +0000511
Darin Petkov6a5b3222010-07-13 14:55:28 -0700512OmahaRequestAction::~OmahaRequestAction() {}
rspangler@google.com49fdf182009-10-10 00:57:34 +0000513
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700514// Calculates the value to use for the ping days parameter.
515int OmahaRequestAction::CalculatePingDays(const string& key) {
516 int days = kNeverPinged;
517 int64_t last_ping = 0;
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800518 if (system_state_->prefs()->GetInt64(key, &last_ping) && last_ping >= 0) {
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700519 days = (Time::Now() - Time::FromInternalValue(last_ping)).InDays();
520 if (days < 0) {
521 // If |days| is negative, then the system clock must have jumped
522 // back in time since the ping was sent. Mark the value so that
523 // it doesn't get sent to the server but we still update the
524 // last ping daystart preference. This way the next ping time
525 // will be correct, hopefully.
526 days = kPingTimeJump;
527 LOG(WARNING) <<
528 "System clock jumped back in time. Resetting ping daystarts.";
529 }
530 }
531 return days;
532}
533
534void OmahaRequestAction::InitPingDays() {
535 // We send pings only along with update checks, not with events.
536 if (IsEvent()) {
537 return;
538 }
539 // TODO(petkov): Figure a way to distinguish active use pings
540 // vs. roll call pings. Currently, the two pings are identical. A
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700541 // fix needs to change this code as well as UpdateLastPingDays and ShouldPing.
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700542 ping_active_days_ = CalculatePingDays(kPrefsLastActivePingDay);
543 ping_roll_call_days_ = CalculatePingDays(kPrefsLastRollCallPingDay);
544}
545
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700546bool OmahaRequestAction::ShouldPing() const {
547 if (ping_active_days_ == OmahaRequestAction::kNeverPinged &&
548 ping_roll_call_days_ == OmahaRequestAction::kNeverPinged) {
549 int powerwash_count = system_state_->hardware()->GetPowerwashCount();
550 if (powerwash_count > 0) {
551 LOG(INFO) << "Not sending ping with a=-1 r=-1 to omaha because "
552 << "powerwash_count is " << powerwash_count;
553 return false;
554 }
555 return true;
556 }
557 return ping_active_days_ > 0 || ping_roll_call_days_ > 0;
558}
559
David Zeuthen639aa362014-02-03 16:23:44 -0800560// static
561int OmahaRequestAction::GetInstallDate(SystemState* system_state) {
562 PrefsInterface* prefs = system_state->prefs();
Alex Vakulenko88b591f2014-08-28 16:48:57 -0700563 if (prefs == nullptr)
David Zeuthen639aa362014-02-03 16:23:44 -0800564 return -1;
565
566 // If we have the value stored on disk, just return it.
567 int64_t stored_value;
568 if (prefs->GetInt64(kPrefsInstallDateDays, &stored_value)) {
569 // Convert and sanity-check.
570 int install_date_days = static_cast<int>(stored_value);
571 if (install_date_days >= 0)
572 return install_date_days;
573 LOG(ERROR) << "Dropping stored Omaha InstallData since its value num_days="
574 << install_date_days << " looks suspicious.";
575 prefs->Delete(kPrefsInstallDateDays);
576 }
577
578 // Otherwise, if OOBE is not complete then do nothing and wait for
579 // ParseResponse() to call ParseInstallDate() and then
580 // PersistInstallDate() to set the kPrefsInstallDateDays state
581 // variable. Once that is done, we'll then report back in future
582 // Omaha requests. This works exactly because OOBE triggers an
583 // update check.
584 //
585 // However, if OOBE is complete and the kPrefsInstallDateDays state
586 // variable is not set, there are two possibilities
587 //
588 // 1. The update check in OOBE failed so we never got a response
589 // from Omaha (no network etc.); or
590 //
591 // 2. OOBE was done on an older version that didn't write to the
592 // kPrefsInstallDateDays state variable.
593 //
594 // In both cases, we approximate the install date by simply
595 // inspecting the timestamp of when OOBE happened.
596
597 Time time_of_oobe;
Alex Deymobccbc382014-04-03 13:38:55 -0700598 if (!system_state->hardware()->IsOOBEComplete(&time_of_oobe)) {
David Zeuthen639aa362014-02-03 16:23:44 -0800599 LOG(INFO) << "Not generating Omaha InstallData as we have "
600 << "no prefs file and OOBE is not complete.";
601 return -1;
602 }
603
604 int num_days;
605 if (!utils::ConvertToOmahaInstallDate(time_of_oobe, &num_days)) {
606 LOG(ERROR) << "Not generating Omaha InstallData from time of OOBE "
607 << "as its value '" << utils::ToString(time_of_oobe)
608 << "' looks suspicious.";
609 return -1;
610 }
611
612 // Persist this to disk, for future use.
613 if (!OmahaRequestAction::PersistInstallDate(system_state,
614 num_days,
615 kProvisionedFromOOBEMarker))
616 return -1;
617
618 LOG(INFO) << "Set the Omaha InstallDate from OOBE time-stamp to "
619 << num_days << " days";
620
621 return num_days;
622}
623
Darin Petkov6a5b3222010-07-13 14:55:28 -0700624void OmahaRequestAction::PerformAction() {
rspangler@google.com49fdf182009-10-10 00:57:34 +0000625 http_fetcher_->set_delegate(this);
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700626 InitPingDays();
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700627 if (ping_only_ && !ShouldPing()) {
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700628 processor_->ActionComplete(this, ErrorCode::kSuccess);
Thieu Leb44e9e82011-06-06 14:34:04 -0700629 return;
630 }
David Zeuthen639aa362014-02-03 16:23:44 -0800631
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700632 string request_post(GetRequestXml(event_.get(),
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700633 params_,
Thieu Le116fda32011-04-19 11:01:54 -0700634 ping_only_,
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700635 ShouldPing(), // include_ping
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700636 ping_active_days_,
Darin Petkov95508da2011-01-05 12:42:29 -0800637 ping_roll_call_days_,
David Zeuthen639aa362014-02-03 16:23:44 -0800638 GetInstallDate(system_state_),
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700639 system_state_));
Jay Srinivasan0a708742012-03-20 11:26:12 -0700640
Gilad Arnold9dd1e7c2012-02-16 12:13:36 -0800641 http_fetcher_->SetPostData(request_post.data(), request_post.size(),
642 kHttpContentTypeTextXml);
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700643 LOG(INFO) << "Posting an Omaha request to " << params_->update_url();
Andrew de los Reyesf98bff82010-05-06 13:33:25 -0700644 LOG(INFO) << "Request: " << request_post;
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700645 http_fetcher_->BeginTransfer(params_->update_url());
rspangler@google.com49fdf182009-10-10 00:57:34 +0000646}
647
Darin Petkov6a5b3222010-07-13 14:55:28 -0700648void OmahaRequestAction::TerminateProcessing() {
rspangler@google.com49fdf182009-10-10 00:57:34 +0000649 http_fetcher_->TerminateTransfer();
650}
651
652// We just store the response in the buffer. Once we've received all bytes,
653// we'll look in the buffer and decide what to do.
Darin Petkov6a5b3222010-07-13 14:55:28 -0700654void OmahaRequestAction::ReceivedBytes(HttpFetcher *fetcher,
Alex Vakulenkof68bbbc2015-02-09 12:53:18 -0800655 const void* bytes,
656 size_t length) {
657 const uint8_t* byte_ptr = reinterpret_cast<const uint8_t*>(bytes);
658 response_buffer_.insert(response_buffer_.end(), byte_ptr, byte_ptr + length);
rspangler@google.com49fdf182009-10-10 00:57:34 +0000659}
660
661namespace {
rspangler@google.com49fdf182009-10-10 00:57:34 +0000662
663// Parses a 64 bit base-10 int from a string and returns it. Returns 0
664// on error. If the string contains "0", that's indistinguishable from
665// error.
666off_t ParseInt(const string& str) {
667 off_t ret = 0;
Gilad Arnoldec7f9162014-07-15 13:24:46 -0700668 int rc = sscanf(str.c_str(), "%" PRIi64, &ret); // NOLINT(runtime/printf)
rspangler@google.com49fdf182009-10-10 00:57:34 +0000669 if (rc < 1) {
670 // failure
671 return 0;
672 }
673 return ret;
674}
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700675
David Zeuthene8ed8632014-07-24 13:38:10 -0400676// Parses |str| and returns |true| if, and only if, its value is "true".
677bool ParseBool(const string& str) {
678 return str == "true";
679}
680
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700681// Update the last ping day preferences based on the server daystart
682// response. Returns true on success, false otherwise.
David Zeuthene8ed8632014-07-24 13:38:10 -0400683bool UpdateLastPingDays(OmahaParserData *parser_data, PrefsInterface* prefs) {
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700684 int64_t elapsed_seconds = 0;
David Zeuthene8ed8632014-07-24 13:38:10 -0400685 TEST_AND_RETURN_FALSE(
686 base::StringToInt64(parser_data->daystart_elapsed_seconds,
687 &elapsed_seconds));
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700688 TEST_AND_RETURN_FALSE(elapsed_seconds >= 0);
689
690 // Remember the local time that matches the server's last midnight
691 // time.
692 Time daystart = Time::Now() - TimeDelta::FromSeconds(elapsed_seconds);
693 prefs->SetInt64(kPrefsLastActivePingDay, daystart.ToInternalValue());
694 prefs->SetInt64(kPrefsLastRollCallPingDay, daystart.ToInternalValue());
695 return true;
696}
Alex Vakulenkod2779df2014-06-16 13:19:00 -0700697} // namespace
rspangler@google.com49fdf182009-10-10 00:57:34 +0000698
David Zeuthene8ed8632014-07-24 13:38:10 -0400699bool OmahaRequestAction::ParseResponse(OmahaParserData* parser_data,
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700700 OmahaResponse* output_object,
701 ScopedActionCompleter* completer) {
David Zeuthene8ed8632014-07-24 13:38:10 -0400702 if (parser_data->updatecheck_status.empty()) {
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700703 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700704 return false;
705 }
706
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800707 // chromium-os:37289: The PollInterval is not supported by Omaha server
708 // currently. But still keeping this existing code in case we ever decide to
Gilad Arnoldec7f9162014-07-15 13:24:46 -0700709 // slow down the request rate from the server-side. Note that the PollInterval
710 // is not persisted, so it has to be sent by the server on every response to
711 // guarantee that the scheduler uses this value (otherwise, if the device got
712 // rebooted after the last server-indicated value, it'll revert to the default
713 // value). Also kDefaultMaxUpdateChecks value for the scattering logic is
714 // based on the assumption that we perform an update check every hour so that
715 // the max value of 8 will roughly be equivalent to one work day. If we decide
716 // to use PollInterval permanently, we should update the
717 // max_update_checks_allowed to take PollInterval into account. Note: The
718 // parsing for PollInterval happens even before parsing of the status because
719 // we may want to specify the PollInterval even when there's no update.
David Zeuthene8ed8632014-07-24 13:38:10 -0400720 base::StringToInt(parser_data->updatecheck_poll_interval,
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700721 &output_object->poll_interval);
722
David Zeuthen639aa362014-02-03 16:23:44 -0800723 // Check for the "elapsed_days" attribute in the "daystart"
724 // element. This is the number of days since Jan 1 2007, 0:00
725 // PST. If we don't have a persisted value of the Omaha InstallDate,
726 // we'll use it to calculate it and then persist it.
David Zeuthene8ed8632014-07-24 13:38:10 -0400727 if (ParseInstallDate(parser_data, output_object) &&
728 !HasInstallDate(system_state_)) {
David Zeuthen639aa362014-02-03 16:23:44 -0800729 // Since output_object->install_date_days is never negative, the
730 // elapsed_days -> install-date calculation is reduced to simply
731 // rounding down to the nearest number divisible by 7.
732 int remainder = output_object->install_date_days % 7;
733 int install_date_days_rounded =
734 output_object->install_date_days - remainder;
735 if (PersistInstallDate(system_state_,
736 install_date_days_rounded,
737 kProvisionedFromOmahaResponse)) {
738 LOG(INFO) << "Set the Omaha InstallDate from Omaha Response to "
739 << install_date_days_rounded << " days";
740 }
741 }
742
Alex Deymo00d79ac2015-06-29 15:41:49 -0700743 // We persist the cohorts sent by omaha even if the status is "noupdate".
744 if (parser_data->app_cohort_set)
745 PersistCohortData(kPrefsOmahaCohort, parser_data->app_cohort);
746 if (parser_data->app_cohorthint_set)
747 PersistCohortData(kPrefsOmahaCohortHint, parser_data->app_cohorthint);
748 if (parser_data->app_cohortname_set)
749 PersistCohortData(kPrefsOmahaCohortName, parser_data->app_cohortname);
750
David Zeuthene8ed8632014-07-24 13:38:10 -0400751 if (!ParseStatus(parser_data, output_object, completer))
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700752 return false;
753
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800754 // Note: ParseUrls MUST be called before ParsePackage as ParsePackage
755 // appends the package name to the URLs populated in this method.
David Zeuthene8ed8632014-07-24 13:38:10 -0400756 if (!ParseUrls(parser_data, output_object, completer))
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700757 return false;
758
David Zeuthene8ed8632014-07-24 13:38:10 -0400759 if (!ParsePackage(parser_data, output_object, completer))
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700760 return false;
761
David Zeuthene8ed8632014-07-24 13:38:10 -0400762 if (!ParseParams(parser_data, output_object, completer))
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700763 return false;
764
765 return true;
766}
767
David Zeuthene8ed8632014-07-24 13:38:10 -0400768bool OmahaRequestAction::ParseStatus(OmahaParserData* parser_data,
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700769 OmahaResponse* output_object,
770 ScopedActionCompleter* completer) {
David Zeuthene8ed8632014-07-24 13:38:10 -0400771 const string& status = parser_data->updatecheck_status;
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700772 if (status == "noupdate") {
773 LOG(INFO) << "No update.";
774 output_object->update_exists = false;
775 SetOutputObject(*output_object);
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700776 completer->set_code(ErrorCode::kSuccess);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700777 return false;
778 }
779
780 if (status != "ok") {
781 LOG(ERROR) << "Unknown Omaha response status: " << status;
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700782 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700783 return false;
784 }
785
786 return true;
787}
788
David Zeuthene8ed8632014-07-24 13:38:10 -0400789bool OmahaRequestAction::ParseUrls(OmahaParserData* parser_data,
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700790 OmahaResponse* output_object,
791 ScopedActionCompleter* completer) {
David Zeuthene8ed8632014-07-24 13:38:10 -0400792 if (parser_data->url_codebase.empty()) {
793 LOG(ERROR) << "No Omaha Response URLs";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700794 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700795 return false;
796 }
797
David Zeuthene8ed8632014-07-24 13:38:10 -0400798 LOG(INFO) << "Found " << parser_data->url_codebase.size() << " url(s)";
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800799 output_object->payload_urls.clear();
David Zeuthene8ed8632014-07-24 13:38:10 -0400800 for (const auto& codebase : parser_data->url_codebase) {
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800801 if (codebase.empty()) {
802 LOG(ERROR) << "Omaha Response URL has empty codebase";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700803 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800804 return false;
805 }
806 output_object->payload_urls.push_back(codebase);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700807 }
808
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700809 return true;
810}
811
David Zeuthene8ed8632014-07-24 13:38:10 -0400812bool OmahaRequestAction::ParsePackage(OmahaParserData* parser_data,
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700813 OmahaResponse* output_object,
814 ScopedActionCompleter* completer) {
David Zeuthene8ed8632014-07-24 13:38:10 -0400815 if (parser_data->package_name.empty()) {
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700816 LOG(ERROR) << "Omaha Response has empty package name";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700817 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700818 return false;
819 }
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800820
821 // Append the package name to each URL in our list so that we don't
822 // propagate the urlBase vs packageName distinctions beyond this point.
823 // From now on, we only need to use payload_urls.
David Zeuthene8ed8632014-07-24 13:38:10 -0400824 for (auto& payload_url : output_object->payload_urls)
825 payload_url += parser_data->package_name;
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700826
827 // Parse the payload size.
David Zeuthene8ed8632014-07-24 13:38:10 -0400828 off_t size = ParseInt(parser_data->package_size);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700829 if (size <= 0) {
830 LOG(ERROR) << "Omaha Response has invalid payload size: " << size;
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700831 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700832 return false;
833 }
834 output_object->size = size;
835
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800836 LOG(INFO) << "Payload size = " << output_object->size << " bytes";
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700837
838 return true;
839}
840
David Zeuthene8ed8632014-07-24 13:38:10 -0400841bool OmahaRequestAction::ParseParams(OmahaParserData* parser_data,
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700842 OmahaResponse* output_object,
843 ScopedActionCompleter* completer) {
David Zeuthene8ed8632014-07-24 13:38:10 -0400844 output_object->version = parser_data->manifest_version;
Chris Sosa3b748432013-06-20 16:42:59 -0700845 if (output_object->version.empty()) {
Chris Sosaaa18e162013-06-20 13:20:30 -0700846 LOG(ERROR) << "Omaha Response does not have version in manifest!";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700847 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Chris Sosa3b748432013-06-20 16:42:59 -0700848 return false;
849 }
850
851 LOG(INFO) << "Received omaha response to update to version "
852 << output_object->version;
853
David Zeuthene8ed8632014-07-24 13:38:10 -0400854 map<string, string> attrs = parser_data->action_postinstall_attrs;
855 if (attrs.empty()) {
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700856 LOG(ERROR) << "Omaha Response has no postinstall event action";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700857 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700858 return false;
859 }
860
David Zeuthene8ed8632014-07-24 13:38:10 -0400861 output_object->hash = attrs[kTagSha256];
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700862 if (output_object->hash.empty()) {
863 LOG(ERROR) << "Omaha Response has empty sha256 value";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700864 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700865 return false;
866 }
867
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800868 // Get the optional properties one by one.
David Zeuthene8ed8632014-07-24 13:38:10 -0400869 output_object->more_info_url = attrs[kTagMoreInfo];
870 output_object->metadata_size = ParseInt(attrs[kTagMetadataSize]);
871 output_object->metadata_signature = attrs[kTagMetadataSignatureRsa];
872 output_object->prompt = ParseBool(attrs[kTagPrompt]);
873 output_object->deadline = attrs[kTagDeadline];
874 output_object->max_days_to_scatter = ParseInt(attrs[kTagMaxDaysToScatter]);
David Zeuthen8f191b22013-08-06 12:27:50 -0700875 output_object->disable_p2p_for_downloading =
David Zeuthene8ed8632014-07-24 13:38:10 -0400876 ParseBool(attrs[kTagDisableP2PForDownloading]);
David Zeuthen8f191b22013-08-06 12:27:50 -0700877 output_object->disable_p2p_for_sharing =
David Zeuthene8ed8632014-07-24 13:38:10 -0400878 ParseBool(attrs[kTagDisableP2PForSharing]);
879 output_object->public_key_rsa = attrs[kTagPublicKeyRsa];
Jay Srinivasan2b5a0f02012-12-19 17:25:56 -0800880
David Zeuthene8ed8632014-07-24 13:38:10 -0400881 string max = attrs[kTagMaxFailureCountPerUrl];
Jay Srinivasan08262882012-12-28 19:29:43 -0800882 if (!base::StringToUint(max, &output_object->max_failure_count_per_url))
Jay Srinivasan2b5a0f02012-12-19 17:25:56 -0800883 output_object->max_failure_count_per_url = kDefaultMaxFailureCountPerUrl;
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700884
David Zeuthene8ed8632014-07-24 13:38:10 -0400885 output_object->is_delta_payload = ParseBool(attrs[kTagIsDeltaPayload]);
Jay Srinivasan08262882012-12-28 19:29:43 -0800886
887 output_object->disable_payload_backoff =
David Zeuthene8ed8632014-07-24 13:38:10 -0400888 ParseBool(attrs[kTagDisablePayloadBackoff]);
Jay Srinivasan08262882012-12-28 19:29:43 -0800889
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700890 return true;
891}
892
David Zeuthene8ed8632014-07-24 13:38:10 -0400893// If the transfer was successful, this uses expat to parse the response
rspangler@google.com49fdf182009-10-10 00:57:34 +0000894// and fill in the appropriate fields of the output object. Also, notifies
895// the processor that we're done.
Darin Petkov6a5b3222010-07-13 14:55:28 -0700896void OmahaRequestAction::TransferComplete(HttpFetcher *fetcher,
897 bool successful) {
rspangler@google.com49fdf182009-10-10 00:57:34 +0000898 ScopedActionCompleter completer(processor_, this);
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800899 string current_response(response_buffer_.begin(), response_buffer_.end());
900 LOG(INFO) << "Omaha request response: " << current_response;
Darin Petkov0dc8e9a2010-07-14 14:51:57 -0700901
Gilad Arnold74b5f552014-10-07 08:17:16 -0700902 PayloadStateInterface* const payload_state = system_state_->payload_state();
903
Darin Petkov0dc8e9a2010-07-14 14:51:57 -0700904 // Events are best effort transactions -- assume they always succeed.
905 if (IsEvent()) {
906 CHECK(!HasOutputPipe()) << "No output pipe allowed for event requests.";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700907 completer.set_code(ErrorCode::kSuccess);
Darin Petkov0dc8e9a2010-07-14 14:51:57 -0700908 return;
909 }
910
Andrew de los Reyesf98bff82010-05-06 13:33:25 -0700911 if (!successful) {
Darin Petkov0dc8e9a2010-07-14 14:51:57 -0700912 LOG(ERROR) << "Omaha request network transfer failed.";
Darin Petkovedc522e2010-11-05 09:35:17 -0700913 int code = GetHTTPResponseCode();
914 // Makes sure we send sane error values.
915 if (code < 0 || code >= 1000) {
916 code = 999;
917 }
David Zeuthena99981f2013-04-29 13:42:47 -0700918 completer.set_code(static_cast<ErrorCode>(
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700919 static_cast<int>(ErrorCode::kOmahaRequestHTTPResponseBase) + code));
rspangler@google.com49fdf182009-10-10 00:57:34 +0000920 return;
Andrew de los Reyesf98bff82010-05-06 13:33:25 -0700921 }
rspangler@google.com49fdf182009-10-10 00:57:34 +0000922
David Zeuthene8ed8632014-07-24 13:38:10 -0400923 XML_Parser parser = XML_ParserCreate(nullptr);
David Zeuthenf3e28012014-08-26 18:23:52 -0400924 OmahaParserData parser_data(parser);
David Zeuthene8ed8632014-07-24 13:38:10 -0400925 XML_SetUserData(parser, &parser_data);
926 XML_SetElementHandler(parser, ParserHandlerStart, ParserHandlerEnd);
David Zeuthenf3e28012014-08-26 18:23:52 -0400927 XML_SetEntityDeclHandler(parser, ParserHandlerEntityDecl);
Alex Vakulenkof68bbbc2015-02-09 12:53:18 -0800928 XML_Status res = XML_Parse(
929 parser,
930 reinterpret_cast<const char*>(response_buffer_.data()),
931 response_buffer_.size(),
932 XML_TRUE);
David Zeuthene8ed8632014-07-24 13:38:10 -0400933 XML_ParserFree(parser);
934
935 if (res != XML_STATUS_OK || parser_data.failed) {
Alex Deymoa9bb7dc2015-06-19 09:50:23 -0700936 LOG(ERROR) << "Omaha response not valid XML: "
937 << XML_ErrorString(XML_GetErrorCode(parser))
938 << " at line " << XML_GetCurrentLineNumber(parser)
939 << " col " << XML_GetCurrentColumnNumber(parser);
David Zeuthenf3e28012014-08-26 18:23:52 -0400940 ErrorCode error_code = ErrorCode::kOmahaRequestXMLParseError;
941 if (response_buffer_.empty()) {
942 error_code = ErrorCode::kOmahaRequestEmptyResponseError;
943 } else if (parser_data.entity_decl) {
944 error_code = ErrorCode::kOmahaRequestXMLHasEntityDecl;
945 }
946 completer.set_code(error_code);
rspangler@google.com49fdf182009-10-10 00:57:34 +0000947 return;
948 }
949
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700950 // Update the last ping day preferences based on the server daystart response
951 // even if we didn't send a ping. Omaha always includes the daystart in the
952 // response, but log the error if it didn't.
953 LOG_IF(ERROR, !UpdateLastPingDays(&parser_data, system_state_->prefs()))
954 << "Failed to update the last ping day preferences!";
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700955
Thieu Le116fda32011-04-19 11:01:54 -0700956 if (!HasOutputPipe()) {
957 // Just set success to whether or not the http transfer succeeded,
958 // which must be true at this point in the code.
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700959 completer.set_code(ErrorCode::kSuccess);
Thieu Le116fda32011-04-19 11:01:54 -0700960 return;
961 }
962
Darin Petkov6a5b3222010-07-13 14:55:28 -0700963 OmahaResponse output_object;
David Zeuthene8ed8632014-07-24 13:38:10 -0400964 if (!ParseResponse(&parser_data, &output_object, &completer))
rspangler@google.com49fdf182009-10-10 00:57:34 +0000965 return;
David Zeuthen8f191b22013-08-06 12:27:50 -0700966 output_object.update_exists = true;
967 SetOutputObject(output_object);
rspangler@google.com49fdf182009-10-10 00:57:34 +0000968
Chris Sosa77f79e82014-06-02 18:16:24 -0700969 if (ShouldIgnoreUpdate(output_object)) {
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700970 output_object.update_exists = false;
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700971 completer.set_code(ErrorCode::kOmahaUpdateIgnoredPerPolicy);
Jay Srinivasan0a708742012-03-20 11:26:12 -0700972 return;
973 }
974
David Zeuthen8f191b22013-08-06 12:27:50 -0700975 // If Omaha says to disable p2p, respect that
976 if (output_object.disable_p2p_for_downloading) {
977 LOG(INFO) << "Forcibly disabling use of p2p for downloading as "
978 << "requested by Omaha.";
Gilad Arnold74b5f552014-10-07 08:17:16 -0700979 payload_state->SetUsingP2PForDownloading(false);
David Zeuthen8f191b22013-08-06 12:27:50 -0700980 }
981 if (output_object.disable_p2p_for_sharing) {
982 LOG(INFO) << "Forcibly disabling use of p2p for sharing as "
983 << "requested by Omaha.";
Gilad Arnold74b5f552014-10-07 08:17:16 -0700984 payload_state->SetUsingP2PForSharing(false);
Jay Srinivasan480ddfa2012-06-01 19:15:26 -0700985 }
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800986
987 // Update the payload state with the current response. The payload state
988 // will automatically reset all stale state if this response is different
Jay Srinivasan08262882012-12-28 19:29:43 -0800989 // from what's stored already. We are updating the payload state as late
990 // as possible in this method so that if a new release gets pushed and then
991 // got pulled back due to some issues, we don't want to clear our internal
992 // state unnecessarily.
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800993 payload_state->SetResponse(output_object);
Jay Srinivasan08262882012-12-28 19:29:43 -0800994
David Zeuthen8f191b22013-08-06 12:27:50 -0700995 // It could be we've already exceeded the deadline for when p2p is
996 // allowed or that we've tried too many times with p2p. Check that.
Gilad Arnold74b5f552014-10-07 08:17:16 -0700997 if (payload_state->GetUsingP2PForDownloading()) {
David Zeuthen8f191b22013-08-06 12:27:50 -0700998 payload_state->P2PNewAttempt();
999 if (!payload_state->P2PAttemptAllowed()) {
1000 LOG(INFO) << "Forcibly disabling use of p2p for downloading because "
1001 << "of previous failures when using p2p.";
Gilad Arnold74b5f552014-10-07 08:17:16 -07001002 payload_state->SetUsingP2PForDownloading(false);
David Zeuthen8f191b22013-08-06 12:27:50 -07001003 }
1004 }
1005
1006 // From here on, we'll complete stuff in CompleteProcessing() so
1007 // disable |completer| since we'll create a new one in that
1008 // function.
1009 completer.set_should_complete(false);
1010
1011 // If we're allowed to use p2p for downloading we do not pay
1012 // attention to wall-clock-based waiting if the URL is indeed
1013 // available via p2p. Therefore, check if the file is available via
1014 // p2p before deferring...
Gilad Arnold74b5f552014-10-07 08:17:16 -07001015 if (payload_state->GetUsingP2PForDownloading()) {
David Zeuthen8f191b22013-08-06 12:27:50 -07001016 LookupPayloadViaP2P(output_object);
1017 } else {
1018 CompleteProcessing();
1019 }
1020}
1021
1022void OmahaRequestAction::CompleteProcessing() {
1023 ScopedActionCompleter completer(processor_, this);
1024 OmahaResponse& output_object = const_cast<OmahaResponse&>(GetOutputObject());
1025 PayloadStateInterface* payload_state = system_state_->payload_state();
1026
Kevin Cernekee2494e282016-03-29 18:03:53 -07001027 if (!system_state_->hardware()->IsOOBEComplete(nullptr) &&
1028 output_object.deadline.empty()) {
1029 output_object.update_exists = false;
1030 LOG(INFO) << "Ignoring non-critical Omaha updates until OOBE is done.";
1031 completer.set_code(ErrorCode::kNonCriticalUpdateInOOBE);
1032 return;
1033 }
1034
David Zeuthen8f191b22013-08-06 12:27:50 -07001035 if (ShouldDeferDownload(&output_object)) {
Jay Srinivasan08262882012-12-28 19:29:43 -08001036 output_object.update_exists = false;
David Zeuthen8f191b22013-08-06 12:27:50 -07001037 LOG(INFO) << "Ignoring Omaha updates as updates are deferred by policy.";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001038 completer.set_code(ErrorCode::kOmahaUpdateDeferredPerPolicy);
Jay Srinivasan08262882012-12-28 19:29:43 -08001039 return;
1040 }
David Zeuthen8f191b22013-08-06 12:27:50 -07001041
Chris Sosa20f005c2013-09-05 13:53:08 -07001042 if (payload_state->ShouldBackoffDownload()) {
1043 output_object.update_exists = false;
1044 LOG(INFO) << "Ignoring Omaha updates in order to backoff our retry "
1045 << "attempts";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001046 completer.set_code(ErrorCode::kOmahaUpdateDeferredForBackoff);
Chris Sosa20f005c2013-09-05 13:53:08 -07001047 return;
David Zeuthen8f191b22013-08-06 12:27:50 -07001048 }
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001049 completer.set_code(ErrorCode::kSuccess);
David Zeuthen8f191b22013-08-06 12:27:50 -07001050}
1051
1052void OmahaRequestAction::OnLookupPayloadViaP2PCompleted(const string& url) {
1053 LOG(INFO) << "Lookup complete, p2p-client returned URL '" << url << "'";
1054 if (!url.empty()) {
Gilad Arnold74b5f552014-10-07 08:17:16 -07001055 system_state_->payload_state()->SetP2PUrl(url);
David Zeuthen8f191b22013-08-06 12:27:50 -07001056 } else {
1057 LOG(INFO) << "Forcibly disabling use of p2p for downloading "
1058 << "because no suitable peer could be found.";
Gilad Arnold74b5f552014-10-07 08:17:16 -07001059 system_state_->payload_state()->SetUsingP2PForDownloading(false);
David Zeuthen8f191b22013-08-06 12:27:50 -07001060 }
1061 CompleteProcessing();
1062}
1063
1064void OmahaRequestAction::LookupPayloadViaP2P(const OmahaResponse& response) {
David Zeuthen41996ad2013-09-24 15:43:24 -07001065 // If the device is in the middle of an update, the state variables
1066 // kPrefsUpdateStateNextDataOffset, kPrefsUpdateStateNextDataLength
1067 // tracks the offset and length of the operation currently in
1068 // progress. The offset is based from the end of the manifest which
1069 // is kPrefsManifestMetadataSize bytes long.
1070 //
1071 // To make forward progress and avoid deadlocks, we need to find a
1072 // peer that has at least the entire operation we're currently
1073 // working on. Otherwise we may end up in a situation where two
1074 // devices bounce back and forth downloading from each other,
1075 // neither making any forward progress until one of them decides to
1076 // stop using p2p (via kMaxP2PAttempts and kMaxP2PAttemptTimeSeconds
1077 // safe-guards). See http://crbug.com/297170 for an example)
David Zeuthen8f191b22013-08-06 12:27:50 -07001078 size_t minimum_size = 0;
David Zeuthen41996ad2013-09-24 15:43:24 -07001079 int64_t manifest_metadata_size = 0;
Alex Deymof25eb492016-02-26 00:20:08 -08001080 int64_t manifest_signature_size = 0;
David Zeuthen41996ad2013-09-24 15:43:24 -07001081 int64_t next_data_offset = 0;
1082 int64_t next_data_length = 0;
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001083 if (system_state_ &&
David Zeuthen41996ad2013-09-24 15:43:24 -07001084 system_state_->prefs()->GetInt64(kPrefsManifestMetadataSize,
1085 &manifest_metadata_size) &&
1086 manifest_metadata_size != -1 &&
Alex Deymof25eb492016-02-26 00:20:08 -08001087 system_state_->prefs()->GetInt64(kPrefsManifestSignatureSize,
1088 &manifest_signature_size) &&
1089 manifest_signature_size != -1 &&
David Zeuthen8f191b22013-08-06 12:27:50 -07001090 system_state_->prefs()->GetInt64(kPrefsUpdateStateNextDataOffset,
David Zeuthen41996ad2013-09-24 15:43:24 -07001091 &next_data_offset) &&
1092 next_data_offset != -1 &&
1093 system_state_->prefs()->GetInt64(kPrefsUpdateStateNextDataLength,
1094 &next_data_length)) {
Alex Deymof25eb492016-02-26 00:20:08 -08001095 minimum_size = manifest_metadata_size + manifest_signature_size +
1096 next_data_offset + next_data_length;
David Zeuthen8f191b22013-08-06 12:27:50 -07001097 }
1098
1099 string file_id = utils::CalculateP2PFileId(response.hash, response.size);
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001100 if (system_state_->p2p_manager()) {
David Zeuthen8f191b22013-08-06 12:27:50 -07001101 LOG(INFO) << "Checking if payload is available via p2p, file_id="
1102 << file_id << " minimum_size=" << minimum_size;
1103 system_state_->p2p_manager()->LookupUrlForFile(
1104 file_id,
1105 minimum_size,
David Zeuthen4cc5ed22014-01-15 12:35:03 -08001106 TimeDelta::FromSeconds(kMaxP2PNetworkWaitTimeSeconds),
David Zeuthen8f191b22013-08-06 12:27:50 -07001107 base::Bind(&OmahaRequestAction::OnLookupPayloadViaP2PCompleted,
1108 base::Unretained(this)));
1109 }
rspangler@google.com49fdf182009-10-10 00:57:34 +00001110}
1111
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001112bool OmahaRequestAction::ShouldDeferDownload(OmahaResponse* output_object) {
Chris Sosa968d0572013-08-23 14:46:02 -07001113 if (params_->interactive()) {
1114 LOG(INFO) << "Not deferring download because update is interactive.";
1115 return false;
1116 }
1117
David Zeuthen8f191b22013-08-06 12:27:50 -07001118 // If we're using p2p to download _and_ we have a p2p URL, we never
1119 // defer the download. This is because the download will always
1120 // happen from a peer on the LAN and we've been waiting in line for
1121 // our turn.
Gilad Arnold74b5f552014-10-07 08:17:16 -07001122 const PayloadStateInterface* payload_state = system_state_->payload_state();
1123 if (payload_state->GetUsingP2PForDownloading() &&
1124 !payload_state->GetP2PUrl().empty()) {
David Zeuthen8f191b22013-08-06 12:27:50 -07001125 LOG(INFO) << "Download not deferred because download "
1126 << "will happen from a local peer (via p2p).";
1127 return false;
1128 }
1129
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001130 // We should defer the downloads only if we've first satisfied the
1131 // wall-clock-based-waiting period and then the update-check-based waiting
1132 // period, if required.
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001133 if (!params_->wall_clock_based_wait_enabled()) {
Chris Sosa968d0572013-08-23 14:46:02 -07001134 LOG(INFO) << "Wall-clock-based waiting period is not enabled,"
1135 << " so no deferring needed.";
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001136 return false;
1137 }
1138
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001139 switch (IsWallClockBasedWaitingSatisfied(output_object)) {
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001140 case kWallClockWaitNotSatisfied:
1141 // We haven't even satisfied the first condition, passing the
1142 // wall-clock-based waiting period, so we should defer the downloads
1143 // until that happens.
1144 LOG(INFO) << "wall-clock-based-wait not satisfied.";
1145 return true;
1146
1147 case kWallClockWaitDoneButUpdateCheckWaitRequired:
1148 LOG(INFO) << "wall-clock-based-wait satisfied and "
1149 << "update-check-based-wait required.";
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001150 return !IsUpdateCheckCountBasedWaitingSatisfied();
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001151
1152 case kWallClockWaitDoneAndUpdateCheckWaitNotRequired:
1153 // Wall-clock-based waiting period is satisfied, and it's determined
1154 // that we do not need the update-check-based wait. so no need to
1155 // defer downloads.
1156 LOG(INFO) << "wall-clock-based-wait satisfied and "
1157 << "update-check-based-wait is not required.";
1158 return false;
1159
1160 default:
1161 // Returning false for this default case so we err on the
1162 // side of downloading updates than deferring in case of any bugs.
1163 NOTREACHED();
1164 return false;
1165 }
1166}
1167
1168OmahaRequestAction::WallClockWaitResult
1169OmahaRequestAction::IsWallClockBasedWaitingSatisfied(
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001170 OmahaResponse* output_object) {
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001171 Time update_first_seen_at;
Ben Chan9abb7632014-08-07 00:10:53 -07001172 int64_t update_first_seen_at_int;
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001173
Jay Srinivasan6f6ea002012-12-14 11:26:28 -08001174 if (system_state_->prefs()->Exists(kPrefsUpdateFirstSeenAt)) {
1175 if (system_state_->prefs()->GetInt64(kPrefsUpdateFirstSeenAt,
1176 &update_first_seen_at_int)) {
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001177 // Note: This timestamp could be that of ANY update we saw in the past
1178 // (not necessarily this particular update we're considering to apply)
1179 // but never got to apply because of some reason (e.g. stop AU policy,
1180 // updates being pulled out from Omaha, changes in target version prefix,
1181 // new update being rolled out, etc.). But for the purposes of scattering
1182 // it doesn't matter which update the timestamp corresponds to. i.e.
1183 // the clock starts ticking the first time we see an update and we're
1184 // ready to apply when the random wait period is satisfied relative to
1185 // that first seen timestamp.
1186 update_first_seen_at = Time::FromInternalValue(update_first_seen_at_int);
1187 LOG(INFO) << "Using persisted value of UpdateFirstSeenAt: "
1188 << utils::ToString(update_first_seen_at);
1189 } else {
1190 // This seems like an unexpected error where the persisted value exists
1191 // but it's not readable for some reason. Just skip scattering in this
1192 // case to be safe.
1193 LOG(INFO) << "Not scattering as UpdateFirstSeenAt value cannot be read";
1194 return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
1195 }
1196 } else {
1197 update_first_seen_at = Time::Now();
1198 update_first_seen_at_int = update_first_seen_at.ToInternalValue();
Jay Srinivasan6f6ea002012-12-14 11:26:28 -08001199 if (system_state_->prefs()->SetInt64(kPrefsUpdateFirstSeenAt,
1200 update_first_seen_at_int)) {
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001201 LOG(INFO) << "Persisted the new value for UpdateFirstSeenAt: "
1202 << utils::ToString(update_first_seen_at);
Alex Vakulenkod2779df2014-06-16 13:19:00 -07001203 } else {
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001204 // This seems like an unexpected error where the value cannot be
1205 // persisted for some reason. Just skip scattering in this
1206 // case to be safe.
1207 LOG(INFO) << "Not scattering as UpdateFirstSeenAt value "
1208 << utils::ToString(update_first_seen_at)
1209 << " cannot be persisted";
1210 return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
1211 }
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001212 }
1213
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001214 TimeDelta elapsed_time = Time::Now() - update_first_seen_at;
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001215 TimeDelta max_scatter_period = TimeDelta::FromDays(
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001216 output_object->max_days_to_scatter);
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001217
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001218 LOG(INFO) << "Waiting Period = "
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001219 << utils::FormatSecs(params_->waiting_period().InSeconds())
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001220 << ", Time Elapsed = "
1221 << utils::FormatSecs(elapsed_time.InSeconds())
1222 << ", MaxDaysToScatter = "
1223 << max_scatter_period.InDays();
1224
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001225 if (!output_object->deadline.empty()) {
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001226 // The deadline is set for all rules which serve a delta update from a
1227 // previous FSI, which means this update will be applied mostly in OOBE
1228 // cases. For these cases, we shouldn't scatter so as to finish the OOBE
1229 // quickly.
1230 LOG(INFO) << "Not scattering as deadline flag is set";
1231 return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
1232 }
1233
1234 if (max_scatter_period.InDays() == 0) {
1235 // This means the Omaha rule creator decides that this rule
1236 // should not be scattered irrespective of the policy.
1237 LOG(INFO) << "Not scattering as MaxDaysToScatter in rule is 0.";
1238 return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
1239 }
1240
1241 if (elapsed_time > max_scatter_period) {
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001242 // This means we've waited more than the upperbound wait in the rule
1243 // from the time we first saw a valid update available to us.
1244 // This will prevent update starvation.
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001245 LOG(INFO) << "Not scattering as we're past the MaxDaysToScatter limit.";
1246 return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
1247 }
1248
1249 // This means we are required to participate in scattering.
1250 // See if our turn has arrived now.
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001251 TimeDelta remaining_wait_time = params_->waiting_period() - elapsed_time;
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001252 if (remaining_wait_time.InSeconds() <= 0) {
1253 // Yes, it's our turn now.
1254 LOG(INFO) << "Successfully passed the wall-clock-based-wait.";
1255
1256 // But we can't download until the update-check-count-based wait is also
1257 // satisfied, so mark it as required now if update checks are enabled.
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001258 return params_->update_check_count_wait_enabled() ?
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001259 kWallClockWaitDoneButUpdateCheckWaitRequired :
1260 kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
1261 }
1262
1263 // Not our turn yet, so we have to wait until our turn to
1264 // help scatter the downloads across all clients of the enterprise.
1265 LOG(INFO) << "Update deferred for another "
1266 << utils::FormatSecs(remaining_wait_time.InSeconds())
1267 << " per policy.";
1268 return kWallClockWaitNotSatisfied;
1269}
1270
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001271bool OmahaRequestAction::IsUpdateCheckCountBasedWaitingSatisfied() {
Ben Chan9abb7632014-08-07 00:10:53 -07001272 int64_t update_check_count_value;
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001273
Jay Srinivasan6f6ea002012-12-14 11:26:28 -08001274 if (system_state_->prefs()->Exists(kPrefsUpdateCheckCount)) {
1275 if (!system_state_->prefs()->GetInt64(kPrefsUpdateCheckCount,
1276 &update_check_count_value)) {
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001277 // We are unable to read the update check count from file for some reason.
1278 // So let's proceed anyway so as to not stall the update.
1279 LOG(ERROR) << "Unable to read update check count. "
1280 << "Skipping update-check-count-based-wait.";
1281 return true;
1282 }
1283 } else {
1284 // This file does not exist. This means we haven't started our update
1285 // check count down yet, so this is the right time to start the count down.
1286 update_check_count_value = base::RandInt(
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001287 params_->min_update_checks_needed(),
1288 params_->max_update_checks_allowed());
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001289
1290 LOG(INFO) << "Randomly picked update check count value = "
1291 << update_check_count_value;
1292
1293 // Write out the initial value of update_check_count_value.
Jay Srinivasan6f6ea002012-12-14 11:26:28 -08001294 if (!system_state_->prefs()->SetInt64(kPrefsUpdateCheckCount,
1295 update_check_count_value)) {
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001296 // We weren't able to write the update check count file for some reason.
1297 // So let's proceed anyway so as to not stall the update.
1298 LOG(ERROR) << "Unable to write update check count. "
1299 << "Skipping update-check-count-based-wait.";
1300 return true;
1301 }
1302 }
1303
1304 if (update_check_count_value == 0) {
1305 LOG(INFO) << "Successfully passed the update-check-based-wait.";
1306 return true;
1307 }
1308
1309 if (update_check_count_value < 0 ||
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001310 update_check_count_value > params_->max_update_checks_allowed()) {
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001311 // We err on the side of skipping scattering logic instead of stalling
1312 // a machine from receiving any updates in case of any unexpected state.
1313 LOG(ERROR) << "Invalid value for update check count detected. "
1314 << "Skipping update-check-count-based-wait.";
1315 return true;
1316 }
1317
1318 // Legal value, we need to wait for more update checks to happen
1319 // until this becomes 0.
1320 LOG(INFO) << "Deferring Omaha updates for another "
1321 << update_check_count_value
1322 << " update checks per policy";
1323 return false;
1324}
1325
David Zeuthen639aa362014-02-03 16:23:44 -08001326// static
David Zeuthene8ed8632014-07-24 13:38:10 -04001327bool OmahaRequestAction::ParseInstallDate(OmahaParserData* parser_data,
David Zeuthen639aa362014-02-03 16:23:44 -08001328 OmahaResponse* output_object) {
David Zeuthen639aa362014-02-03 16:23:44 -08001329 int64_t elapsed_days = 0;
David Zeuthene8ed8632014-07-24 13:38:10 -04001330 if (!base::StringToInt64(parser_data->daystart_elapsed_days,
David Zeuthen639aa362014-02-03 16:23:44 -08001331 &elapsed_days))
1332 return false;
1333
1334 if (elapsed_days < 0)
1335 return false;
1336
1337 output_object->install_date_days = elapsed_days;
1338 return true;
1339}
1340
1341// static
1342bool OmahaRequestAction::HasInstallDate(SystemState *system_state) {
1343 PrefsInterface* prefs = system_state->prefs();
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001344 if (prefs == nullptr)
David Zeuthen639aa362014-02-03 16:23:44 -08001345 return false;
1346
1347 return prefs->Exists(kPrefsInstallDateDays);
1348}
1349
1350// static
1351bool OmahaRequestAction::PersistInstallDate(
1352 SystemState *system_state,
1353 int install_date_days,
1354 InstallDateProvisioningSource source) {
1355 TEST_AND_RETURN_FALSE(install_date_days >= 0);
1356
1357 PrefsInterface* prefs = system_state->prefs();
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001358 if (prefs == nullptr)
David Zeuthen639aa362014-02-03 16:23:44 -08001359 return false;
1360
1361 if (!prefs->SetInt64(kPrefsInstallDateDays, install_date_days))
1362 return false;
1363
Alex Deymoaf9a8632015-09-23 18:51:48 -07001364 string metric_name = metrics::kMetricInstallDateProvisioningSource;
David Zeuthen33bae492014-02-25 16:16:18 -08001365 system_state->metrics_lib()->SendEnumToUMA(
1366 metric_name,
1367 static_cast<int>(source), // Sample.
1368 kProvisionedMax); // Maximum.
David Zeuthen639aa362014-02-03 16:23:44 -08001369
1370 return true;
1371}
1372
Alex Deymo8e18f932015-03-27 16:16:59 -07001373bool OmahaRequestAction::PersistCohortData(
1374 const string& prefs_key,
1375 const string& new_value) {
1376 if (new_value.empty() && system_state_->prefs()->Exists(prefs_key)) {
1377 LOG(INFO) << "Removing stored " << prefs_key << " value.";
1378 return system_state_->prefs()->Delete(prefs_key);
1379 } else if (!new_value.empty()) {
1380 LOG(INFO) << "Storing new setting " << prefs_key << " as " << new_value;
1381 return system_state_->prefs()->SetString(prefs_key, new_value);
1382 }
1383 return true;
1384}
1385
David Zeuthen33bae492014-02-25 16:16:18 -08001386void OmahaRequestAction::ActionCompleted(ErrorCode code) {
1387 // We only want to report this on "update check".
1388 if (ping_only_ || event_ != nullptr)
1389 return;
1390
1391 metrics::CheckResult result = metrics::CheckResult::kUnset;
1392 metrics::CheckReaction reaction = metrics::CheckReaction::kUnset;
1393 metrics::DownloadErrorCode download_error_code =
1394 metrics::DownloadErrorCode::kUnset;
1395
1396 // Regular update attempt.
1397 switch (code) {
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001398 case ErrorCode::kSuccess:
David Zeuthen33bae492014-02-25 16:16:18 -08001399 // OK, we parsed the response successfully but that does
1400 // necessarily mean that an update is available.
1401 if (HasOutputPipe()) {
1402 const OmahaResponse& response = GetOutputObject();
1403 if (response.update_exists) {
1404 result = metrics::CheckResult::kUpdateAvailable;
1405 reaction = metrics::CheckReaction::kUpdating;
1406 } else {
1407 result = metrics::CheckResult::kNoUpdateAvailable;
1408 }
1409 } else {
1410 result = metrics::CheckResult::kNoUpdateAvailable;
1411 }
1412 break;
1413
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001414 case ErrorCode::kOmahaUpdateIgnoredPerPolicy:
David Zeuthen33bae492014-02-25 16:16:18 -08001415 result = metrics::CheckResult::kUpdateAvailable;
1416 reaction = metrics::CheckReaction::kIgnored;
1417 break;
1418
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001419 case ErrorCode::kOmahaUpdateDeferredPerPolicy:
David Zeuthen33bae492014-02-25 16:16:18 -08001420 result = metrics::CheckResult::kUpdateAvailable;
1421 reaction = metrics::CheckReaction::kDeferring;
1422 break;
1423
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001424 case ErrorCode::kOmahaUpdateDeferredForBackoff:
David Zeuthen33bae492014-02-25 16:16:18 -08001425 result = metrics::CheckResult::kUpdateAvailable;
1426 reaction = metrics::CheckReaction::kBackingOff;
1427 break;
1428
1429 default:
1430 // We report two flavors of errors, "Download errors" and "Parsing
1431 // error". Try to convert to the former and if that doesn't work
1432 // we know it's the latter.
Alex Deymo38429cf2015-11-11 18:27:22 -08001433 metrics::DownloadErrorCode tmp_error =
1434 metrics_utils::GetDownloadErrorCode(code);
David Zeuthen33bae492014-02-25 16:16:18 -08001435 if (tmp_error != metrics::DownloadErrorCode::kInputMalformed) {
1436 result = metrics::CheckResult::kDownloadError;
1437 download_error_code = tmp_error;
1438 } else {
1439 result = metrics::CheckResult::kParsingError;
1440 }
1441 break;
1442 }
1443
1444 metrics::ReportUpdateCheckMetrics(system_state_,
1445 result, reaction, download_error_code);
1446}
1447
Chris Sosa77f79e82014-06-02 18:16:24 -07001448bool OmahaRequestAction::ShouldIgnoreUpdate(
1449 const OmahaResponse& response) const {
Chris Sosa77f79e82014-06-02 18:16:24 -07001450 // Note: policy decision to not update to a version we rolled back from.
1451 string rollback_version =
1452 system_state_->payload_state()->GetRollbackVersion();
Alex Vakulenkod2779df2014-06-16 13:19:00 -07001453 if (!rollback_version.empty()) {
Chris Sosa77f79e82014-06-02 18:16:24 -07001454 LOG(INFO) << "Detected previous rollback from version " << rollback_version;
Alex Vakulenkod2779df2014-06-16 13:19:00 -07001455 if (rollback_version == response.version) {
Chris Sosa77f79e82014-06-02 18:16:24 -07001456 LOG(INFO) << "Received version that we rolled back from. Ignoring.";
1457 return true;
1458 }
1459 }
1460
Alex Vakulenkod2779df2014-06-16 13:19:00 -07001461 if (!IsUpdateAllowedOverCurrentConnection()) {
Chris Sosa77f79e82014-06-02 18:16:24 -07001462 LOG(INFO) << "Update is not allowed over current connection.";
1463 return true;
1464 }
1465
1466 // Note: We could technically delete the UpdateFirstSeenAt state when we
1467 // return true. If we do, it'll mean a device has to restart the
1468 // UpdateFirstSeenAt and thus help scattering take effect when the AU is
1469 // turned on again. On the other hand, it also increases the chance of update
1470 // starvation if an admin turns AU on/off more frequently. We choose to err on
1471 // the side of preventing starvation at the cost of not applying scattering in
1472 // those cases.
1473 return false;
1474}
1475
1476bool OmahaRequestAction::IsUpdateAllowedOverCurrentConnection() const {
1477 NetworkConnectionType type;
1478 NetworkTethering tethering;
Alex Deymof6ee0162015-07-31 12:35:22 -07001479 ConnectionManagerInterface* connection_manager =
1480 system_state_->connection_manager();
Alex Deymo30534502015-07-20 15:06:33 -07001481 if (!connection_manager->GetConnectionProperties(&type, &tethering)) {
Chris Sosa77f79e82014-06-02 18:16:24 -07001482 LOG(INFO) << "We could not determine our connection type. "
1483 << "Defaulting to allow updates.";
1484 return true;
1485 }
1486 bool is_allowed = connection_manager->IsUpdateAllowedOver(type, tethering);
1487 LOG(INFO) << "We are connected via "
Alex Deymof6ee0162015-07-31 12:35:22 -07001488 << ConnectionManager::StringForConnectionType(type)
Chris Sosa77f79e82014-06-02 18:16:24 -07001489 << ", Updates allowed: " << (is_allowed ? "Yes" : "No");
1490 return is_allowed;
1491}
1492
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001493} // namespace chromeos_update_engine