Home | History | Annotate | Download | only in update_engine
      1 //
      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 //
     16 
     17 #include "update_engine/omaha_request_action.h"
     18 
     19 #include <inttypes.h>
     20 
     21 #include <map>
     22 #include <sstream>
     23 #include <string>
     24 #include <vector>
     25 
     26 #include <base/bind.h>
     27 #include <base/logging.h>
     28 #include <base/rand_util.h>
     29 #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>
     33 #include <expat.h>
     34 #include <metrics/metrics_library.h>
     35 
     36 #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"
     43 #include "update_engine/connection_manager.h"
     44 #include "update_engine/metrics.h"
     45 #include "update_engine/metrics_utils.h"
     46 #include "update_engine/omaha_request_params.h"
     47 #include "update_engine/p2p_manager.h"
     48 #include "update_engine/payload_state_interface.h"
     49 
     50 using base::Time;
     51 using base::TimeDelta;
     52 using std::map;
     53 using std::string;
     54 using std::vector;
     55 
     56 namespace chromeos_update_engine {
     57 
     58 // List of custom pair tags that we interpret in the Omaha Response:
     59 static const char* kTagDeadline = "deadline";
     60 static const char* kTagDisablePayloadBackoff = "DisablePayloadBackoff";
     61 static const char* kTagVersion = "version";
     62 // Deprecated: "IsDelta"
     63 static const char* kTagIsDeltaPayload = "IsDeltaPayload";
     64 static const char* kTagMaxFailureCountPerUrl = "MaxFailureCountPerUrl";
     65 static const char* kTagMaxDaysToScatter = "MaxDaysToScatter";
     66 // Deprecated: "ManifestSignatureRsa"
     67 // Deprecated: "ManifestSize"
     68 static const char* kTagMetadataSignatureRsa = "MetadataSignatureRsa";
     69 static const char* kTagMetadataSize = "MetadataSize";
     70 static const char* kTagMoreInfo = "MoreInfo";
     71 // Deprecated: "NeedsAdmin"
     72 static const char* kTagPrompt = "Prompt";
     73 static const char* kTagSha256 = "sha256";
     74 static const char* kTagDisableP2PForDownloading = "DisableP2PForDownloading";
     75 static const char* kTagDisableP2PForSharing = "DisableP2PForSharing";
     76 static const char* kTagPublicKeyRsa = "PublicKeyRsa";
     77 
     78 static const char* kOmahaUpdaterVersion = "0.1.0.0";
     79 
     80 namespace {
     81 
     82 // 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.
     85 string GetPingAttribute(const string& name, int ping_days) {
     86   if (ping_days > 0 || ping_days == OmahaRequestAction::kNeverPinged)
     87     return base::StringPrintf(" %s=\"%d\"", name.c_str(), ping_days);
     88   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.
     93 string GetPingXml(int ping_active_days, int ping_roll_call_days) {
     94   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()) {
     97     return base::StringPrintf("        <ping active=\"1\"%s%s></ping>\n",
     98                               ping_active.c_str(),
     99                               ping_roll_call.c_str());
    100   }
    101   return "";
    102 }
    103 
    104 // Returns an XML that goes into the body of the <app> element of the Omaha
    105 // request based on the given parameters.
    106 string GetAppBody(const OmahaEvent* event,
    107                   OmahaRequestParams* params,
    108                   bool ping_only,
    109                   bool include_ping,
    110                   int ping_active_days,
    111                   int ping_roll_call_days,
    112                   PrefsInterface* prefs) {
    113   string app_body;
    114   if (event == nullptr) {
    115     if (include_ping)
    116         app_body = GetPingXml(ping_active_days, ping_roll_call_days);
    117     if (!ping_only) {
    118       app_body += base::StringPrintf(
    119           "        <updatecheck targetversionprefix=\"%s\""
    120           "></updatecheck>\n",
    121           XmlEncodeWithDefault(params->target_version_prefix(), "").c_str());
    122 
    123       // 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
    129       // rebooted. The previous version event is also not sent if it was already
    130       // sent for this new version with a previous updatecheck.
    131       string prev_version;
    132       if (!prefs->GetString(kPrefsPreviousVersion, &prev_version)) {
    133         prev_version = "0.0.0.0";
    134       }
    135       // 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",
    142             OmahaEvent::kTypeRebootedAfterUpdate,
    143             OmahaEvent::kResultSuccess,
    144             XmlEncodeWithDefault(prev_version, "0.0.0.0").c_str());
    145         LOG_IF(WARNING, !prefs->SetString(kPrefsPreviousVersion, ""))
    146             << "Unable to reset the previous version.";
    147       }
    148     }
    149   } else {
    150     // The error code is an optional attribute so append it only if the result
    151     // is not success.
    152     string error_code;
    153     if (event->result != OmahaEvent::kResultSuccess) {
    154       error_code = base::StringPrintf(" errorcode=\"%d\"",
    155                                       static_cast<int>(event->error_code));
    156     }
    157     app_body = base::StringPrintf(
    158         "        <event eventtype=\"%d\" eventresult=\"%d\"%s></event>\n",
    159         event->type, event->result, error_code.c_str());
    160   }
    161 
    162   return app_body;
    163 }
    164 
    165 // 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.
    168 string GetCohortArgXml(PrefsInterface* prefs,
    169                        const string arg_name,
    170                        const string prefs_key) {
    171   // 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 
    188   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 
    195   return base::StringPrintf("%s=\"%s\" ",
    196                             arg_name.c_str(), escaped_xml_value.c_str());
    197 }
    198 
    199 // Returns an XML that corresponds to the entire <app> node of the Omaha
    200 // request based on the given parameters.
    201 string GetAppXml(const OmahaEvent* event,
    202                  OmahaRequestParams* params,
    203                  bool ping_only,
    204                  bool include_ping,
    205                  int ping_active_days,
    206                  int ping_roll_call_days,
    207                  int install_date_in_days,
    208                  SystemState* system_state) {
    209   string app_body = GetAppBody(event, params, ping_only, include_ping,
    210                                ping_active_days, ping_roll_call_days,
    211                                system_state->prefs());
    212   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.
    217   if (params->to_more_stable_channel() && params->is_powerwash_allowed()) {
    218     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=\"" +
    221         XmlEncodeWithDefault(params->app_version(), "0.0.0.0") + "\" ";
    222   } else {
    223     app_versions = "version=\"" +
    224         XmlEncodeWithDefault(params->app_version(), "0.0.0.0") + "\" ";
    225   }
    226 
    227   string download_channel = params->download_channel();
    228   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   }
    234 
    235   string delta_okay_str = params->delta_okay() ? "true" : "false";
    236 
    237   // 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) {
    241     install_date_in_days_str = base::StringPrintf("installdate=\"%d\" ",
    242                                                   install_date_in_days);
    243   }
    244 
    245   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 
    253   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 +
    267       "    </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.
    274 string GetOsXml(OmahaRequestParams* params) {
    275   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";
    280   return os_xml;
    281 }
    282 
    283 // Returns an XML that corresponds to the entire Omaha request based on the
    284 // given parameters.
    285 string GetRequestXml(const OmahaEvent* event,
    286                      OmahaRequestParams* params,
    287                      bool ping_only,
    288                      bool include_ping,
    289                      int ping_active_days,
    290                      int ping_roll_call_days,
    291                      int install_date_in_days,
    292                      SystemState* system_state) {
    293   string os_xml = GetOsXml(params);
    294   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);
    297 
    298   string install_source = base::StringPrintf("installsource=\"%s\" ",
    299       (params->interactive() ? "ondemandupdate" : "scheduler"));
    300 
    301   string updater_version = XmlEncodeWithDefault(
    302       base::StringPrintf("%s-%s",
    303                          constants::kOmahaUpdaterID,
    304                          kOmahaUpdaterVersion), "");
    305   string request_xml =
    306       "<?xml version=\"1.0\" encoding=\"UTF-8\"?>\n"
    307       "<request protocol=\"3.0\" " + (
    308           "version=\"" + updater_version + "\" "
    309           "updaterversion=\"" + updater_version + "\" " +
    310           install_source +
    311           "ismachine=\"1\">\n") +
    312       os_xml +
    313       app_xml +
    314       "</request>\n";
    315 
    316   return request_xml;
    317 }
    318 
    319 }  // namespace
    320 
    321 // Struct used for holding data obtained when parsing the XML.
    322 struct OmahaParserData {
    323   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 
    328   // This is the state of the parser as it's processing the XML.
    329   bool failed = false;
    330   bool entity_decl = false;
    331   string current_path;
    332 
    333   // These are the values extracted from the XML.
    334   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;
    340   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 
    351 namespace {
    352 
    353 // Callback function invoked by expat.
    354 void 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 
    372   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") {
    386     // 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.
    414 void 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 
    421   if (!base::EndsWith(data->current_path, path_suffix,
    422                       base::CompareCase::SENSITIVE)) {
    423     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 
    431 // 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.
    437 void 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 
    454 }  // namespace
    455 
    456 bool 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   }
    463   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   }
    488   return true;
    489 }
    490 
    491 string XmlEncodeWithDefault(const string& input, const string& default_value) {
    492   string output;
    493   if (XmlEncode(input, &output))
    494     return output;
    495   return default_value;
    496 }
    497 
    498 OmahaRequestAction::OmahaRequestAction(
    499     SystemState* system_state,
    500     OmahaEvent* event,
    501     std::unique_ptr<HttpFetcher> http_fetcher,
    502     bool ping_only)
    503     : system_state_(system_state),
    504       event_(event),
    505       http_fetcher_(std::move(http_fetcher)),
    506       ping_only_(ping_only),
    507       ping_active_days_(0),
    508       ping_roll_call_days_(0) {
    509   params_ = system_state->request_params();
    510 }
    511 
    512 OmahaRequestAction::~OmahaRequestAction() {}
    513 
    514 // Calculates the value to use for the ping days parameter.
    515 int OmahaRequestAction::CalculatePingDays(const string& key) {
    516   int days = kNeverPinged;
    517   int64_t last_ping = 0;
    518   if (system_state_->prefs()->GetInt64(key, &last_ping) && last_ping >= 0) {
    519     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 
    534 void 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
    541   // fix needs to change this code as well as UpdateLastPingDays and ShouldPing.
    542   ping_active_days_ = CalculatePingDays(kPrefsLastActivePingDay);
    543   ping_roll_call_days_ = CalculatePingDays(kPrefsLastRollCallPingDay);
    544 }
    545 
    546 bool 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 
    560 // static
    561 int OmahaRequestAction::GetInstallDate(SystemState* system_state) {
    562   PrefsInterface* prefs = system_state->prefs();
    563   if (prefs == nullptr)
    564     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;
    598   if (!system_state->hardware()->IsOOBEComplete(&time_of_oobe)) {
    599     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 
    624 void OmahaRequestAction::PerformAction() {
    625   http_fetcher_->set_delegate(this);
    626   InitPingDays();
    627   if (ping_only_ && !ShouldPing()) {
    628     processor_->ActionComplete(this, ErrorCode::kSuccess);
    629     return;
    630   }
    631 
    632   string request_post(GetRequestXml(event_.get(),
    633                                     params_,
    634                                     ping_only_,
    635                                     ShouldPing(),  // include_ping
    636                                     ping_active_days_,
    637                                     ping_roll_call_days_,
    638                                     GetInstallDate(system_state_),
    639                                     system_state_));
    640 
    641   http_fetcher_->SetPostData(request_post.data(), request_post.size(),
    642                              kHttpContentTypeTextXml);
    643   LOG(INFO) << "Posting an Omaha request to " << params_->update_url();
    644   LOG(INFO) << "Request: " << request_post;
    645   http_fetcher_->BeginTransfer(params_->update_url());
    646 }
    647 
    648 void OmahaRequestAction::TerminateProcessing() {
    649   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.
    654 void OmahaRequestAction::ReceivedBytes(HttpFetcher *fetcher,
    655                                        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);
    659 }
    660 
    661 namespace {
    662 
    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.
    666 off_t ParseInt(const string& str) {
    667   off_t ret = 0;
    668   int rc = sscanf(str.c_str(), "%" PRIi64, &ret);  // NOLINT(runtime/printf)
    669   if (rc < 1) {
    670     // failure
    671     return 0;
    672   }
    673   return ret;
    674 }
    675 
    676 // Parses |str| and returns |true| if, and only if, its value is "true".
    677 bool ParseBool(const string& str) {
    678   return str == "true";
    679 }
    680 
    681 // Update the last ping day preferences based on the server daystart
    682 // response. Returns true on success, false otherwise.
    683 bool UpdateLastPingDays(OmahaParserData *parser_data, PrefsInterface* prefs) {
    684   int64_t elapsed_seconds = 0;
    685   TEST_AND_RETURN_FALSE(
    686       base::StringToInt64(parser_data->daystart_elapsed_seconds,
    687                           &elapsed_seconds));
    688   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 }
    697 }  // namespace
    698 
    699 bool OmahaRequestAction::ParseResponse(OmahaParserData* parser_data,
    700                                        OmahaResponse* output_object,
    701                                        ScopedActionCompleter* completer) {
    702   if (parser_data->updatecheck_status.empty()) {
    703     completer->set_code(ErrorCode::kOmahaResponseInvalid);
    704     return false;
    705   }
    706 
    707   // 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
    709   // 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.
    720   base::StringToInt(parser_data->updatecheck_poll_interval,
    721                     &output_object->poll_interval);
    722 
    723   // 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.
    727   if (ParseInstallDate(parser_data, output_object) &&
    728       !HasInstallDate(system_state_)) {
    729     // 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 
    743   // 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 
    751   if (!ParseStatus(parser_data, output_object, completer))
    752     return false;
    753 
    754   // Note: ParseUrls MUST be called before ParsePackage as ParsePackage
    755   // appends the package name to the URLs populated in this method.
    756   if (!ParseUrls(parser_data, output_object, completer))
    757     return false;
    758 
    759   if (!ParsePackage(parser_data, output_object, completer))
    760     return false;
    761 
    762   if (!ParseParams(parser_data, output_object, completer))
    763     return false;
    764 
    765   return true;
    766 }
    767 
    768 bool OmahaRequestAction::ParseStatus(OmahaParserData* parser_data,
    769                                      OmahaResponse* output_object,
    770                                      ScopedActionCompleter* completer) {
    771   const string& status = parser_data->updatecheck_status;
    772   if (status == "noupdate") {
    773     LOG(INFO) << "No update.";
    774     output_object->update_exists = false;
    775     SetOutputObject(*output_object);
    776     completer->set_code(ErrorCode::kSuccess);
    777     return false;
    778   }
    779 
    780   if (status != "ok") {
    781     LOG(ERROR) << "Unknown Omaha response status: " << status;
    782     completer->set_code(ErrorCode::kOmahaResponseInvalid);
    783     return false;
    784   }
    785 
    786   return true;
    787 }
    788 
    789 bool OmahaRequestAction::ParseUrls(OmahaParserData* parser_data,
    790                                    OmahaResponse* output_object,
    791                                    ScopedActionCompleter* completer) {
    792   if (parser_data->url_codebase.empty()) {
    793     LOG(ERROR) << "No Omaha Response URLs";
    794     completer->set_code(ErrorCode::kOmahaResponseInvalid);
    795     return false;
    796   }
    797 
    798   LOG(INFO) << "Found " << parser_data->url_codebase.size() << " url(s)";
    799   output_object->payload_urls.clear();
    800   for (const auto& codebase : parser_data->url_codebase) {
    801     if (codebase.empty()) {
    802       LOG(ERROR) << "Omaha Response URL has empty codebase";
    803       completer->set_code(ErrorCode::kOmahaResponseInvalid);
    804       return false;
    805     }
    806     output_object->payload_urls.push_back(codebase);
    807   }
    808 
    809   return true;
    810 }
    811 
    812 bool OmahaRequestAction::ParsePackage(OmahaParserData* parser_data,
    813                                       OmahaResponse* output_object,
    814                                       ScopedActionCompleter* completer) {
    815   if (parser_data->package_name.empty()) {
    816     LOG(ERROR) << "Omaha Response has empty package name";
    817     completer->set_code(ErrorCode::kOmahaResponseInvalid);
    818     return false;
    819   }
    820 
    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.
    824   for (auto& payload_url : output_object->payload_urls)
    825     payload_url += parser_data->package_name;
    826 
    827   // Parse the payload size.
    828   off_t size = ParseInt(parser_data->package_size);
    829   if (size <= 0) {
    830     LOG(ERROR) << "Omaha Response has invalid payload size: " << size;
    831     completer->set_code(ErrorCode::kOmahaResponseInvalid);
    832     return false;
    833   }
    834   output_object->size = size;
    835 
    836   LOG(INFO) << "Payload size = " << output_object->size << " bytes";
    837 
    838   return true;
    839 }
    840 
    841 bool OmahaRequestAction::ParseParams(OmahaParserData* parser_data,
    842                                      OmahaResponse* output_object,
    843                                      ScopedActionCompleter* completer) {
    844   output_object->version = parser_data->manifest_version;
    845   if (output_object->version.empty()) {
    846     LOG(ERROR) << "Omaha Response does not have version in manifest!";
    847     completer->set_code(ErrorCode::kOmahaResponseInvalid);
    848     return false;
    849   }
    850 
    851   LOG(INFO) << "Received omaha response to update to version "
    852             << output_object->version;
    853 
    854   map<string, string> attrs = parser_data->action_postinstall_attrs;
    855   if (attrs.empty()) {
    856     LOG(ERROR) << "Omaha Response has no postinstall event action";
    857     completer->set_code(ErrorCode::kOmahaResponseInvalid);
    858     return false;
    859   }
    860 
    861   output_object->hash = attrs[kTagSha256];
    862   if (output_object->hash.empty()) {
    863     LOG(ERROR) << "Omaha Response has empty sha256 value";
    864     completer->set_code(ErrorCode::kOmahaResponseInvalid);
    865     return false;
    866   }
    867 
    868   // Get the optional properties one by one.
    869   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]);
    875   output_object->disable_p2p_for_downloading =
    876       ParseBool(attrs[kTagDisableP2PForDownloading]);
    877   output_object->disable_p2p_for_sharing =
    878       ParseBool(attrs[kTagDisableP2PForSharing]);
    879   output_object->public_key_rsa = attrs[kTagPublicKeyRsa];
    880 
    881   string max = attrs[kTagMaxFailureCountPerUrl];
    882   if (!base::StringToUint(max, &output_object->max_failure_count_per_url))
    883     output_object->max_failure_count_per_url = kDefaultMaxFailureCountPerUrl;
    884 
    885   output_object->is_delta_payload = ParseBool(attrs[kTagIsDeltaPayload]);
    886 
    887   output_object->disable_payload_backoff =
    888       ParseBool(attrs[kTagDisablePayloadBackoff]);
    889 
    890   return true;
    891 }
    892 
    893 // If the transfer was successful, this uses expat to parse the response
    894 // and fill in the appropriate fields of the output object. Also, notifies
    895 // the processor that we're done.
    896 void OmahaRequestAction::TransferComplete(HttpFetcher *fetcher,
    897                                           bool successful) {
    898   ScopedActionCompleter completer(processor_, this);
    899   string current_response(response_buffer_.begin(), response_buffer_.end());
    900   LOG(INFO) << "Omaha request response: " << current_response;
    901 
    902   PayloadStateInterface* const payload_state = system_state_->payload_state();
    903 
    904   // Events are best effort transactions -- assume they always succeed.
    905   if (IsEvent()) {
    906     CHECK(!HasOutputPipe()) << "No output pipe allowed for event requests.";
    907     if (event_->result == OmahaEvent::kResultError && successful &&
    908         system_state_->hardware()->IsOfficialBuild()) {
    909       LOG(INFO) << "Signalling Crash Reporter.";
    910       utils::ScheduleCrashReporterUpload();
    911     }
    912     completer.set_code(ErrorCode::kSuccess);
    913     return;
    914   }
    915 
    916   if (!successful) {
    917     LOG(ERROR) << "Omaha request network transfer failed.";
    918     int code = GetHTTPResponseCode();
    919     // Makes sure we send sane error values.
    920     if (code < 0 || code >= 1000) {
    921       code = 999;
    922     }
    923     completer.set_code(static_cast<ErrorCode>(
    924         static_cast<int>(ErrorCode::kOmahaRequestHTTPResponseBase) + code));
    925     return;
    926   }
    927 
    928   XML_Parser parser = XML_ParserCreate(nullptr);
    929   OmahaParserData parser_data(parser);
    930   XML_SetUserData(parser, &parser_data);
    931   XML_SetElementHandler(parser, ParserHandlerStart, ParserHandlerEnd);
    932   XML_SetEntityDeclHandler(parser, ParserHandlerEntityDecl);
    933   XML_Status res = XML_Parse(
    934       parser,
    935       reinterpret_cast<const char*>(response_buffer_.data()),
    936       response_buffer_.size(),
    937       XML_TRUE);
    938   XML_ParserFree(parser);
    939 
    940   if (res != XML_STATUS_OK || parser_data.failed) {
    941     LOG(ERROR) << "Omaha response not valid XML: "
    942                << XML_ErrorString(XML_GetErrorCode(parser))
    943                << " at line " << XML_GetCurrentLineNumber(parser)
    944                << " col " << XML_GetCurrentColumnNumber(parser);
    945     ErrorCode error_code = ErrorCode::kOmahaRequestXMLParseError;
    946     if (response_buffer_.empty()) {
    947       error_code = ErrorCode::kOmahaRequestEmptyResponseError;
    948     } else if (parser_data.entity_decl) {
    949       error_code = ErrorCode::kOmahaRequestXMLHasEntityDecl;
    950     }
    951     completer.set_code(error_code);
    952     return;
    953   }
    954 
    955   // Update the last ping day preferences based on the server daystart response
    956   // even if we didn't send a ping. Omaha always includes the daystart in the
    957   // response, but log the error if it didn't.
    958   LOG_IF(ERROR, !UpdateLastPingDays(&parser_data, system_state_->prefs()))
    959       << "Failed to update the last ping day preferences!";
    960 
    961   if (!HasOutputPipe()) {
    962     // Just set success to whether or not the http transfer succeeded,
    963     // which must be true at this point in the code.
    964     completer.set_code(ErrorCode::kSuccess);
    965     return;
    966   }
    967 
    968   OmahaResponse output_object;
    969   if (!ParseResponse(&parser_data, &output_object, &completer))
    970     return;
    971   output_object.update_exists = true;
    972   SetOutputObject(output_object);
    973 
    974   if (ShouldIgnoreUpdate(output_object)) {
    975     output_object.update_exists = false;
    976     completer.set_code(ErrorCode::kOmahaUpdateIgnoredPerPolicy);
    977     return;
    978   }
    979 
    980   // If Omaha says to disable p2p, respect that
    981   if (output_object.disable_p2p_for_downloading) {
    982     LOG(INFO) << "Forcibly disabling use of p2p for downloading as "
    983               << "requested by Omaha.";
    984     payload_state->SetUsingP2PForDownloading(false);
    985   }
    986   if (output_object.disable_p2p_for_sharing) {
    987     LOG(INFO) << "Forcibly disabling use of p2p for sharing as "
    988               << "requested by Omaha.";
    989     payload_state->SetUsingP2PForSharing(false);
    990   }
    991 
    992   // Update the payload state with the current response. The payload state
    993   // will automatically reset all stale state if this response is different
    994   // from what's stored already. We are updating the payload state as late
    995   // as possible in this method so that if a new release gets pushed and then
    996   // got pulled back due to some issues, we don't want to clear our internal
    997   // state unnecessarily.
    998   payload_state->SetResponse(output_object);
    999 
   1000   // It could be we've already exceeded the deadline for when p2p is
   1001   // allowed or that we've tried too many times with p2p. Check that.
   1002   if (payload_state->GetUsingP2PForDownloading()) {
   1003     payload_state->P2PNewAttempt();
   1004     if (!payload_state->P2PAttemptAllowed()) {
   1005       LOG(INFO) << "Forcibly disabling use of p2p for downloading because "
   1006                 << "of previous failures when using p2p.";
   1007       payload_state->SetUsingP2PForDownloading(false);
   1008     }
   1009   }
   1010 
   1011   // From here on, we'll complete stuff in CompleteProcessing() so
   1012   // disable |completer| since we'll create a new one in that
   1013   // function.
   1014   completer.set_should_complete(false);
   1015 
   1016   // If we're allowed to use p2p for downloading we do not pay
   1017   // attention to wall-clock-based waiting if the URL is indeed
   1018   // available via p2p. Therefore, check if the file is available via
   1019   // p2p before deferring...
   1020   if (payload_state->GetUsingP2PForDownloading()) {
   1021     LookupPayloadViaP2P(output_object);
   1022   } else {
   1023     CompleteProcessing();
   1024   }
   1025 }
   1026 
   1027 void OmahaRequestAction::CompleteProcessing() {
   1028   ScopedActionCompleter completer(processor_, this);
   1029   OmahaResponse& output_object = const_cast<OmahaResponse&>(GetOutputObject());
   1030   PayloadStateInterface* payload_state = system_state_->payload_state();
   1031 
   1032   if (ShouldDeferDownload(&output_object)) {
   1033     output_object.update_exists = false;
   1034     LOG(INFO) << "Ignoring Omaha updates as updates are deferred by policy.";
   1035     completer.set_code(ErrorCode::kOmahaUpdateDeferredPerPolicy);
   1036     return;
   1037   }
   1038 
   1039   if (payload_state->ShouldBackoffDownload()) {
   1040     output_object.update_exists = false;
   1041     LOG(INFO) << "Ignoring Omaha updates in order to backoff our retry "
   1042               << "attempts";
   1043     completer.set_code(ErrorCode::kOmahaUpdateDeferredForBackoff);
   1044     return;
   1045   }
   1046   completer.set_code(ErrorCode::kSuccess);
   1047 }
   1048 
   1049 void OmahaRequestAction::OnLookupPayloadViaP2PCompleted(const string& url) {
   1050   LOG(INFO) << "Lookup complete, p2p-client returned URL '" << url << "'";
   1051   if (!url.empty()) {
   1052     system_state_->payload_state()->SetP2PUrl(url);
   1053   } else {
   1054     LOG(INFO) << "Forcibly disabling use of p2p for downloading "
   1055               << "because no suitable peer could be found.";
   1056     system_state_->payload_state()->SetUsingP2PForDownloading(false);
   1057   }
   1058   CompleteProcessing();
   1059 }
   1060 
   1061 void OmahaRequestAction::LookupPayloadViaP2P(const OmahaResponse& response) {
   1062   // If the device is in the middle of an update, the state variables
   1063   // kPrefsUpdateStateNextDataOffset, kPrefsUpdateStateNextDataLength
   1064   // tracks the offset and length of the operation currently in
   1065   // progress. The offset is based from the end of the manifest which
   1066   // is kPrefsManifestMetadataSize bytes long.
   1067   //
   1068   // To make forward progress and avoid deadlocks, we need to find a
   1069   // peer that has at least the entire operation we're currently
   1070   // working on. Otherwise we may end up in a situation where two
   1071   // devices bounce back and forth downloading from each other,
   1072   // neither making any forward progress until one of them decides to
   1073   // stop using p2p (via kMaxP2PAttempts and kMaxP2PAttemptTimeSeconds
   1074   // safe-guards). See http://crbug.com/297170 for an example)
   1075   size_t minimum_size = 0;
   1076   int64_t manifest_metadata_size = 0;
   1077   int64_t manifest_signature_size = 0;
   1078   int64_t next_data_offset = 0;
   1079   int64_t next_data_length = 0;
   1080   if (system_state_ &&
   1081       system_state_->prefs()->GetInt64(kPrefsManifestMetadataSize,
   1082                                        &manifest_metadata_size) &&
   1083       manifest_metadata_size != -1 &&
   1084       system_state_->prefs()->GetInt64(kPrefsManifestSignatureSize,
   1085                                        &manifest_signature_size) &&
   1086       manifest_signature_size != -1 &&
   1087       system_state_->prefs()->GetInt64(kPrefsUpdateStateNextDataOffset,
   1088                                        &next_data_offset) &&
   1089       next_data_offset != -1 &&
   1090       system_state_->prefs()->GetInt64(kPrefsUpdateStateNextDataLength,
   1091                                        &next_data_length)) {
   1092     minimum_size = manifest_metadata_size + manifest_signature_size +
   1093                    next_data_offset + next_data_length;
   1094   }
   1095 
   1096   string file_id = utils::CalculateP2PFileId(response.hash, response.size);
   1097   if (system_state_->p2p_manager()) {
   1098     LOG(INFO) << "Checking if payload is available via p2p, file_id="
   1099               << file_id << " minimum_size=" << minimum_size;
   1100     system_state_->p2p_manager()->LookupUrlForFile(
   1101         file_id,
   1102         minimum_size,
   1103         TimeDelta::FromSeconds(kMaxP2PNetworkWaitTimeSeconds),
   1104         base::Bind(&OmahaRequestAction::OnLookupPayloadViaP2PCompleted,
   1105                    base::Unretained(this)));
   1106   }
   1107 }
   1108 
   1109 bool OmahaRequestAction::ShouldDeferDownload(OmahaResponse* output_object) {
   1110   if (params_->interactive()) {
   1111     LOG(INFO) << "Not deferring download because update is interactive.";
   1112     return false;
   1113   }
   1114 
   1115   // If we're using p2p to download _and_ we have a p2p URL, we never
   1116   // defer the download. This is because the download will always
   1117   // happen from a peer on the LAN and we've been waiting in line for
   1118   // our turn.
   1119   const PayloadStateInterface* payload_state = system_state_->payload_state();
   1120   if (payload_state->GetUsingP2PForDownloading() &&
   1121       !payload_state->GetP2PUrl().empty()) {
   1122     LOG(INFO) << "Download not deferred because download "
   1123               << "will happen from a local peer (via p2p).";
   1124     return false;
   1125   }
   1126 
   1127   // We should defer the downloads only if we've first satisfied the
   1128   // wall-clock-based-waiting period and then the update-check-based waiting
   1129   // period, if required.
   1130   if (!params_->wall_clock_based_wait_enabled()) {
   1131     LOG(INFO) << "Wall-clock-based waiting period is not enabled,"
   1132               << " so no deferring needed.";
   1133     return false;
   1134   }
   1135 
   1136   switch (IsWallClockBasedWaitingSatisfied(output_object)) {
   1137     case kWallClockWaitNotSatisfied:
   1138       // We haven't even satisfied the first condition, passing the
   1139       // wall-clock-based waiting period, so we should defer the downloads
   1140       // until that happens.
   1141       LOG(INFO) << "wall-clock-based-wait not satisfied.";
   1142       return true;
   1143 
   1144     case kWallClockWaitDoneButUpdateCheckWaitRequired:
   1145       LOG(INFO) << "wall-clock-based-wait satisfied and "
   1146                 << "update-check-based-wait required.";
   1147       return !IsUpdateCheckCountBasedWaitingSatisfied();
   1148 
   1149     case kWallClockWaitDoneAndUpdateCheckWaitNotRequired:
   1150       // Wall-clock-based waiting period is satisfied, and it's determined
   1151       // that we do not need the update-check-based wait. so no need to
   1152       // defer downloads.
   1153       LOG(INFO) << "wall-clock-based-wait satisfied and "
   1154                 << "update-check-based-wait is not required.";
   1155       return false;
   1156 
   1157     default:
   1158       // Returning false for this default case so we err on the
   1159       // side of downloading updates than deferring in case of any bugs.
   1160       NOTREACHED();
   1161       return false;
   1162   }
   1163 }
   1164 
   1165 OmahaRequestAction::WallClockWaitResult
   1166 OmahaRequestAction::IsWallClockBasedWaitingSatisfied(
   1167     OmahaResponse* output_object) {
   1168   Time update_first_seen_at;
   1169   int64_t update_first_seen_at_int;
   1170 
   1171   if (system_state_->prefs()->Exists(kPrefsUpdateFirstSeenAt)) {
   1172     if (system_state_->prefs()->GetInt64(kPrefsUpdateFirstSeenAt,
   1173                                          &update_first_seen_at_int)) {
   1174       // Note: This timestamp could be that of ANY update we saw in the past
   1175       // (not necessarily this particular update we're considering to apply)
   1176       // but never got to apply because of some reason (e.g. stop AU policy,
   1177       // updates being pulled out from Omaha, changes in target version prefix,
   1178       // new update being rolled out, etc.). But for the purposes of scattering
   1179       // it doesn't matter which update the timestamp corresponds to. i.e.
   1180       // the clock starts ticking the first time we see an update and we're
   1181       // ready to apply when the random wait period is satisfied relative to
   1182       // that first seen timestamp.
   1183       update_first_seen_at = Time::FromInternalValue(update_first_seen_at_int);
   1184       LOG(INFO) << "Using persisted value of UpdateFirstSeenAt: "
   1185                 << utils::ToString(update_first_seen_at);
   1186     } else {
   1187       // This seems like an unexpected error where the persisted value exists
   1188       // but it's not readable for some reason. Just skip scattering in this
   1189       // case to be safe.
   1190      LOG(INFO) << "Not scattering as UpdateFirstSeenAt value cannot be read";
   1191      return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
   1192     }
   1193   } else {
   1194     update_first_seen_at = Time::Now();
   1195     update_first_seen_at_int = update_first_seen_at.ToInternalValue();
   1196     if (system_state_->prefs()->SetInt64(kPrefsUpdateFirstSeenAt,
   1197                                          update_first_seen_at_int)) {
   1198       LOG(INFO) << "Persisted the new value for UpdateFirstSeenAt: "
   1199                 << utils::ToString(update_first_seen_at);
   1200     } else {
   1201       // This seems like an unexpected error where the value cannot be
   1202       // persisted for some reason. Just skip scattering in this
   1203       // case to be safe.
   1204       LOG(INFO) << "Not scattering as UpdateFirstSeenAt value "
   1205                 << utils::ToString(update_first_seen_at)
   1206                 << " cannot be persisted";
   1207      return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
   1208     }
   1209   }
   1210 
   1211   TimeDelta elapsed_time = Time::Now() - update_first_seen_at;
   1212   TimeDelta max_scatter_period = TimeDelta::FromDays(
   1213       output_object->max_days_to_scatter);
   1214 
   1215   LOG(INFO) << "Waiting Period = "
   1216             << utils::FormatSecs(params_->waiting_period().InSeconds())
   1217             << ", Time Elapsed = "
   1218             << utils::FormatSecs(elapsed_time.InSeconds())
   1219             << ", MaxDaysToScatter = "
   1220             << max_scatter_period.InDays();
   1221 
   1222   if (!output_object->deadline.empty()) {
   1223     // The deadline is set for all rules which serve a delta update from a
   1224     // previous FSI, which means this update will be applied mostly in OOBE
   1225     // cases. For these cases, we shouldn't scatter so as to finish the OOBE
   1226     // quickly.
   1227     LOG(INFO) << "Not scattering as deadline flag is set";
   1228     return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
   1229   }
   1230 
   1231   if (max_scatter_period.InDays() == 0) {
   1232     // This means the Omaha rule creator decides that this rule
   1233     // should not be scattered irrespective of the policy.
   1234     LOG(INFO) << "Not scattering as MaxDaysToScatter in rule is 0.";
   1235     return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
   1236   }
   1237 
   1238   if (elapsed_time > max_scatter_period) {
   1239     // This means we've waited more than the upperbound wait in the rule
   1240     // from the time we first saw a valid update available to us.
   1241     // This will prevent update starvation.
   1242     LOG(INFO) << "Not scattering as we're past the MaxDaysToScatter limit.";
   1243     return kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
   1244   }
   1245 
   1246   // This means we are required to participate in scattering.
   1247   // See if our turn has arrived now.
   1248   TimeDelta remaining_wait_time = params_->waiting_period() - elapsed_time;
   1249   if (remaining_wait_time.InSeconds() <= 0) {
   1250     // Yes, it's our turn now.
   1251     LOG(INFO) << "Successfully passed the wall-clock-based-wait.";
   1252 
   1253     // But we can't download until the update-check-count-based wait is also
   1254     // satisfied, so mark it as required now if update checks are enabled.
   1255     return params_->update_check_count_wait_enabled() ?
   1256               kWallClockWaitDoneButUpdateCheckWaitRequired :
   1257               kWallClockWaitDoneAndUpdateCheckWaitNotRequired;
   1258   }
   1259 
   1260   // Not our turn yet, so we have to wait until our turn to
   1261   // help scatter the downloads across all clients of the enterprise.
   1262   LOG(INFO) << "Update deferred for another "
   1263             << utils::FormatSecs(remaining_wait_time.InSeconds())
   1264             << " per policy.";
   1265   return kWallClockWaitNotSatisfied;
   1266 }
   1267 
   1268 bool OmahaRequestAction::IsUpdateCheckCountBasedWaitingSatisfied() {
   1269   int64_t update_check_count_value;
   1270 
   1271   if (system_state_->prefs()->Exists(kPrefsUpdateCheckCount)) {
   1272     if (!system_state_->prefs()->GetInt64(kPrefsUpdateCheckCount,
   1273                                           &update_check_count_value)) {
   1274       // We are unable to read the update check count from file for some reason.
   1275       // So let's proceed anyway so as to not stall the update.
   1276       LOG(ERROR) << "Unable to read update check count. "
   1277                  << "Skipping update-check-count-based-wait.";
   1278       return true;
   1279     }
   1280   } else {
   1281     // This file does not exist. This means we haven't started our update
   1282     // check count down yet, so this is the right time to start the count down.
   1283     update_check_count_value = base::RandInt(
   1284       params_->min_update_checks_needed(),
   1285       params_->max_update_checks_allowed());
   1286 
   1287     LOG(INFO) << "Randomly picked update check count value = "
   1288               << update_check_count_value;
   1289 
   1290     // Write out the initial value of update_check_count_value.
   1291     if (!system_state_->prefs()->SetInt64(kPrefsUpdateCheckCount,
   1292                                           update_check_count_value)) {
   1293       // We weren't able to write the update check count file for some reason.
   1294       // So let's proceed anyway so as to not stall the update.
   1295       LOG(ERROR) << "Unable to write update check count. "
   1296                  << "Skipping update-check-count-based-wait.";
   1297       return true;
   1298     }
   1299   }
   1300 
   1301   if (update_check_count_value == 0) {
   1302     LOG(INFO) << "Successfully passed the update-check-based-wait.";
   1303     return true;
   1304   }
   1305 
   1306   if (update_check_count_value < 0 ||
   1307       update_check_count_value > params_->max_update_checks_allowed()) {
   1308     // We err on the side of skipping scattering logic instead of stalling
   1309     // a machine from receiving any updates in case of any unexpected state.
   1310     LOG(ERROR) << "Invalid value for update check count detected. "
   1311                << "Skipping update-check-count-based-wait.";
   1312     return true;
   1313   }
   1314 
   1315   // Legal value, we need to wait for more update checks to happen
   1316   // until this becomes 0.
   1317   LOG(INFO) << "Deferring Omaha updates for another "
   1318             << update_check_count_value
   1319             << " update checks per policy";
   1320   return false;
   1321 }
   1322 
   1323 // static
   1324 bool OmahaRequestAction::ParseInstallDate(OmahaParserData* parser_data,
   1325                                           OmahaResponse* output_object) {
   1326   int64_t elapsed_days = 0;
   1327   if (!base::StringToInt64(parser_data->daystart_elapsed_days,
   1328                            &elapsed_days))
   1329     return false;
   1330 
   1331   if (elapsed_days < 0)
   1332     return false;
   1333 
   1334   output_object->install_date_days = elapsed_days;
   1335   return true;
   1336 }
   1337 
   1338 // static
   1339 bool OmahaRequestAction::HasInstallDate(SystemState *system_state) {
   1340   PrefsInterface* prefs = system_state->prefs();
   1341   if (prefs == nullptr)
   1342     return false;
   1343 
   1344   return prefs->Exists(kPrefsInstallDateDays);
   1345 }
   1346 
   1347 // static
   1348 bool OmahaRequestAction::PersistInstallDate(
   1349     SystemState *system_state,
   1350     int install_date_days,
   1351     InstallDateProvisioningSource source) {
   1352   TEST_AND_RETURN_FALSE(install_date_days >= 0);
   1353 
   1354   PrefsInterface* prefs = system_state->prefs();
   1355   if (prefs == nullptr)
   1356     return false;
   1357 
   1358   if (!prefs->SetInt64(kPrefsInstallDateDays, install_date_days))
   1359     return false;
   1360 
   1361   string metric_name = metrics::kMetricInstallDateProvisioningSource;
   1362   system_state->metrics_lib()->SendEnumToUMA(
   1363       metric_name,
   1364       static_cast<int>(source),  // Sample.
   1365       kProvisionedMax);          // Maximum.
   1366 
   1367   return true;
   1368 }
   1369 
   1370 bool OmahaRequestAction::PersistCohortData(
   1371     const string& prefs_key,
   1372     const string& new_value) {
   1373   if (new_value.empty() && system_state_->prefs()->Exists(prefs_key)) {
   1374     LOG(INFO) << "Removing stored " << prefs_key << " value.";
   1375     return system_state_->prefs()->Delete(prefs_key);
   1376   } else if (!new_value.empty()) {
   1377     LOG(INFO) << "Storing new setting " << prefs_key << " as " << new_value;
   1378     return system_state_->prefs()->SetString(prefs_key, new_value);
   1379   }
   1380   return true;
   1381 }
   1382 
   1383 void OmahaRequestAction::ActionCompleted(ErrorCode code) {
   1384   // We only want to report this on "update check".
   1385   if (ping_only_ || event_ != nullptr)
   1386     return;
   1387 
   1388   metrics::CheckResult result = metrics::CheckResult::kUnset;
   1389   metrics::CheckReaction reaction = metrics::CheckReaction::kUnset;
   1390   metrics::DownloadErrorCode download_error_code =
   1391       metrics::DownloadErrorCode::kUnset;
   1392 
   1393   // Regular update attempt.
   1394   switch (code) {
   1395   case ErrorCode::kSuccess:
   1396     // OK, we parsed the response successfully but that does
   1397     // necessarily mean that an update is available.
   1398     if (HasOutputPipe()) {
   1399       const OmahaResponse& response = GetOutputObject();
   1400       if (response.update_exists) {
   1401         result = metrics::CheckResult::kUpdateAvailable;
   1402         reaction = metrics::CheckReaction::kUpdating;
   1403       } else {
   1404         result = metrics::CheckResult::kNoUpdateAvailable;
   1405       }
   1406     } else {
   1407       result = metrics::CheckResult::kNoUpdateAvailable;
   1408     }
   1409     break;
   1410 
   1411   case ErrorCode::kOmahaUpdateIgnoredPerPolicy:
   1412     result = metrics::CheckResult::kUpdateAvailable;
   1413     reaction = metrics::CheckReaction::kIgnored;
   1414     break;
   1415 
   1416   case ErrorCode::kOmahaUpdateDeferredPerPolicy:
   1417     result = metrics::CheckResult::kUpdateAvailable;
   1418     reaction = metrics::CheckReaction::kDeferring;
   1419     break;
   1420 
   1421   case ErrorCode::kOmahaUpdateDeferredForBackoff:
   1422     result = metrics::CheckResult::kUpdateAvailable;
   1423     reaction = metrics::CheckReaction::kBackingOff;
   1424     break;
   1425 
   1426   default:
   1427     // We report two flavors of errors, "Download errors" and "Parsing
   1428     // error". Try to convert to the former and if that doesn't work
   1429     // we know it's the latter.
   1430     metrics::DownloadErrorCode tmp_error =
   1431         metrics_utils::GetDownloadErrorCode(code);
   1432     if (tmp_error != metrics::DownloadErrorCode::kInputMalformed) {
   1433       result = metrics::CheckResult::kDownloadError;
   1434       download_error_code = tmp_error;
   1435     } else {
   1436       result = metrics::CheckResult::kParsingError;
   1437     }
   1438     break;
   1439   }
   1440 
   1441   metrics::ReportUpdateCheckMetrics(system_state_,
   1442                                     result, reaction, download_error_code);
   1443 }
   1444 
   1445 bool OmahaRequestAction::ShouldIgnoreUpdate(
   1446     const OmahaResponse& response) const {
   1447   // Note: policy decision to not update to a version we rolled back from.
   1448   string rollback_version =
   1449       system_state_->payload_state()->GetRollbackVersion();
   1450   if (!rollback_version.empty()) {
   1451     LOG(INFO) << "Detected previous rollback from version " << rollback_version;
   1452     if (rollback_version == response.version) {
   1453       LOG(INFO) << "Received version that we rolled back from. Ignoring.";
   1454       return true;
   1455     }
   1456   }
   1457 
   1458   if (!IsUpdateAllowedOverCurrentConnection()) {
   1459     LOG(INFO) << "Update is not allowed over current connection.";
   1460     return true;
   1461   }
   1462 
   1463   // Note: We could technically delete the UpdateFirstSeenAt state when we
   1464   // return true. If we do, it'll mean a device has to restart the
   1465   // UpdateFirstSeenAt and thus help scattering take effect when the AU is
   1466   // turned on again. On the other hand, it also increases the chance of update
   1467   // starvation if an admin turns AU on/off more frequently. We choose to err on
   1468   // the side of preventing starvation at the cost of not applying scattering in
   1469   // those cases.
   1470   return false;
   1471 }
   1472 
   1473 bool OmahaRequestAction::IsUpdateAllowedOverCurrentConnection() const {
   1474   NetworkConnectionType type;
   1475   NetworkTethering tethering;
   1476   ConnectionManagerInterface* connection_manager =
   1477       system_state_->connection_manager();
   1478   if (!connection_manager->GetConnectionProperties(&type, &tethering)) {
   1479     LOG(INFO) << "We could not determine our connection type. "
   1480               << "Defaulting to allow updates.";
   1481     return true;
   1482   }
   1483   bool is_allowed = connection_manager->IsUpdateAllowedOver(type, tethering);
   1484   LOG(INFO) << "We are connected via "
   1485             << ConnectionManager::StringForConnectionType(type)
   1486             << ", Updates allowed: " << (is_allowed ? "Yes" : "No");
   1487   return is_allowed;
   1488 }
   1489 
   1490 }  // namespace chromeos_update_engine
   1491