blob: a1cc429aafa7babbd4ce06792c46edfa084db47c [file] [log] [blame]
Mike Frysinger8155d082012-04-06 15:23:18 -04001// Copyright (c) 2012 The Chromium OS Authors. All rights reserved.
rspangler@google.com49fdf182009-10-10 00:57:34 +00002// Use of this source code is governed by a BSD-style license that can be
3// found in the LICENSE file.
4
Darin Petkov6a5b3222010-07-13 14:55:28 -07005#include "update_engine/omaha_request_action.h"
Darin Petkov85ced132010-09-01 10:20:56 -07006
Andrew de los Reyes08c4e272010-04-15 14:02:17 -07007#include <inttypes.h>
Darin Petkov85ced132010-09-01 10:20:56 -07008
David Zeuthene8ed8632014-07-24 13:38:10 -04009#include <map>
rspangler@google.com49fdf182009-10-10 00:57:34 +000010#include <sstream>
Jay Srinivasan480ddfa2012-06-01 19:15:26 -070011#include <string>
David Zeuthene8ed8632014-07-24 13:38:10 -040012#include <vector>
rspangler@google.com49fdf182009-10-10 00:57:34 +000013
David Zeuthen8f191b22013-08-06 12:27:50 -070014#include <base/bind.h>
Jay Srinivasan480ddfa2012-06-01 19:15:26 -070015#include <base/logging.h>
16#include <base/rand_util.h>
Alex Vakulenko75039d72014-03-25 12:36:28 -070017#include <base/strings/string_number_conversions.h>
18#include <base/strings/string_util.h>
19#include <base/strings/stringprintf.h>
20#include <base/time/time.h>
David Zeuthene8ed8632014-07-24 13:38:10 -040021#include <expat.h>
rspangler@google.com49fdf182009-10-10 00:57:34 +000022
23#include "update_engine/action_pipe.h"
Jay Srinivasand29695d2013-04-08 15:08:05 -070024#include "update_engine/constants.h"
J. Richard Barnette056b0ab2013-10-29 15:24:56 -070025#include "update_engine/hardware_interface.h"
David Zeuthen8f191b22013-08-06 12:27:50 -070026#include "update_engine/omaha_hash_calculator.h"
Darin Petkova4a8a8c2010-07-15 22:21:12 -070027#include "update_engine/omaha_request_params.h"
David Zeuthen8f191b22013-08-06 12:27:50 -070028#include "update_engine/p2p_manager.h"
Jay Srinivasan55f50c22013-01-10 19:24:35 -080029#include "update_engine/payload_state_interface.h"
Darin Petkov1cbd78f2010-07-29 12:38:34 -070030#include "update_engine/prefs_interface.h"
Chris Sosa77f79e82014-06-02 18:16:24 -070031#include "update_engine/real_dbus_wrapper.h"
adlr@google.comc98a7ed2009-12-04 18:54:03 +000032#include "update_engine/utils.h"
rspangler@google.com49fdf182009-10-10 00:57:34 +000033
Darin Petkov1cbd78f2010-07-29 12:38:34 -070034using base::Time;
35using base::TimeDelta;
David Zeuthene8ed8632014-07-24 13:38:10 -040036using std::map;
rspangler@google.com49fdf182009-10-10 00:57:34 +000037using std::string;
David Zeuthene8ed8632014-07-24 13:38:10 -040038using std::vector;
rspangler@google.com49fdf182009-10-10 00:57:34 +000039
40namespace chromeos_update_engine {
41
Jay Srinivasan2b5a0f02012-12-19 17:25:56 -080042// List of custom pair tags that we interpret in the Omaha Response:
43static const char* kTagDeadline = "deadline";
Jay Srinivasan08262882012-12-28 19:29:43 -080044static const char* kTagDisablePayloadBackoff = "DisablePayloadBackoff";
Chris Sosa3b748432013-06-20 16:42:59 -070045static const char* kTagVersion = "version";
Jay Srinivasand671e972013-01-11 17:17:19 -080046// Deprecated: "IsDelta"
47static const char* kTagIsDeltaPayload = "IsDeltaPayload";
Jay Srinivasan2b5a0f02012-12-19 17:25:56 -080048static const char* kTagMaxFailureCountPerUrl = "MaxFailureCountPerUrl";
49static const char* kTagMaxDaysToScatter = "MaxDaysToScatter";
50// Deprecated: "ManifestSignatureRsa"
51// Deprecated: "ManifestSize"
52static const char* kTagMetadataSignatureRsa = "MetadataSignatureRsa";
53static const char* kTagMetadataSize = "MetadataSize";
54static const char* kTagMoreInfo = "MoreInfo";
Don Garrett42bd3aa2013-04-10 18:14:56 -070055// Deprecated: "NeedsAdmin"
Jay Srinivasan2b5a0f02012-12-19 17:25:56 -080056static const char* kTagPrompt = "Prompt";
57static const char* kTagSha256 = "sha256";
David Zeuthen8f191b22013-08-06 12:27:50 -070058static const char* kTagDisableP2PForDownloading = "DisableP2PForDownloading";
59static const char* kTagDisableP2PForSharing = "DisableP2PForSharing";
David Zeuthene7f89172013-10-31 10:21:04 -070060static const char* kTagPublicKeyRsa = "PublicKeyRsa";
Jay Srinivasan2b5a0f02012-12-19 17:25:56 -080061
rspangler@google.com49fdf182009-10-10 00:57:34 +000062namespace {
63
Alex Vakulenkod2779df2014-06-16 13:19:00 -070064static const char* const kGupdateVersion = "ChromeOSUpdateEngine-0.1.0.0";
rspangler@google.com49fdf182009-10-10 00:57:34 +000065
Darin Petkov1cbd78f2010-07-29 12:38:34 -070066// Returns an XML ping element attribute assignment with attribute
67// |name| and value |ping_days| if |ping_days| has a value that needs
68// to be sent, or an empty string otherwise.
69string GetPingAttribute(const string& name, int ping_days) {
Alex Deymoebbe7ef2014-10-30 13:02:49 -070070 if (ping_days > 0 || ping_days == OmahaRequestAction::kNeverPinged)
Alex Vakulenko75039d72014-03-25 12:36:28 -070071 return base::StringPrintf(" %s=\"%d\"", name.c_str(), ping_days);
Darin Petkov1cbd78f2010-07-29 12:38:34 -070072 return "";
73}
74
75// Returns an XML ping element if any of the elapsed days need to be
76// sent, or an empty string otherwise.
Jay Srinivasanae4697c2013-03-18 17:08:08 -070077string GetPingXml(int ping_active_days, int ping_roll_call_days) {
Darin Petkov1cbd78f2010-07-29 12:38:34 -070078 string ping_active = GetPingAttribute("a", ping_active_days);
79 string ping_roll_call = GetPingAttribute("r", ping_roll_call_days);
80 if (!ping_active.empty() || !ping_roll_call.empty()) {
Alex Vakulenko75039d72014-03-25 12:36:28 -070081 return base::StringPrintf(" <ping active=\"1\"%s%s></ping>\n",
Alex Deymoebbe7ef2014-10-30 13:02:49 -070082 ping_active.c_str(),
83 ping_roll_call.c_str());
Darin Petkov1cbd78f2010-07-29 12:38:34 -070084 }
85 return "";
86}
87
Jay Srinivasanae4697c2013-03-18 17:08:08 -070088// Returns an XML that goes into the body of the <app> element of the Omaha
89// request based on the given parameters.
90string GetAppBody(const OmahaEvent* event,
Jay Srinivasan1c0fe792013-03-28 16:45:25 -070091 OmahaRequestParams* params,
Jay Srinivasanae4697c2013-03-18 17:08:08 -070092 bool ping_only,
Alex Deymoebbe7ef2014-10-30 13:02:49 -070093 bool include_ping,
Jay Srinivasanae4697c2013-03-18 17:08:08 -070094 int ping_active_days,
95 int ping_roll_call_days,
96 PrefsInterface* prefs) {
97 string app_body;
Alex Vakulenko88b591f2014-08-28 16:48:57 -070098 if (event == nullptr) {
Alex Deymoebbe7ef2014-10-30 13:02:49 -070099 if (include_ping)
100 app_body = GetPingXml(ping_active_days, ping_roll_call_days);
Darin Petkov265f2902011-05-09 15:17:40 -0700101 if (!ping_only) {
Alex Vakulenko75039d72014-03-25 12:36:28 -0700102 app_body += base::StringPrintf(
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700103 " <updatecheck targetversionprefix=\"%s\""
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700104 "></updatecheck>\n",
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700105 XmlEncode(params->target_version_prefix()).c_str());
Jay Srinivasan0a708742012-03-20 11:26:12 -0700106
Darin Petkov265f2902011-05-09 15:17:40 -0700107 // If this is the first update check after a reboot following a previous
108 // update, generate an event containing the previous version number. If
109 // the previous version preference file doesn't exist the event is still
110 // generated with a previous version of 0.0.0.0 -- this is relevant for
111 // older clients or new installs. The previous version event is not sent
112 // for ping-only requests because they come before the client has
113 // rebooted.
114 string prev_version;
115 if (!prefs->GetString(kPrefsPreviousVersion, &prev_version)) {
116 prev_version = "0.0.0.0";
117 }
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700118
Alex Vakulenko75039d72014-03-25 12:36:28 -0700119 app_body += base::StringPrintf(
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700120 " <event eventtype=\"%d\" eventresult=\"%d\" "
121 "previousversion=\"%s\"></event>\n",
122 OmahaEvent::kTypeUpdateComplete,
123 OmahaEvent::kResultSuccessReboot,
124 XmlEncode(prev_version).c_str());
125 LOG_IF(WARNING, !prefs->SetString(kPrefsPreviousVersion, ""))
126 << "Unable to reset the previous version.";
Darin Petkov95508da2011-01-05 12:42:29 -0800127 }
Darin Petkov0dc8e9a2010-07-14 14:51:57 -0700128 } else {
Darin Petkovc91dd6b2011-01-10 12:31:34 -0800129 // The error code is an optional attribute so append it only if the result
130 // is not success.
Darin Petkove17f86b2010-07-20 09:12:01 -0700131 string error_code;
132 if (event->result != OmahaEvent::kResultSuccess) {
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700133 error_code = base::StringPrintf(" errorcode=\"%d\"",
134 static_cast<int>(event->error_code));
Darin Petkove17f86b2010-07-20 09:12:01 -0700135 }
Alex Vakulenko75039d72014-03-25 12:36:28 -0700136 app_body = base::StringPrintf(
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700137 " <event eventtype=\"%d\" eventresult=\"%d\"%s></event>\n",
Darin Petkove17f86b2010-07-20 09:12:01 -0700138 event->type, event->result, error_code.c_str());
Darin Petkov0dc8e9a2010-07-14 14:51:57 -0700139 }
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700140
141 return app_body;
142}
143
Alex Deymo8e18f932015-03-27 16:16:59 -0700144// Returns the cohort* argument to include in the <app> tag for the passed
145// |arg_name| and |prefs_key|, if any. The return value is suitable to
146// concatenate to the list of arguments and includes a space at the end.
147string GetCohortArgXml(PrefsInterface* prefs,
148 const std::string arg_name,
149 const std::string prefs_key) {
150 // There's nothing wrong with not having a given cohort setting, so we check
151 // existance first to avoid the warning log message.
152 if (!prefs->Exists(prefs_key))
153 return "";
154 string cohort_value;
155 if (!prefs->GetString(prefs_key, &cohort_value) || cohort_value.empty())
156 return "";
157 // This is a sanity check to avoid sending a huge XML file back to Ohama due
158 // to a compromised stateful partition making the update check fail in low
159 // network environments envent after a reboot.
160 if (cohort_value.size() > 1024) {
161 LOG(WARNING) << "The omaha cohort setting " << arg_name
162 << " has a too big value, which must be an error or an "
163 "attacker trying to inhibit updates.";
164 return "";
165 }
166
167 return base::StringPrintf("%s=\"%s\" ",
168 arg_name.c_str(), XmlEncode(cohort_value).c_str());
169}
170
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700171// Returns an XML that corresponds to the entire <app> node of the Omaha
172// request based on the given parameters.
173string GetAppXml(const OmahaEvent* event,
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700174 OmahaRequestParams* params,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700175 bool ping_only,
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700176 bool include_ping,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700177 int ping_active_days,
178 int ping_roll_call_days,
David Zeuthen639aa362014-02-03 16:23:44 -0800179 int install_date_in_days,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700180 SystemState* system_state) {
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700181 string app_body = GetAppBody(event, params, ping_only, include_ping,
182 ping_active_days, ping_roll_call_days,
183 system_state->prefs());
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700184 string app_versions;
185
186 // If we are upgrading to a more stable channel and we are allowed to do
187 // powerwash, then pass 0.0.0.0 as the version. This is needed to get the
188 // highest-versioned payload on the destination channel.
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700189 if (params->to_more_stable_channel() && params->is_powerwash_allowed()) {
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700190 LOG(INFO) << "Passing OS version as 0.0.0.0 as we are set to powerwash "
191 << "on downgrading to the version in the more stable channel";
192 app_versions = "version=\"0.0.0.0\" from_version=\"" +
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700193 XmlEncode(params->app_version()) + "\" ";
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700194 } else {
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700195 app_versions = "version=\"" + XmlEncode(params->app_version()) + "\" ";
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700196 }
197
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700198 string download_channel = params->download_channel();
199 string app_channels = "track=\"" + XmlEncode(download_channel) + "\" ";
200 if (params->current_channel() != download_channel)
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700201 app_channels +=
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700202 "from_track=\"" + XmlEncode(params->current_channel()) + "\" ";
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700203
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700204 string delta_okay_str = params->delta_okay() ? "true" : "false";
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700205
David Zeuthen639aa362014-02-03 16:23:44 -0800206 // If install_date_days is not set (e.g. its value is -1 ), don't
207 // include the attribute.
208 string install_date_in_days_str = "";
209 if (install_date_in_days >= 0) {
Alex Vakulenko75039d72014-03-25 12:36:28 -0700210 install_date_in_days_str = base::StringPrintf("installdate=\"%d\" ",
211 install_date_in_days);
David Zeuthen639aa362014-02-03 16:23:44 -0800212 }
213
Alex Deymo8e18f932015-03-27 16:16:59 -0700214 string app_cohort_args;
215 app_cohort_args += GetCohortArgXml(system_state->prefs(),
216 "cohort", kPrefsOmahaCohort);
217 app_cohort_args += GetCohortArgXml(system_state->prefs(),
218 "cohorthint", kPrefsOmahaCohortHint);
219 app_cohort_args += GetCohortArgXml(system_state->prefs(),
220 "cohortname", kPrefsOmahaCohortName);
221
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700222 string app_xml =
Jay Srinivasandb0acdf2013-04-02 14:47:45 -0700223 " <app appid=\"" + XmlEncode(params->GetAppId()) + "\" " +
Alex Deymo8e18f932015-03-27 16:16:59 -0700224 app_cohort_args +
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700225 app_versions +
226 app_channels +
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700227 "lang=\"" + XmlEncode(params->app_lang()) + "\" " +
228 "board=\"" + XmlEncode(params->os_board()) + "\" " +
229 "hardware_class=\"" + XmlEncode(params->hwid()) + "\" " +
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700230 "delta_okay=\"" + delta_okay_str + "\" "
Chris Sosac1972482013-04-30 22:31:10 -0700231 "fw_version=\"" + XmlEncode(params->fw_version()) + "\" " +
232 "ec_version=\"" + XmlEncode(params->ec_version()) + "\" " +
David Zeuthen639aa362014-02-03 16:23:44 -0800233 install_date_in_days_str +
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700234 ">\n" +
235 app_body +
236 " </app>\n";
237
238 return app_xml;
239}
240
241// Returns an XML that corresponds to the entire <os> node of the Omaha
242// request based on the given parameters.
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700243string GetOsXml(OmahaRequestParams* params) {
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700244 string os_xml =
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700245 " <os version=\"" + XmlEncode(params->os_version()) + "\" " +
246 "platform=\"" + XmlEncode(params->os_platform()) + "\" " +
247 "sp=\"" + XmlEncode(params->os_sp()) + "\">"
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700248 "</os>\n";
249 return os_xml;
250}
251
252// Returns an XML that corresponds to the entire Omaha request based on the
253// given parameters.
254string GetRequestXml(const OmahaEvent* event,
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700255 OmahaRequestParams* params,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700256 bool ping_only,
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700257 bool include_ping,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700258 int ping_active_days,
259 int ping_roll_call_days,
David Zeuthen639aa362014-02-03 16:23:44 -0800260 int install_date_in_days,
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700261 SystemState* system_state) {
262 string os_xml = GetOsXml(params);
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700263 string app_xml = GetAppXml(event, params, ping_only, include_ping,
264 ping_active_days, ping_roll_call_days,
265 install_date_in_days, system_state);
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700266
Alex Vakulenko75039d72014-03-25 12:36:28 -0700267 string install_source = base::StringPrintf("installsource=\"%s\" ",
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700268 (params->interactive() ? "ondemandupdate" : "scheduler"));
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700269
270 string request_xml =
271 "<?xml version=\"1.0\" encoding=\"UTF-8\"?>\n"
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700272 "<request protocol=\"3.0\" "
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700273 "version=\"" + XmlEncode(kGupdateVersion) + "\" "
274 "updaterversion=\"" + XmlEncode(kGupdateVersion) + "\" " +
275 install_source +
276 "ismachine=\"1\">\n" +
277 os_xml +
278 app_xml +
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700279 "</request>\n";
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700280
281 return request_xml;
rspangler@google.com49fdf182009-10-10 00:57:34 +0000282}
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700283
Alex Vakulenkod2779df2014-06-16 13:19:00 -0700284} // namespace
rspangler@google.com49fdf182009-10-10 00:57:34 +0000285
David Zeuthene8ed8632014-07-24 13:38:10 -0400286// Struct used for holding data obtained when parsing the XML.
287struct OmahaParserData {
David Zeuthenf3e28012014-08-26 18:23:52 -0400288 explicit OmahaParserData(XML_Parser _xml_parser) : xml_parser(_xml_parser) {}
289
290 // Pointer to the expat XML_Parser object.
291 XML_Parser xml_parser;
292
David Zeuthene8ed8632014-07-24 13:38:10 -0400293 // This is the state of the parser as it's processing the XML.
294 bool failed = false;
David Zeuthenf3e28012014-08-26 18:23:52 -0400295 bool entity_decl = false;
David Zeuthene8ed8632014-07-24 13:38:10 -0400296 string current_path;
297
298 // These are the values extracted from the XML.
Alex Deymo8e18f932015-03-27 16:16:59 -0700299 string app_cohort;
300 string app_cohorthint;
301 string app_cohortname;
302 bool app_cohort_set = false;
303 bool app_cohorthint_set = false;
304 bool app_cohortname_set = false;
David Zeuthene8ed8632014-07-24 13:38:10 -0400305 string updatecheck_status;
306 string updatecheck_poll_interval;
307 string daystart_elapsed_days;
308 string daystart_elapsed_seconds;
309 vector<string> url_codebase;
310 string package_name;
311 string package_size;
312 string manifest_version;
313 map<string, string> action_postinstall_attrs;
314};
315
316namespace {
317
318// Callback function invoked by expat.
319void ParserHandlerStart(void* user_data, const XML_Char* element,
320 const XML_Char** attr) {
321 OmahaParserData* data = reinterpret_cast<OmahaParserData*>(user_data);
322
323 if (data->failed)
324 return;
325
326 data->current_path += string("/") + element;
327
328 map<string, string> attrs;
329 if (attr != nullptr) {
330 for (int n = 0; attr[n] != nullptr && attr[n+1] != nullptr; n += 2) {
331 string key = attr[n];
332 string value = attr[n + 1];
333 attrs[key] = value;
334 }
335 }
336
Alex Deymo8e18f932015-03-27 16:16:59 -0700337 if (data->current_path == "/response/app") {
338 if (attrs.find("cohort") != attrs.end()) {
339 data->app_cohort_set = true;
340 data->app_cohort = attrs["cohort"];
341 }
342 if (attrs.find("cohorthint") != attrs.end()) {
343 data->app_cohorthint_set = true;
344 data->app_cohorthint = attrs["cohorthint"];
345 }
346 if (attrs.find("cohortname") != attrs.end()) {
347 data->app_cohortname_set = true;
348 data->app_cohortname = attrs["cohortname"];
349 }
350 } else if (data->current_path == "/response/app/updatecheck") {
David Zeuthene8ed8632014-07-24 13:38:10 -0400351 // There is only supposed to be a single <updatecheck> element.
352 data->updatecheck_status = attrs["status"];
353 data->updatecheck_poll_interval = attrs["PollInterval"];
354 } else if (data->current_path == "/response/daystart") {
355 // Get the install-date.
356 data->daystart_elapsed_days = attrs["elapsed_days"];
357 data->daystart_elapsed_seconds = attrs["elapsed_seconds"];
358 } else if (data->current_path == "/response/app/updatecheck/urls/url") {
359 // Look at all <url> elements.
360 data->url_codebase.push_back(attrs["codebase"]);
361 } else if (data->package_name.empty() && data->current_path ==
362 "/response/app/updatecheck/manifest/packages/package") {
363 // Only look at the first <package>.
364 data->package_name = attrs["name"];
365 data->package_size = attrs["size"];
366 } else if (data->current_path == "/response/app/updatecheck/manifest") {
367 // Get the version.
368 data->manifest_version = attrs[kTagVersion];
369 } else if (data->current_path ==
370 "/response/app/updatecheck/manifest/actions/action") {
371 // We only care about the postinstall action.
372 if (attrs["event"] == "postinstall") {
373 data->action_postinstall_attrs = attrs;
374 }
375 }
376}
377
378// Callback function invoked by expat.
379void ParserHandlerEnd(void* user_data, const XML_Char* element) {
380 OmahaParserData* data = reinterpret_cast<OmahaParserData*>(user_data);
381 if (data->failed)
382 return;
383
384 const string path_suffix = string("/") + element;
385
386 if (!EndsWith(data->current_path, path_suffix, true)) {
387 LOG(ERROR) << "Unexpected end element '" << element
388 << "' with current_path='" << data->current_path << "'";
389 data->failed = true;
390 return;
391 }
392 data->current_path.resize(data->current_path.size() - path_suffix.size());
393}
394
David Zeuthenf3e28012014-08-26 18:23:52 -0400395// Callback function invoked by expat.
396//
397// This is called for entity declarations. Since Omaha is guaranteed
398// to never return any XML with entities our course of action is to
399// just stop parsing. This avoids potential resource exhaustion
400// problems AKA the "billion laughs". CVE-2013-0340.
401void ParserHandlerEntityDecl(void *user_data,
402 const XML_Char *entity_name,
403 int is_parameter_entity,
404 const XML_Char *value,
405 int value_length,
406 const XML_Char *base,
407 const XML_Char *system_id,
408 const XML_Char *public_id,
409 const XML_Char *notation_name) {
410 OmahaParserData* data = reinterpret_cast<OmahaParserData*>(user_data);
411
412 LOG(ERROR) << "XML entities are not supported. Aborting parsing.";
413 data->failed = true;
414 data->entity_decl = true;
415 XML_StopParser(data->xml_parser, false);
416}
417
David Zeuthene8ed8632014-07-24 13:38:10 -0400418} // namespace
419
420// Escapes text so it can be included as character data and attribute
421// values. The |input| string must be valid UTF-8.
rspangler@google.com49fdf182009-10-10 00:57:34 +0000422string XmlEncode(const string& input) {
David Zeuthene8ed8632014-07-24 13:38:10 -0400423 gchar* escaped = g_markup_escape_text(input.c_str(), input.size());
424 string ret = string(escaped);
425 g_free(escaped);
426 return ret;
rspangler@google.com49fdf182009-10-10 00:57:34 +0000427}
428
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800429OmahaRequestAction::OmahaRequestAction(SystemState* system_state,
Darin Petkova4a8a8c2010-07-15 22:21:12 -0700430 OmahaEvent* event,
Thieu Le116fda32011-04-19 11:01:54 -0700431 HttpFetcher* http_fetcher,
432 bool ping_only)
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800433 : system_state_(system_state),
Darin Petkova4a8a8c2010-07-15 22:21:12 -0700434 event_(event),
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700435 http_fetcher_(http_fetcher),
Thieu Le116fda32011-04-19 11:01:54 -0700436 ping_only_(ping_only),
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700437 ping_active_days_(0),
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700438 ping_roll_call_days_(0) {
439 params_ = system_state->request_params();
440}
rspangler@google.com49fdf182009-10-10 00:57:34 +0000441
Darin Petkov6a5b3222010-07-13 14:55:28 -0700442OmahaRequestAction::~OmahaRequestAction() {}
rspangler@google.com49fdf182009-10-10 00:57:34 +0000443
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700444// Calculates the value to use for the ping days parameter.
445int OmahaRequestAction::CalculatePingDays(const string& key) {
446 int days = kNeverPinged;
447 int64_t last_ping = 0;
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800448 if (system_state_->prefs()->GetInt64(key, &last_ping) && last_ping >= 0) {
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700449 days = (Time::Now() - Time::FromInternalValue(last_ping)).InDays();
450 if (days < 0) {
451 // If |days| is negative, then the system clock must have jumped
452 // back in time since the ping was sent. Mark the value so that
453 // it doesn't get sent to the server but we still update the
454 // last ping daystart preference. This way the next ping time
455 // will be correct, hopefully.
456 days = kPingTimeJump;
457 LOG(WARNING) <<
458 "System clock jumped back in time. Resetting ping daystarts.";
459 }
460 }
461 return days;
462}
463
464void OmahaRequestAction::InitPingDays() {
465 // We send pings only along with update checks, not with events.
466 if (IsEvent()) {
467 return;
468 }
469 // TODO(petkov): Figure a way to distinguish active use pings
470 // vs. roll call pings. Currently, the two pings are identical. A
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700471 // fix needs to change this code as well as UpdateLastPingDays and ShouldPing.
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700472 ping_active_days_ = CalculatePingDays(kPrefsLastActivePingDay);
473 ping_roll_call_days_ = CalculatePingDays(kPrefsLastRollCallPingDay);
474}
475
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700476bool OmahaRequestAction::ShouldPing() const {
477 if (ping_active_days_ == OmahaRequestAction::kNeverPinged &&
478 ping_roll_call_days_ == OmahaRequestAction::kNeverPinged) {
479 int powerwash_count = system_state_->hardware()->GetPowerwashCount();
480 if (powerwash_count > 0) {
481 LOG(INFO) << "Not sending ping with a=-1 r=-1 to omaha because "
482 << "powerwash_count is " << powerwash_count;
483 return false;
484 }
485 return true;
486 }
487 return ping_active_days_ > 0 || ping_roll_call_days_ > 0;
488}
489
David Zeuthen639aa362014-02-03 16:23:44 -0800490// static
491int OmahaRequestAction::GetInstallDate(SystemState* system_state) {
492 PrefsInterface* prefs = system_state->prefs();
Alex Vakulenko88b591f2014-08-28 16:48:57 -0700493 if (prefs == nullptr)
David Zeuthen639aa362014-02-03 16:23:44 -0800494 return -1;
495
496 // If we have the value stored on disk, just return it.
497 int64_t stored_value;
498 if (prefs->GetInt64(kPrefsInstallDateDays, &stored_value)) {
499 // Convert and sanity-check.
500 int install_date_days = static_cast<int>(stored_value);
501 if (install_date_days >= 0)
502 return install_date_days;
503 LOG(ERROR) << "Dropping stored Omaha InstallData since its value num_days="
504 << install_date_days << " looks suspicious.";
505 prefs->Delete(kPrefsInstallDateDays);
506 }
507
508 // Otherwise, if OOBE is not complete then do nothing and wait for
509 // ParseResponse() to call ParseInstallDate() and then
510 // PersistInstallDate() to set the kPrefsInstallDateDays state
511 // variable. Once that is done, we'll then report back in future
512 // Omaha requests. This works exactly because OOBE triggers an
513 // update check.
514 //
515 // However, if OOBE is complete and the kPrefsInstallDateDays state
516 // variable is not set, there are two possibilities
517 //
518 // 1. The update check in OOBE failed so we never got a response
519 // from Omaha (no network etc.); or
520 //
521 // 2. OOBE was done on an older version that didn't write to the
522 // kPrefsInstallDateDays state variable.
523 //
524 // In both cases, we approximate the install date by simply
525 // inspecting the timestamp of when OOBE happened.
526
527 Time time_of_oobe;
Alex Deymobccbc382014-04-03 13:38:55 -0700528 if (!system_state->hardware()->IsOOBEComplete(&time_of_oobe)) {
David Zeuthen639aa362014-02-03 16:23:44 -0800529 LOG(INFO) << "Not generating Omaha InstallData as we have "
530 << "no prefs file and OOBE is not complete.";
531 return -1;
532 }
533
534 int num_days;
535 if (!utils::ConvertToOmahaInstallDate(time_of_oobe, &num_days)) {
536 LOG(ERROR) << "Not generating Omaha InstallData from time of OOBE "
537 << "as its value '" << utils::ToString(time_of_oobe)
538 << "' looks suspicious.";
539 return -1;
540 }
541
542 // Persist this to disk, for future use.
543 if (!OmahaRequestAction::PersistInstallDate(system_state,
544 num_days,
545 kProvisionedFromOOBEMarker))
546 return -1;
547
548 LOG(INFO) << "Set the Omaha InstallDate from OOBE time-stamp to "
549 << num_days << " days";
550
551 return num_days;
552}
553
Darin Petkov6a5b3222010-07-13 14:55:28 -0700554void OmahaRequestAction::PerformAction() {
rspangler@google.com49fdf182009-10-10 00:57:34 +0000555 http_fetcher_->set_delegate(this);
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700556 InitPingDays();
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700557 if (ping_only_ && !ShouldPing()) {
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700558 processor_->ActionComplete(this, ErrorCode::kSuccess);
Thieu Leb44e9e82011-06-06 14:34:04 -0700559 return;
560 }
David Zeuthen639aa362014-02-03 16:23:44 -0800561
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700562 string request_post(GetRequestXml(event_.get(),
Jay Srinivasan1c0fe792013-03-28 16:45:25 -0700563 params_,
Thieu Le116fda32011-04-19 11:01:54 -0700564 ping_only_,
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700565 ShouldPing(), // include_ping
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700566 ping_active_days_,
Darin Petkov95508da2011-01-05 12:42:29 -0800567 ping_roll_call_days_,
David Zeuthen639aa362014-02-03 16:23:44 -0800568 GetInstallDate(system_state_),
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700569 system_state_));
Jay Srinivasan0a708742012-03-20 11:26:12 -0700570
Gilad Arnold9dd1e7c2012-02-16 12:13:36 -0800571 http_fetcher_->SetPostData(request_post.data(), request_post.size(),
572 kHttpContentTypeTextXml);
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700573 LOG(INFO) << "Posting an Omaha request to " << params_->update_url();
Andrew de los Reyesf98bff82010-05-06 13:33:25 -0700574 LOG(INFO) << "Request: " << request_post;
Jay Srinivasanae4697c2013-03-18 17:08:08 -0700575 http_fetcher_->BeginTransfer(params_->update_url());
rspangler@google.com49fdf182009-10-10 00:57:34 +0000576}
577
Darin Petkov6a5b3222010-07-13 14:55:28 -0700578void OmahaRequestAction::TerminateProcessing() {
rspangler@google.com49fdf182009-10-10 00:57:34 +0000579 http_fetcher_->TerminateTransfer();
580}
581
582// We just store the response in the buffer. Once we've received all bytes,
583// we'll look in the buffer and decide what to do.
Darin Petkov6a5b3222010-07-13 14:55:28 -0700584void OmahaRequestAction::ReceivedBytes(HttpFetcher *fetcher,
Alex Vakulenkof68bbbc2015-02-09 12:53:18 -0800585 const void* bytes,
586 size_t length) {
587 const uint8_t* byte_ptr = reinterpret_cast<const uint8_t*>(bytes);
588 response_buffer_.insert(response_buffer_.end(), byte_ptr, byte_ptr + length);
rspangler@google.com49fdf182009-10-10 00:57:34 +0000589}
590
591namespace {
rspangler@google.com49fdf182009-10-10 00:57:34 +0000592
593// Parses a 64 bit base-10 int from a string and returns it. Returns 0
594// on error. If the string contains "0", that's indistinguishable from
595// error.
596off_t ParseInt(const string& str) {
597 off_t ret = 0;
Gilad Arnoldec7f9162014-07-15 13:24:46 -0700598 int rc = sscanf(str.c_str(), "%" PRIi64, &ret); // NOLINT(runtime/printf)
rspangler@google.com49fdf182009-10-10 00:57:34 +0000599 if (rc < 1) {
600 // failure
601 return 0;
602 }
603 return ret;
604}
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700605
David Zeuthene8ed8632014-07-24 13:38:10 -0400606// Parses |str| and returns |true| if, and only if, its value is "true".
607bool ParseBool(const string& str) {
608 return str == "true";
609}
610
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700611// Update the last ping day preferences based on the server daystart
612// response. Returns true on success, false otherwise.
David Zeuthene8ed8632014-07-24 13:38:10 -0400613bool UpdateLastPingDays(OmahaParserData *parser_data, PrefsInterface* prefs) {
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700614 int64_t elapsed_seconds = 0;
David Zeuthene8ed8632014-07-24 13:38:10 -0400615 TEST_AND_RETURN_FALSE(
616 base::StringToInt64(parser_data->daystart_elapsed_seconds,
617 &elapsed_seconds));
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700618 TEST_AND_RETURN_FALSE(elapsed_seconds >= 0);
619
620 // Remember the local time that matches the server's last midnight
621 // time.
622 Time daystart = Time::Now() - TimeDelta::FromSeconds(elapsed_seconds);
623 prefs->SetInt64(kPrefsLastActivePingDay, daystart.ToInternalValue());
624 prefs->SetInt64(kPrefsLastRollCallPingDay, daystart.ToInternalValue());
625 return true;
626}
Alex Vakulenkod2779df2014-06-16 13:19:00 -0700627} // namespace
rspangler@google.com49fdf182009-10-10 00:57:34 +0000628
David Zeuthene8ed8632014-07-24 13:38:10 -0400629bool OmahaRequestAction::ParseResponse(OmahaParserData* parser_data,
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700630 OmahaResponse* output_object,
631 ScopedActionCompleter* completer) {
David Zeuthene8ed8632014-07-24 13:38:10 -0400632 if (parser_data->updatecheck_status.empty()) {
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700633 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700634 return false;
635 }
636
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800637 // chromium-os:37289: The PollInterval is not supported by Omaha server
638 // currently. But still keeping this existing code in case we ever decide to
Gilad Arnoldec7f9162014-07-15 13:24:46 -0700639 // slow down the request rate from the server-side. Note that the PollInterval
640 // is not persisted, so it has to be sent by the server on every response to
641 // guarantee that the scheduler uses this value (otherwise, if the device got
642 // rebooted after the last server-indicated value, it'll revert to the default
643 // value). Also kDefaultMaxUpdateChecks value for the scattering logic is
644 // based on the assumption that we perform an update check every hour so that
645 // the max value of 8 will roughly be equivalent to one work day. If we decide
646 // to use PollInterval permanently, we should update the
647 // max_update_checks_allowed to take PollInterval into account. Note: The
648 // parsing for PollInterval happens even before parsing of the status because
649 // we may want to specify the PollInterval even when there's no update.
David Zeuthene8ed8632014-07-24 13:38:10 -0400650 base::StringToInt(parser_data->updatecheck_poll_interval,
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700651 &output_object->poll_interval);
652
David Zeuthen639aa362014-02-03 16:23:44 -0800653 // Check for the "elapsed_days" attribute in the "daystart"
654 // element. This is the number of days since Jan 1 2007, 0:00
655 // PST. If we don't have a persisted value of the Omaha InstallDate,
656 // we'll use it to calculate it and then persist it.
David Zeuthene8ed8632014-07-24 13:38:10 -0400657 if (ParseInstallDate(parser_data, output_object) &&
658 !HasInstallDate(system_state_)) {
David Zeuthen639aa362014-02-03 16:23:44 -0800659 // Since output_object->install_date_days is never negative, the
660 // elapsed_days -> install-date calculation is reduced to simply
661 // rounding down to the nearest number divisible by 7.
662 int remainder = output_object->install_date_days % 7;
663 int install_date_days_rounded =
664 output_object->install_date_days - remainder;
665 if (PersistInstallDate(system_state_,
666 install_date_days_rounded,
667 kProvisionedFromOmahaResponse)) {
668 LOG(INFO) << "Set the Omaha InstallDate from Omaha Response to "
669 << install_date_days_rounded << " days";
670 }
671 }
672
David Zeuthene8ed8632014-07-24 13:38:10 -0400673 if (!ParseStatus(parser_data, output_object, completer))
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700674 return false;
675
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800676 // Note: ParseUrls MUST be called before ParsePackage as ParsePackage
677 // appends the package name to the URLs populated in this method.
David Zeuthene8ed8632014-07-24 13:38:10 -0400678 if (!ParseUrls(parser_data, output_object, completer))
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700679 return false;
680
David Zeuthene8ed8632014-07-24 13:38:10 -0400681 if (!ParsePackage(parser_data, output_object, completer))
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700682 return false;
683
David Zeuthene8ed8632014-07-24 13:38:10 -0400684 if (!ParseParams(parser_data, output_object, completer))
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700685 return false;
686
Alex Deymo8e18f932015-03-27 16:16:59 -0700687 if (parser_data->app_cohort_set)
688 PersistCohortData(kPrefsOmahaCohort, parser_data->app_cohort);
689 if (parser_data->app_cohorthint_set)
690 PersistCohortData(kPrefsOmahaCohortHint, parser_data->app_cohorthint);
691 if (parser_data->app_cohortname_set)
692 PersistCohortData(kPrefsOmahaCohortName, parser_data->app_cohortname);
693
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700694 return true;
695}
696
David Zeuthene8ed8632014-07-24 13:38:10 -0400697bool OmahaRequestAction::ParseStatus(OmahaParserData* parser_data,
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700698 OmahaResponse* output_object,
699 ScopedActionCompleter* completer) {
David Zeuthene8ed8632014-07-24 13:38:10 -0400700 const string& status = parser_data->updatecheck_status;
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700701 if (status == "noupdate") {
702 LOG(INFO) << "No update.";
703 output_object->update_exists = false;
704 SetOutputObject(*output_object);
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700705 completer->set_code(ErrorCode::kSuccess);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700706 return false;
707 }
708
709 if (status != "ok") {
710 LOG(ERROR) << "Unknown Omaha response status: " << status;
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700711 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700712 return false;
713 }
714
715 return true;
716}
717
David Zeuthene8ed8632014-07-24 13:38:10 -0400718bool OmahaRequestAction::ParseUrls(OmahaParserData* parser_data,
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700719 OmahaResponse* output_object,
720 ScopedActionCompleter* completer) {
David Zeuthene8ed8632014-07-24 13:38:10 -0400721 if (parser_data->url_codebase.empty()) {
722 LOG(ERROR) << "No Omaha Response URLs";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700723 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700724 return false;
725 }
726
David Zeuthene8ed8632014-07-24 13:38:10 -0400727 LOG(INFO) << "Found " << parser_data->url_codebase.size() << " url(s)";
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800728 output_object->payload_urls.clear();
David Zeuthene8ed8632014-07-24 13:38:10 -0400729 for (const auto& codebase : parser_data->url_codebase) {
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800730 if (codebase.empty()) {
731 LOG(ERROR) << "Omaha Response URL has empty codebase";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700732 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800733 return false;
734 }
735 output_object->payload_urls.push_back(codebase);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700736 }
737
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700738 return true;
739}
740
David Zeuthene8ed8632014-07-24 13:38:10 -0400741bool OmahaRequestAction::ParsePackage(OmahaParserData* parser_data,
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700742 OmahaResponse* output_object,
743 ScopedActionCompleter* completer) {
David Zeuthene8ed8632014-07-24 13:38:10 -0400744 if (parser_data->package_name.empty()) {
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700745 LOG(ERROR) << "Omaha Response has empty package name";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700746 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700747 return false;
748 }
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800749
750 // Append the package name to each URL in our list so that we don't
751 // propagate the urlBase vs packageName distinctions beyond this point.
752 // From now on, we only need to use payload_urls.
David Zeuthene8ed8632014-07-24 13:38:10 -0400753 for (auto& payload_url : output_object->payload_urls)
754 payload_url += parser_data->package_name;
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700755
756 // Parse the payload size.
David Zeuthene8ed8632014-07-24 13:38:10 -0400757 off_t size = ParseInt(parser_data->package_size);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700758 if (size <= 0) {
759 LOG(ERROR) << "Omaha Response has invalid payload size: " << size;
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700760 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700761 return false;
762 }
763 output_object->size = size;
764
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800765 LOG(INFO) << "Payload size = " << output_object->size << " bytes";
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700766
767 return true;
768}
769
David Zeuthene8ed8632014-07-24 13:38:10 -0400770bool OmahaRequestAction::ParseParams(OmahaParserData* parser_data,
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700771 OmahaResponse* output_object,
772 ScopedActionCompleter* completer) {
David Zeuthene8ed8632014-07-24 13:38:10 -0400773 output_object->version = parser_data->manifest_version;
Chris Sosa3b748432013-06-20 16:42:59 -0700774 if (output_object->version.empty()) {
Chris Sosaaa18e162013-06-20 13:20:30 -0700775 LOG(ERROR) << "Omaha Response does not have version in manifest!";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700776 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Chris Sosa3b748432013-06-20 16:42:59 -0700777 return false;
778 }
779
780 LOG(INFO) << "Received omaha response to update to version "
781 << output_object->version;
782
David Zeuthene8ed8632014-07-24 13:38:10 -0400783 map<string, string> attrs = parser_data->action_postinstall_attrs;
784 if (attrs.empty()) {
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700785 LOG(ERROR) << "Omaha Response has no postinstall event action";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700786 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700787 return false;
788 }
789
David Zeuthene8ed8632014-07-24 13:38:10 -0400790 output_object->hash = attrs[kTagSha256];
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700791 if (output_object->hash.empty()) {
792 LOG(ERROR) << "Omaha Response has empty sha256 value";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700793 completer->set_code(ErrorCode::kOmahaResponseInvalid);
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700794 return false;
795 }
796
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800797 // Get the optional properties one by one.
David Zeuthene8ed8632014-07-24 13:38:10 -0400798 output_object->more_info_url = attrs[kTagMoreInfo];
799 output_object->metadata_size = ParseInt(attrs[kTagMetadataSize]);
800 output_object->metadata_signature = attrs[kTagMetadataSignatureRsa];
801 output_object->prompt = ParseBool(attrs[kTagPrompt]);
802 output_object->deadline = attrs[kTagDeadline];
803 output_object->max_days_to_scatter = ParseInt(attrs[kTagMaxDaysToScatter]);
David Zeuthen8f191b22013-08-06 12:27:50 -0700804 output_object->disable_p2p_for_downloading =
David Zeuthene8ed8632014-07-24 13:38:10 -0400805 ParseBool(attrs[kTagDisableP2PForDownloading]);
David Zeuthen8f191b22013-08-06 12:27:50 -0700806 output_object->disable_p2p_for_sharing =
David Zeuthene8ed8632014-07-24 13:38:10 -0400807 ParseBool(attrs[kTagDisableP2PForSharing]);
808 output_object->public_key_rsa = attrs[kTagPublicKeyRsa];
Jay Srinivasan2b5a0f02012-12-19 17:25:56 -0800809
David Zeuthene8ed8632014-07-24 13:38:10 -0400810 string max = attrs[kTagMaxFailureCountPerUrl];
Jay Srinivasan08262882012-12-28 19:29:43 -0800811 if (!base::StringToUint(max, &output_object->max_failure_count_per_url))
Jay Srinivasan2b5a0f02012-12-19 17:25:56 -0800812 output_object->max_failure_count_per_url = kDefaultMaxFailureCountPerUrl;
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700813
David Zeuthene8ed8632014-07-24 13:38:10 -0400814 output_object->is_delta_payload = ParseBool(attrs[kTagIsDeltaPayload]);
Jay Srinivasan08262882012-12-28 19:29:43 -0800815
816 output_object->disable_payload_backoff =
David Zeuthene8ed8632014-07-24 13:38:10 -0400817 ParseBool(attrs[kTagDisablePayloadBackoff]);
Jay Srinivasan08262882012-12-28 19:29:43 -0800818
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700819 return true;
820}
821
David Zeuthene8ed8632014-07-24 13:38:10 -0400822// If the transfer was successful, this uses expat to parse the response
rspangler@google.com49fdf182009-10-10 00:57:34 +0000823// and fill in the appropriate fields of the output object. Also, notifies
824// the processor that we're done.
Darin Petkov6a5b3222010-07-13 14:55:28 -0700825void OmahaRequestAction::TransferComplete(HttpFetcher *fetcher,
826 bool successful) {
rspangler@google.com49fdf182009-10-10 00:57:34 +0000827 ScopedActionCompleter completer(processor_, this);
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800828 string current_response(response_buffer_.begin(), response_buffer_.end());
829 LOG(INFO) << "Omaha request response: " << current_response;
Darin Petkov0dc8e9a2010-07-14 14:51:57 -0700830
Gilad Arnold74b5f552014-10-07 08:17:16 -0700831 PayloadStateInterface* const payload_state = system_state_->payload_state();
832
Darin Petkov0dc8e9a2010-07-14 14:51:57 -0700833 // Events are best effort transactions -- assume they always succeed.
834 if (IsEvent()) {
835 CHECK(!HasOutputPipe()) << "No output pipe allowed for event requests.";
Andrew de los Reyes2008e4c2011-01-12 10:17:52 -0800836 if (event_->result == OmahaEvent::kResultError && successful &&
J. Richard Barnette056b0ab2013-10-29 15:24:56 -0700837 system_state_->hardware()->IsOfficialBuild()) {
Andrew de los Reyes2008e4c2011-01-12 10:17:52 -0800838 LOG(INFO) << "Signalling Crash Reporter.";
839 utils::ScheduleCrashReporterUpload();
840 }
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700841 completer.set_code(ErrorCode::kSuccess);
Darin Petkov0dc8e9a2010-07-14 14:51:57 -0700842 return;
843 }
844
Andrew de los Reyesf98bff82010-05-06 13:33:25 -0700845 if (!successful) {
Darin Petkov0dc8e9a2010-07-14 14:51:57 -0700846 LOG(ERROR) << "Omaha request network transfer failed.";
Darin Petkovedc522e2010-11-05 09:35:17 -0700847 int code = GetHTTPResponseCode();
848 // Makes sure we send sane error values.
849 if (code < 0 || code >= 1000) {
850 code = 999;
851 }
David Zeuthena99981f2013-04-29 13:42:47 -0700852 completer.set_code(static_cast<ErrorCode>(
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700853 static_cast<int>(ErrorCode::kOmahaRequestHTTPResponseBase) + code));
rspangler@google.com49fdf182009-10-10 00:57:34 +0000854 return;
Andrew de los Reyesf98bff82010-05-06 13:33:25 -0700855 }
rspangler@google.com49fdf182009-10-10 00:57:34 +0000856
David Zeuthene8ed8632014-07-24 13:38:10 -0400857 XML_Parser parser = XML_ParserCreate(nullptr);
David Zeuthenf3e28012014-08-26 18:23:52 -0400858 OmahaParserData parser_data(parser);
David Zeuthene8ed8632014-07-24 13:38:10 -0400859 XML_SetUserData(parser, &parser_data);
860 XML_SetElementHandler(parser, ParserHandlerStart, ParserHandlerEnd);
David Zeuthenf3e28012014-08-26 18:23:52 -0400861 XML_SetEntityDeclHandler(parser, ParserHandlerEntityDecl);
Alex Vakulenkof68bbbc2015-02-09 12:53:18 -0800862 XML_Status res = XML_Parse(
863 parser,
864 reinterpret_cast<const char*>(response_buffer_.data()),
865 response_buffer_.size(),
866 XML_TRUE);
David Zeuthene8ed8632014-07-24 13:38:10 -0400867 XML_ParserFree(parser);
868
869 if (res != XML_STATUS_OK || parser_data.failed) {
rspangler@google.com49fdf182009-10-10 00:57:34 +0000870 LOG(ERROR) << "Omaha response not valid XML";
David Zeuthenf3e28012014-08-26 18:23:52 -0400871 ErrorCode error_code = ErrorCode::kOmahaRequestXMLParseError;
872 if (response_buffer_.empty()) {
873 error_code = ErrorCode::kOmahaRequestEmptyResponseError;
874 } else if (parser_data.entity_decl) {
875 error_code = ErrorCode::kOmahaRequestXMLHasEntityDecl;
876 }
877 completer.set_code(error_code);
rspangler@google.com49fdf182009-10-10 00:57:34 +0000878 return;
879 }
880
Alex Deymoebbe7ef2014-10-30 13:02:49 -0700881 // Update the last ping day preferences based on the server daystart response
882 // even if we didn't send a ping. Omaha always includes the daystart in the
883 // response, but log the error if it didn't.
884 LOG_IF(ERROR, !UpdateLastPingDays(&parser_data, system_state_->prefs()))
885 << "Failed to update the last ping day preferences!";
Darin Petkov1cbd78f2010-07-29 12:38:34 -0700886
Thieu Le116fda32011-04-19 11:01:54 -0700887 if (!HasOutputPipe()) {
888 // Just set success to whether or not the http transfer succeeded,
889 // which must be true at this point in the code.
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700890 completer.set_code(ErrorCode::kSuccess);
Thieu Le116fda32011-04-19 11:01:54 -0700891 return;
892 }
893
Darin Petkov6a5b3222010-07-13 14:55:28 -0700894 OmahaResponse output_object;
David Zeuthene8ed8632014-07-24 13:38:10 -0400895 if (!ParseResponse(&parser_data, &output_object, &completer))
rspangler@google.com49fdf182009-10-10 00:57:34 +0000896 return;
David Zeuthen8f191b22013-08-06 12:27:50 -0700897 output_object.update_exists = true;
898 SetOutputObject(output_object);
rspangler@google.com49fdf182009-10-10 00:57:34 +0000899
Chris Sosa77f79e82014-06-02 18:16:24 -0700900 if (ShouldIgnoreUpdate(output_object)) {
Jay Srinivasan23b92a52012-10-27 02:00:21 -0700901 output_object.update_exists = false;
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700902 completer.set_code(ErrorCode::kOmahaUpdateIgnoredPerPolicy);
Jay Srinivasan0a708742012-03-20 11:26:12 -0700903 return;
904 }
905
David Zeuthen8f191b22013-08-06 12:27:50 -0700906 // If Omaha says to disable p2p, respect that
907 if (output_object.disable_p2p_for_downloading) {
908 LOG(INFO) << "Forcibly disabling use of p2p for downloading as "
909 << "requested by Omaha.";
Gilad Arnold74b5f552014-10-07 08:17:16 -0700910 payload_state->SetUsingP2PForDownloading(false);
David Zeuthen8f191b22013-08-06 12:27:50 -0700911 }
912 if (output_object.disable_p2p_for_sharing) {
913 LOG(INFO) << "Forcibly disabling use of p2p for sharing as "
914 << "requested by Omaha.";
Gilad Arnold74b5f552014-10-07 08:17:16 -0700915 payload_state->SetUsingP2PForSharing(false);
Jay Srinivasan480ddfa2012-06-01 19:15:26 -0700916 }
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800917
918 // Update the payload state with the current response. The payload state
919 // will automatically reset all stale state if this response is different
Jay Srinivasan08262882012-12-28 19:29:43 -0800920 // from what's stored already. We are updating the payload state as late
921 // as possible in this method so that if a new release gets pushed and then
922 // got pulled back due to some issues, we don't want to clear our internal
923 // state unnecessarily.
Jay Srinivasan6f6ea002012-12-14 11:26:28 -0800924 payload_state->SetResponse(output_object);
Jay Srinivasan08262882012-12-28 19:29:43 -0800925
David Zeuthen8f191b22013-08-06 12:27:50 -0700926 // It could be we've already exceeded the deadline for when p2p is
927 // allowed or that we've tried too many times with p2p. Check that.
Gilad Arnold74b5f552014-10-07 08:17:16 -0700928 if (payload_state->GetUsingP2PForDownloading()) {
David Zeuthen8f191b22013-08-06 12:27:50 -0700929 payload_state->P2PNewAttempt();
930 if (!payload_state->P2PAttemptAllowed()) {
931 LOG(INFO) << "Forcibly disabling use of p2p for downloading because "
932 << "of previous failures when using p2p.";
Gilad Arnold74b5f552014-10-07 08:17:16 -0700933 payload_state->SetUsingP2PForDownloading(false);
David Zeuthen8f191b22013-08-06 12:27:50 -0700934 }
935 }
936
937 // From here on, we'll complete stuff in CompleteProcessing() so
938 // disable |completer| since we'll create a new one in that
939 // function.
940 completer.set_should_complete(false);
941
942 // If we're allowed to use p2p for downloading we do not pay
943 // attention to wall-clock-based waiting if the URL is indeed
944 // available via p2p. Therefore, check if the file is available via
945 // p2p before deferring...
Gilad Arnold74b5f552014-10-07 08:17:16 -0700946 if (payload_state->GetUsingP2PForDownloading()) {
David Zeuthen8f191b22013-08-06 12:27:50 -0700947 LookupPayloadViaP2P(output_object);
948 } else {
949 CompleteProcessing();
950 }
951}
952
953void OmahaRequestAction::CompleteProcessing() {
954 ScopedActionCompleter completer(processor_, this);
955 OmahaResponse& output_object = const_cast<OmahaResponse&>(GetOutputObject());
956 PayloadStateInterface* payload_state = system_state_->payload_state();
957
958 if (ShouldDeferDownload(&output_object)) {
Jay Srinivasan08262882012-12-28 19:29:43 -0800959 output_object.update_exists = false;
David Zeuthen8f191b22013-08-06 12:27:50 -0700960 LOG(INFO) << "Ignoring Omaha updates as updates are deferred by policy.";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700961 completer.set_code(ErrorCode::kOmahaUpdateDeferredPerPolicy);
Jay Srinivasan08262882012-12-28 19:29:43 -0800962 return;
963 }
David Zeuthen8f191b22013-08-06 12:27:50 -0700964
Chris Sosa20f005c2013-09-05 13:53:08 -0700965 if (payload_state->ShouldBackoffDownload()) {
966 output_object.update_exists = false;
967 LOG(INFO) << "Ignoring Omaha updates in order to backoff our retry "
968 << "attempts";
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700969 completer.set_code(ErrorCode::kOmahaUpdateDeferredForBackoff);
Chris Sosa20f005c2013-09-05 13:53:08 -0700970 return;
David Zeuthen8f191b22013-08-06 12:27:50 -0700971 }
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -0700972 completer.set_code(ErrorCode::kSuccess);
David Zeuthen8f191b22013-08-06 12:27:50 -0700973}
974
975void OmahaRequestAction::OnLookupPayloadViaP2PCompleted(const string& url) {
976 LOG(INFO) << "Lookup complete, p2p-client returned URL '" << url << "'";
977 if (!url.empty()) {
Gilad Arnold74b5f552014-10-07 08:17:16 -0700978 system_state_->payload_state()->SetP2PUrl(url);
David Zeuthen8f191b22013-08-06 12:27:50 -0700979 } else {
980 LOG(INFO) << "Forcibly disabling use of p2p for downloading "
981 << "because no suitable peer could be found.";
Gilad Arnold74b5f552014-10-07 08:17:16 -0700982 system_state_->payload_state()->SetUsingP2PForDownloading(false);
David Zeuthen8f191b22013-08-06 12:27:50 -0700983 }
984 CompleteProcessing();
985}
986
987void OmahaRequestAction::LookupPayloadViaP2P(const OmahaResponse& response) {
David Zeuthen41996ad2013-09-24 15:43:24 -0700988 // If the device is in the middle of an update, the state variables
989 // kPrefsUpdateStateNextDataOffset, kPrefsUpdateStateNextDataLength
990 // tracks the offset and length of the operation currently in
991 // progress. The offset is based from the end of the manifest which
992 // is kPrefsManifestMetadataSize bytes long.
993 //
994 // To make forward progress and avoid deadlocks, we need to find a
995 // peer that has at least the entire operation we're currently
996 // working on. Otherwise we may end up in a situation where two
997 // devices bounce back and forth downloading from each other,
998 // neither making any forward progress until one of them decides to
999 // stop using p2p (via kMaxP2PAttempts and kMaxP2PAttemptTimeSeconds
1000 // safe-guards). See http://crbug.com/297170 for an example)
David Zeuthen8f191b22013-08-06 12:27:50 -07001001 size_t minimum_size = 0;
David Zeuthen41996ad2013-09-24 15:43:24 -07001002 int64_t manifest_metadata_size = 0;
1003 int64_t next_data_offset = 0;
1004 int64_t next_data_length = 0;
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001005 if (system_state_ &&
David Zeuthen41996ad2013-09-24 15:43:24 -07001006 system_state_->prefs()->GetInt64(kPrefsManifestMetadataSize,
1007 &manifest_metadata_size) &&
1008 manifest_metadata_size != -1 &&
David Zeuthen8f191b22013-08-06 12:27:50 -07001009 system_state_->prefs()->GetInt64(kPrefsUpdateStateNextDataOffset,
David Zeuthen41996ad2013-09-24 15:43:24 -07001010 &next_data_offset) &&
1011 next_data_offset != -1 &&
1012 system_state_->prefs()->GetInt64(kPrefsUpdateStateNextDataLength,
1013 &next_data_length)) {
1014 minimum_size = manifest_metadata_size + next_data_offset + next_data_length;
David Zeuthen8f191b22013-08-06 12:27:50 -07001015 }
1016
1017 string file_id = utils::CalculateP2PFileId(response.hash, response.size);
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001018 if (system_state_->p2p_manager()) {
David Zeuthen8f191b22013-08-06 12:27:50 -07001019 LOG(INFO) << "Checking if payload is available via p2p, file_id="
1020 << file_id << " minimum_size=" << minimum_size;
1021 system_state_->p2p_manager()->LookupUrlForFile(
1022 file_id,
1023 minimum_size,
David Zeuthen4cc5ed22014-01-15 12:35:03 -08001024 TimeDelta::FromSeconds(kMaxP2PNetworkWaitTimeSeconds),
David Zeuthen8f191b22013-08-06 12:27:50 -07001025 base::Bind(&OmahaRequestAction::OnLookupPayloadViaP2PCompleted,
1026 base::Unretained(this)));
1027 }
rspangler@google.com49fdf182009-10-10 00:57:34 +00001028}
1029
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001030bool OmahaRequestAction::ShouldDeferDownload(OmahaResponse* output_object) {
Chris Sosa968d0572013-08-23 14:46:02 -07001031 if (params_->interactive()) {
1032 LOG(INFO) << "Not deferring download because update is interactive.";
1033 return false;
1034 }
1035
David Zeuthen8f191b22013-08-06 12:27:50 -07001036 // If we're using p2p to download _and_ we have a p2p URL, we never
1037 // defer the download. This is because the download will always
1038 // happen from a peer on the LAN and we've been waiting in line for
1039 // our turn.
Gilad Arnold74b5f552014-10-07 08:17:16 -07001040 const PayloadStateInterface* payload_state = system_state_->payload_state();
1041 if (payload_state->GetUsingP2PForDownloading() &&
1042 !payload_state->GetP2PUrl().empty()) {
David Zeuthen8f191b22013-08-06 12:27:50 -07001043 LOG(INFO) << "Download not deferred because download "
1044 << "will happen from a local peer (via p2p).";
1045 return false;
1046 }
1047
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001048 // We should defer the downloads only if we've first satisfied the
1049 // wall-clock-based-waiting period and then the update-check-based waiting
1050 // period, if required.
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001051 if (!params_->wall_clock_based_wait_enabled()) {
Chris Sosa968d0572013-08-23 14:46:02 -07001052 LOG(INFO) << "Wall-clock-based waiting period is not enabled,"
1053 << " so no deferring needed.";
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001054 return false;
1055 }
1056
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001057 switch (IsWallClockBasedWaitingSatisfied(output_object)) {
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001058 case kWallClockWaitNotSatisfied:
1059 // We haven't even satisfied the first condition, passing the
1060 // wall-clock-based waiting period, so we should defer the downloads
1061 // until that happens.
1062 LOG(INFO) << "wall-clock-based-wait not satisfied.";
1063 return true;
1064
1065 case kWallClockWaitDoneButUpdateCheckWaitRequired:
1066 LOG(INFO) << "wall-clock-based-wait satisfied and "
1067 << "update-check-based-wait required.";
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001068 return !IsUpdateCheckCountBasedWaitingSatisfied();
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001069
1070 case kWallClockWaitDoneAndUpdateCheckWaitNotRequired:
1071 // Wall-clock-based waiting period is satisfied, and it's determined
1072 // that we do not need the update-check-based wait. so no need to
1073 // defer downloads.
1074 LOG(INFO) << "wall-clock-based-wait satisfied and "
1075 << "update-check-based-wait is not required.";
1076 return false;
1077
1078 default:
1079 // Returning false for this default case so we err on the
1080 // side of downloading updates than deferring in case of any bugs.
1081 NOTREACHED();
1082 return false;
1083 }
1084}
1085
1086OmahaRequestAction::WallClockWaitResult
1087OmahaRequestAction::IsWallClockBasedWaitingSatisfied(
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001088 OmahaResponse* output_object) {
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001089 Time update_first_seen_at;
Ben Chan9abb7632014-08-07 00:10:53 -07001090 int64_t update_first_seen_at_int;
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001091
Jay Srinivasan6f6ea002012-12-14 11:26:28 -08001092 if (system_state_->prefs()->Exists(kPrefsUpdateFirstSeenAt)) {
1093 if (system_state_->prefs()->GetInt64(kPrefsUpdateFirstSeenAt,
1094 &update_first_seen_at_int)) {
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001095 // Note: This timestamp could be that of ANY update we saw in the past
1096 // (not necessarily this particular update we're considering to apply)
1097 // but never got to apply because of some reason (e.g. stop AU policy,
1098 // updates being pulled out from Omaha, changes in target version prefix,
1099 // new update being rolled out, etc.). But for the purposes of scattering
1100 // it doesn't matter which update the timestamp corresponds to. i.e.
1101 // the clock starts ticking the first time we see an update and we're
1102 // ready to apply when the random wait period is satisfied relative to
1103 // that first seen timestamp.
1104 update_first_seen_at = Time::FromInternalValue(update_first_seen_at_int);
1105 LOG(INFO) << "Using persisted value of UpdateFirstSeenAt: "
1106 << utils::ToString(update_first_seen_at);
1107 } else {
1108 // This seems like an unexpected error where the persisted value exists
1109 // but it's not readable for some reason. Just skip scattering in this
1110 // case to be safe.
1111 LOG(INFO) << "Not scattering as UpdateFirstSeenAt value cannot be read";
1112 return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
1113 }
1114 } else {
1115 update_first_seen_at = Time::Now();
1116 update_first_seen_at_int = update_first_seen_at.ToInternalValue();
Jay Srinivasan6f6ea002012-12-14 11:26:28 -08001117 if (system_state_->prefs()->SetInt64(kPrefsUpdateFirstSeenAt,
1118 update_first_seen_at_int)) {
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001119 LOG(INFO) << "Persisted the new value for UpdateFirstSeenAt: "
1120 << utils::ToString(update_first_seen_at);
Alex Vakulenkod2779df2014-06-16 13:19:00 -07001121 } else {
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001122 // This seems like an unexpected error where the value cannot be
1123 // persisted for some reason. Just skip scattering in this
1124 // case to be safe.
1125 LOG(INFO) << "Not scattering as UpdateFirstSeenAt value "
1126 << utils::ToString(update_first_seen_at)
1127 << " cannot be persisted";
1128 return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
1129 }
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001130 }
1131
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001132 TimeDelta elapsed_time = Time::Now() - update_first_seen_at;
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001133 TimeDelta max_scatter_period = TimeDelta::FromDays(
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001134 output_object->max_days_to_scatter);
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001135
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001136 LOG(INFO) << "Waiting Period = "
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001137 << utils::FormatSecs(params_->waiting_period().InSeconds())
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001138 << ", Time Elapsed = "
1139 << utils::FormatSecs(elapsed_time.InSeconds())
1140 << ", MaxDaysToScatter = "
1141 << max_scatter_period.InDays();
1142
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001143 if (!output_object->deadline.empty()) {
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001144 // The deadline is set for all rules which serve a delta update from a
1145 // previous FSI, which means this update will be applied mostly in OOBE
1146 // cases. For these cases, we shouldn't scatter so as to finish the OOBE
1147 // quickly.
1148 LOG(INFO) << "Not scattering as deadline flag is set";
1149 return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
1150 }
1151
1152 if (max_scatter_period.InDays() == 0) {
1153 // This means the Omaha rule creator decides that this rule
1154 // should not be scattered irrespective of the policy.
1155 LOG(INFO) << "Not scattering as MaxDaysToScatter in rule is 0.";
1156 return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
1157 }
1158
1159 if (elapsed_time > max_scatter_period) {
Jay Srinivasan34b5d862012-07-23 11:43:22 -07001160 // This means we've waited more than the upperbound wait in the rule
1161 // from the time we first saw a valid update available to us.
1162 // This will prevent update starvation.
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001163 LOG(INFO) << "Not scattering as we're past the MaxDaysToScatter limit.";
1164 return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
1165 }
1166
1167 // This means we are required to participate in scattering.
1168 // See if our turn has arrived now.
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001169 TimeDelta remaining_wait_time = params_->waiting_period() - elapsed_time;
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001170 if (remaining_wait_time.InSeconds() <= 0) {
1171 // Yes, it's our turn now.
1172 LOG(INFO) << "Successfully passed the wall-clock-based-wait.";
1173
1174 // But we can't download until the update-check-count-based wait is also
1175 // satisfied, so mark it as required now if update checks are enabled.
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001176 return params_->update_check_count_wait_enabled() ?
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001177 kWallClockWaitDoneButUpdateCheckWaitRequired :
1178 kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
1179 }
1180
1181 // Not our turn yet, so we have to wait until our turn to
1182 // help scatter the downloads across all clients of the enterprise.
1183 LOG(INFO) << "Update deferred for another "
1184 << utils::FormatSecs(remaining_wait_time.InSeconds())
1185 << " per policy.";
1186 return kWallClockWaitNotSatisfied;
1187}
1188
Jay Srinivasan23b92a52012-10-27 02:00:21 -07001189bool OmahaRequestAction::IsUpdateCheckCountBasedWaitingSatisfied() {
Ben Chan9abb7632014-08-07 00:10:53 -07001190 int64_t update_check_count_value;
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001191
Jay Srinivasan6f6ea002012-12-14 11:26:28 -08001192 if (system_state_->prefs()->Exists(kPrefsUpdateCheckCount)) {
1193 if (!system_state_->prefs()->GetInt64(kPrefsUpdateCheckCount,
1194 &update_check_count_value)) {
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001195 // We are unable to read the update check count from file for some reason.
1196 // So let's proceed anyway so as to not stall the update.
1197 LOG(ERROR) << "Unable to read update check count. "
1198 << "Skipping update-check-count-based-wait.";
1199 return true;
1200 }
1201 } else {
1202 // This file does not exist. This means we haven't started our update
1203 // check count down yet, so this is the right time to start the count down.
1204 update_check_count_value = base::RandInt(
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001205 params_->min_update_checks_needed(),
1206 params_->max_update_checks_allowed());
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001207
1208 LOG(INFO) << "Randomly picked update check count value = "
1209 << update_check_count_value;
1210
1211 // Write out the initial value of update_check_count_value.
Jay Srinivasan6f6ea002012-12-14 11:26:28 -08001212 if (!system_state_->prefs()->SetInt64(kPrefsUpdateCheckCount,
1213 update_check_count_value)) {
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001214 // We weren't able to write the update check count file for some reason.
1215 // So let's proceed anyway so as to not stall the update.
1216 LOG(ERROR) << "Unable to write update check count. "
1217 << "Skipping update-check-count-based-wait.";
1218 return true;
1219 }
1220 }
1221
1222 if (update_check_count_value == 0) {
1223 LOG(INFO) << "Successfully passed the update-check-based-wait.";
1224 return true;
1225 }
1226
1227 if (update_check_count_value < 0 ||
Jay Srinivasanae4697c2013-03-18 17:08:08 -07001228 update_check_count_value > params_->max_update_checks_allowed()) {
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001229 // We err on the side of skipping scattering logic instead of stalling
1230 // a machine from receiving any updates in case of any unexpected state.
1231 LOG(ERROR) << "Invalid value for update check count detected. "
1232 << "Skipping update-check-count-based-wait.";
1233 return true;
1234 }
1235
1236 // Legal value, we need to wait for more update checks to happen
1237 // until this becomes 0.
1238 LOG(INFO) << "Deferring Omaha updates for another "
1239 << update_check_count_value
1240 << " update checks per policy";
1241 return false;
1242}
1243
David Zeuthen639aa362014-02-03 16:23:44 -08001244// static
David Zeuthene8ed8632014-07-24 13:38:10 -04001245bool OmahaRequestAction::ParseInstallDate(OmahaParserData* parser_data,
David Zeuthen639aa362014-02-03 16:23:44 -08001246 OmahaResponse* output_object) {
David Zeuthen639aa362014-02-03 16:23:44 -08001247 int64_t elapsed_days = 0;
David Zeuthene8ed8632014-07-24 13:38:10 -04001248 if (!base::StringToInt64(parser_data->daystart_elapsed_days,
David Zeuthen639aa362014-02-03 16:23:44 -08001249 &elapsed_days))
1250 return false;
1251
1252 if (elapsed_days < 0)
1253 return false;
1254
1255 output_object->install_date_days = elapsed_days;
1256 return true;
1257}
1258
1259// static
1260bool OmahaRequestAction::HasInstallDate(SystemState *system_state) {
1261 PrefsInterface* prefs = system_state->prefs();
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001262 if (prefs == nullptr)
David Zeuthen639aa362014-02-03 16:23:44 -08001263 return false;
1264
1265 return prefs->Exists(kPrefsInstallDateDays);
1266}
1267
1268// static
1269bool OmahaRequestAction::PersistInstallDate(
1270 SystemState *system_state,
1271 int install_date_days,
1272 InstallDateProvisioningSource source) {
1273 TEST_AND_RETURN_FALSE(install_date_days >= 0);
1274
1275 PrefsInterface* prefs = system_state->prefs();
Alex Vakulenko88b591f2014-08-28 16:48:57 -07001276 if (prefs == nullptr)
David Zeuthen639aa362014-02-03 16:23:44 -08001277 return false;
1278
1279 if (!prefs->SetInt64(kPrefsInstallDateDays, install_date_days))
1280 return false;
1281
1282 string metric_name = "Installer.InstallDateProvisioningSource";
1283 system_state->metrics_lib()->SendEnumToUMA(
1284 metric_name,
David Zeuthen33bae492014-02-25 16:16:18 -08001285 static_cast<int>(source), // Sample.
1286 kProvisionedMax); // Maximum.
1287
1288 metric_name = metrics::kMetricInstallDateProvisioningSource;
1289 system_state->metrics_lib()->SendEnumToUMA(
1290 metric_name,
1291 static_cast<int>(source), // Sample.
1292 kProvisionedMax); // Maximum.
David Zeuthen639aa362014-02-03 16:23:44 -08001293
1294 return true;
1295}
1296
Alex Deymo8e18f932015-03-27 16:16:59 -07001297bool OmahaRequestAction::PersistCohortData(
1298 const string& prefs_key,
1299 const string& new_value) {
1300 if (new_value.empty() && system_state_->prefs()->Exists(prefs_key)) {
1301 LOG(INFO) << "Removing stored " << prefs_key << " value.";
1302 return system_state_->prefs()->Delete(prefs_key);
1303 } else if (!new_value.empty()) {
1304 LOG(INFO) << "Storing new setting " << prefs_key << " as " << new_value;
1305 return system_state_->prefs()->SetString(prefs_key, new_value);
1306 }
1307 return true;
1308}
1309
David Zeuthen33bae492014-02-25 16:16:18 -08001310void OmahaRequestAction::ActionCompleted(ErrorCode code) {
1311 // We only want to report this on "update check".
1312 if (ping_only_ || event_ != nullptr)
1313 return;
1314
1315 metrics::CheckResult result = metrics::CheckResult::kUnset;
1316 metrics::CheckReaction reaction = metrics::CheckReaction::kUnset;
1317 metrics::DownloadErrorCode download_error_code =
1318 metrics::DownloadErrorCode::kUnset;
1319
1320 // Regular update attempt.
1321 switch (code) {
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001322 case ErrorCode::kSuccess:
David Zeuthen33bae492014-02-25 16:16:18 -08001323 // OK, we parsed the response successfully but that does
1324 // necessarily mean that an update is available.
1325 if (HasOutputPipe()) {
1326 const OmahaResponse& response = GetOutputObject();
1327 if (response.update_exists) {
1328 result = metrics::CheckResult::kUpdateAvailable;
1329 reaction = metrics::CheckReaction::kUpdating;
1330 } else {
1331 result = metrics::CheckResult::kNoUpdateAvailable;
1332 }
1333 } else {
1334 result = metrics::CheckResult::kNoUpdateAvailable;
1335 }
1336 break;
1337
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001338 case ErrorCode::kOmahaUpdateIgnoredPerPolicy:
David Zeuthen33bae492014-02-25 16:16:18 -08001339 result = metrics::CheckResult::kUpdateAvailable;
1340 reaction = metrics::CheckReaction::kIgnored;
1341 break;
1342
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001343 case ErrorCode::kOmahaUpdateDeferredPerPolicy:
David Zeuthen33bae492014-02-25 16:16:18 -08001344 result = metrics::CheckResult::kUpdateAvailable;
1345 reaction = metrics::CheckReaction::kDeferring;
1346 break;
1347
Gilad Arnoldd1c4d2d2014-06-05 14:07:53 -07001348 case ErrorCode::kOmahaUpdateDeferredForBackoff:
David Zeuthen33bae492014-02-25 16:16:18 -08001349 result = metrics::CheckResult::kUpdateAvailable;
1350 reaction = metrics::CheckReaction::kBackingOff;
1351 break;
1352
1353 default:
1354 // We report two flavors of errors, "Download errors" and "Parsing
1355 // error". Try to convert to the former and if that doesn't work
1356 // we know it's the latter.
1357 metrics::DownloadErrorCode tmp_error = utils::GetDownloadErrorCode(code);
1358 if (tmp_error != metrics::DownloadErrorCode::kInputMalformed) {
1359 result = metrics::CheckResult::kDownloadError;
1360 download_error_code = tmp_error;
1361 } else {
1362 result = metrics::CheckResult::kParsingError;
1363 }
1364 break;
1365 }
1366
1367 metrics::ReportUpdateCheckMetrics(system_state_,
1368 result, reaction, download_error_code);
1369}
1370
Chris Sosa77f79e82014-06-02 18:16:24 -07001371bool OmahaRequestAction::ShouldIgnoreUpdate(
1372 const OmahaResponse& response) const {
Chris Sosa77f79e82014-06-02 18:16:24 -07001373 // Note: policy decision to not update to a version we rolled back from.
1374 string rollback_version =
1375 system_state_->payload_state()->GetRollbackVersion();
Alex Vakulenkod2779df2014-06-16 13:19:00 -07001376 if (!rollback_version.empty()) {
Chris Sosa77f79e82014-06-02 18:16:24 -07001377 LOG(INFO) << "Detected previous rollback from version " << rollback_version;
Alex Vakulenkod2779df2014-06-16 13:19:00 -07001378 if (rollback_version == response.version) {
Chris Sosa77f79e82014-06-02 18:16:24 -07001379 LOG(INFO) << "Received version that we rolled back from. Ignoring.";
1380 return true;
1381 }
1382 }
1383
Alex Vakulenkod2779df2014-06-16 13:19:00 -07001384 if (!IsUpdateAllowedOverCurrentConnection()) {
Chris Sosa77f79e82014-06-02 18:16:24 -07001385 LOG(INFO) << "Update is not allowed over current connection.";
1386 return true;
1387 }
1388
1389 // Note: We could technically delete the UpdateFirstSeenAt state when we
1390 // return true. If we do, it'll mean a device has to restart the
1391 // UpdateFirstSeenAt and thus help scattering take effect when the AU is
1392 // turned on again. On the other hand, it also increases the chance of update
1393 // starvation if an admin turns AU on/off more frequently. We choose to err on
1394 // the side of preventing starvation at the cost of not applying scattering in
1395 // those cases.
1396 return false;
1397}
1398
1399bool OmahaRequestAction::IsUpdateAllowedOverCurrentConnection() const {
1400 NetworkConnectionType type;
1401 NetworkTethering tethering;
1402 RealDBusWrapper dbus_iface;
1403 ConnectionManager* connection_manager = system_state_->connection_manager();
1404 if (!connection_manager->GetConnectionProperties(&dbus_iface,
1405 &type, &tethering)) {
1406 LOG(INFO) << "We could not determine our connection type. "
1407 << "Defaulting to allow updates.";
1408 return true;
1409 }
1410 bool is_allowed = connection_manager->IsUpdateAllowedOver(type, tethering);
1411 LOG(INFO) << "We are connected via "
1412 << connection_manager->StringForConnectionType(type)
1413 << ", Updates allowed: " << (is_allowed ? "Yes" : "No");
1414 return is_allowed;
1415}
1416
Jay Srinivasan480ddfa2012-06-01 19:15:26 -07001417} // namespace chromeos_update_engine