LUCI Scheduler :: chromium :: Windows deterministic

Status: FAILED

Triggered by: -

Duration: 3 hours

Actions:

Definition (rev 61da5958bb1bf61dc6dab9a9ab14fa46798b5d0f)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.chromium.ci"
  builder: "Windows deterministic"
>

Incoming triggers

a587ececea9a770f4f8430b4b435363ffb93e892 (5 years ago)
29723f905baeab1d4228eef2c31cdb341ebeffe0 (5 years ago)
211b5b7b66d27345ef007e58e164eabd5d6dd172 (5 years ago)
85beea0aa81479cbfa5d398055f93bafea247ed2 (5 years ago)
f4309d15fb6415e635edfcdbbff274b76e7468d7 (5 years ago)
4de146084ef772725fb604f4c91921c9ed5c6acc (5 years ago)
b6da585c095148da1009d659a85b03b9d40c990d (5 years ago)

Incoming properties

{
  "branch": "refs/heads/master",
  "repository": "https://chromium.googlesource.com/chromium/src",
  "revision": "b6da585c095148da1009d659a85b03b9d40c990d"
}

Incoming tags

buildset:commit/git/b6da585c095148da1009d659a85b03b9d40c990d
buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b6da585c095148da1009d659a85b03b9d40c990d
gitiles_ref:refs/heads/master

Debug log (UTC)

[14:45:48.967] New invocation is queued and will start shortly
[14:45:50.122] Starting the invocation (attempt 1)
[14:45:50.155] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:45:50.155] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:45:50.155] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9037230137156344624",
  "parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b6da585c095148da1009d659a85b03b9d40c990d\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Windows deterministic",
    "scheduler_invocation_id:9037230137156344624",
    "scheduler_job_id:chromium/Windows deterministic",
    "user_agent:luci-scheduler",
    "buildset:commit/git/b6da585c095148da1009d659a85b03b9d40c990d",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b6da585c095148da1009d659a85b03b9d40c990d",
    "gitiles_ref:refs/heads/master"
  ]
}
[14:45:50.990] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1597589150289295",
    "id": "8871800075104767520",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b6da585c095148da1009d659a85b03b9d40c990d\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1597589150821856",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/17003",
      "builder:Windows deterministic",
      "buildset:commit/git/b6da585c095148da1009d659a85b03b9d40c990d",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b6da585c095148da1009d659a85b03b9d40c990d",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9037230137156344624",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8871800075104767520/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:recipe_name:swarming/deterministic_build",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1597589150821976",
    "url": "https://ci.chromium.org/b/8871800075104767520",
    "utcnow_ts": "1597589150981317"
  }
}
[14:45:50.990] Task URL: https://ci.chromium.org/b/8871800075104767520
[14:45:50.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:2:0) after 1m0s
[14:46:51.002] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:2:0)
[14:46:51.002] Timer tick, asking Buildbucket for the build status
[14:46:51.195] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:46:51.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:3:0) after 1m0s
[14:47:51.234] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:3:0)
[14:47:51.234] Timer tick, asking Buildbucket for the build status
[14:47:51.384] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:47:51.384] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:4:0) after 1m0s
[14:48:51.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:4:0)
[14:48:51.408] Timer tick, asking Buildbucket for the build status
[14:48:51.511] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:48:51.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:5:0) after 1m0s
[14:49:51.533] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:5:0)
[14:49:51.533] Timer tick, asking Buildbucket for the build status
[14:49:51.627] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:49:51.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:6:0) after 1m0s
[14:50:51.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:6:0)
[14:50:51.648] Timer tick, asking Buildbucket for the build status
[14:50:51.830] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:50:51.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:7:0) after 1m0s
[14:51:51.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:7:0)
[14:51:51.853] Timer tick, asking Buildbucket for the build status
[14:51:52.041] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:51:52.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:8:0) after 1m0s
[14:52:52.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:8:0)
[14:52:52.211] Timer tick, asking Buildbucket for the build status
[14:52:52.330] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:52:52.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:9:0) after 1m0s
[14:53:52.491] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:9:0)
[14:53:52.491] Timer tick, asking Buildbucket for the build status
[14:53:52.732] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:53:52.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:10:0) after 1m0s
[14:54:52.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:10:0)
[14:54:52.751] Timer tick, asking Buildbucket for the build status
[14:54:52.843] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:54:52.843] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:11:0) after 1m0s
[14:55:52.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:11:0)
[14:55:52.858] Timer tick, asking Buildbucket for the build status
[14:55:52.990] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:55:52.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:12:0) after 1m0s
[14:56:53.060] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:12:0)
[14:56:53.060] Timer tick, asking Buildbucket for the build status
[14:56:53.281] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:56:53.281] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:13:0) after 1m0s
[14:57:53.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:13:0)
[14:57:53.476] Timer tick, asking Buildbucket for the build status
[14:57:53.601] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:57:53.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:14:0) after 1m0s
[14:58:53.770] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:14:0)
[14:58:53.770] Timer tick, asking Buildbucket for the build status
[14:58:53.932] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:58:53.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:15:0) after 1m0s
[14:59:53.958] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:15:0)
[14:59:53.958] Timer tick, asking Buildbucket for the build status
[14:59:54.041] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:59:54.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:16:0) after 1m0s
[15:00:54.065] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:16:0)
[15:00:54.065] Timer tick, asking Buildbucket for the build status
[15:00:54.513] Build 8871800075104767520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:00:54.513] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:17:0) after 1m0s
[15:01:50.703] Received PubSub notification, asking Buildbucket for the build status
[15:01:50.955] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:54.636] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:17:0)
[15:01:54.636] Timer tick, asking Buildbucket for the build status
[15:01:54.720] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:54.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:19:0) after 1m0s
[15:02:54.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:19:0)
[15:02:54.794] Timer tick, asking Buildbucket for the build status
[15:02:56.073] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:56.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:20:0) after 1m0s
[15:03:56.059] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:20:0)
[15:03:56.059] Timer tick, asking Buildbucket for the build status
[15:03:56.179] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:56.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:21:0) after 1m0s
[15:04:56.209] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:21:0)
[15:04:56.209] Timer tick, asking Buildbucket for the build status
[15:04:56.316] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:56.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:22:0) after 1m0s
[15:05:56.394] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:22:0)
[15:05:56.394] Timer tick, asking Buildbucket for the build status
[15:05:56.644] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:56.644] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:23:0) after 1m0s
[15:06:56.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:23:0)
[15:06:56.747] Timer tick, asking Buildbucket for the build status
[15:06:56.835] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:56.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:24:0) after 1m0s
[15:07:56.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:24:0)
[15:07:56.922] Timer tick, asking Buildbucket for the build status
[15:07:56.994] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:56.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:25:0) after 1m0s
[15:08:57.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:25:0)
[15:08:57.036] Timer tick, asking Buildbucket for the build status
[15:08:57.117] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:57.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:26:0) after 1m0s
[15:09:57.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:26:0)
[15:09:57.106] Timer tick, asking Buildbucket for the build status
[15:09:57.599] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:57.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:27:0) after 1m0s
[15:10:57.700] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:27:0)
[15:10:57.700] Timer tick, asking Buildbucket for the build status
[15:10:57.799] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:57.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:28:0) after 1m0s
[15:11:57.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:28:0)
[15:11:57.821] Timer tick, asking Buildbucket for the build status
[15:11:57.882] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:57.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:29:0) after 1m0s
[15:12:57.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:29:0)
[15:12:57.906] Timer tick, asking Buildbucket for the build status
[15:12:58.406] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:58.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:30:0) after 1m0s
[15:13:58.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:30:0)
[15:13:58.431] Timer tick, asking Buildbucket for the build status
[15:13:58.489] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:58.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:31:0) after 1m0s
[15:14:58.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:31:0)
[15:14:58.512] Timer tick, asking Buildbucket for the build status
[15:14:58.583] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:58.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:32:0) after 1m0s
[15:15:58.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:32:0)
[15:15:58.603] Timer tick, asking Buildbucket for the build status
[15:15:58.716] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:58.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:33:0) after 1m0s
[15:16:58.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:33:0)
[15:16:58.740] Timer tick, asking Buildbucket for the build status
[15:16:58.794] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:58.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:34:0) after 1m0s
[15:17:58.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:34:0)
[15:17:58.896] Timer tick, asking Buildbucket for the build status
[15:17:59.096] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:59.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:35:0) after 1m0s
[15:18:59.147] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:35:0)
[15:18:59.147] Timer tick, asking Buildbucket for the build status
[15:18:59.282] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:59.282] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:36:0) after 1m0s
[15:19:59.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:36:0)
[15:19:59.273] Timer tick, asking Buildbucket for the build status
[15:19:59.332] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:59.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:37:0) after 1m0s
[15:20:59.467] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:37:0)
[15:20:59.467] Timer tick, asking Buildbucket for the build status
[15:20:59.601] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:59.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:38:0) after 1m0s
[15:21:59.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:38:0)
[15:21:59.686] Timer tick, asking Buildbucket for the build status
[15:21:59.878] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:59.878] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:39:0) after 1m0s
[15:22:59.904] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:39:0)
[15:22:59.904] Timer tick, asking Buildbucket for the build status
[15:22:59.958] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:59.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:40:0) after 1m0s
[15:24:00.078] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:40:0)
[15:24:00.078] Timer tick, asking Buildbucket for the build status
[15:24:00.326] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:00.326] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:41:0) after 1m0s
[15:25:00.848] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:41:0)
[15:25:00.848] Timer tick, asking Buildbucket for the build status
[15:25:00.981] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:00.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:42:0) after 1m0s
[15:26:01.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:42:0)
[15:26:01.149] Timer tick, asking Buildbucket for the build status
[15:26:01.288] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:01.288] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:43:0) after 1m0s
[15:27:01.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:43:0)
[15:27:01.359] Timer tick, asking Buildbucket for the build status
[15:27:01.697] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:01.697] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:44:0) after 1m0s
[15:28:02.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:44:0)
[15:28:02.184] Timer tick, asking Buildbucket for the build status
[15:28:02.338] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:02.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:45:0) after 1m0s
[15:29:02.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:45:0)
[15:29:02.405] Timer tick, asking Buildbucket for the build status
[15:29:02.483] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:02.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:46:0) after 1m0s
[15:30:02.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:46:0)
[15:30:02.550] Timer tick, asking Buildbucket for the build status
[15:30:03.102] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:03.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:47:0) after 1m0s
[15:31:03.187] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:47:0)
[15:31:03.187] Timer tick, asking Buildbucket for the build status
[15:31:03.397] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:03.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:48:0) after 1m0s
[15:32:03.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:48:0)
[15:32:03.508] Timer tick, asking Buildbucket for the build status
[15:32:03.566] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:03.566] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:49:0) after 1m0s
[15:33:03.591] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:49:0)
[15:33:03.591] Timer tick, asking Buildbucket for the build status
[15:33:03.792] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:03.792] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:50:0) after 1m0s
[15:34:03.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:50:0)
[15:34:03.873] Timer tick, asking Buildbucket for the build status
[15:34:03.946] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:03.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:51:0) after 1m0s
[15:35:04.012] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:51:0)
[15:35:04.012] Timer tick, asking Buildbucket for the build status
[15:35:04.333] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:04.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:52:0) after 1m0s
[15:36:04.410] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:52:0)
[15:36:04.410] Timer tick, asking Buildbucket for the build status
[15:36:04.906] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:04.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:53:0) after 1m0s
[15:37:04.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:53:0)
[15:37:04.883] Timer tick, asking Buildbucket for the build status
[15:37:05.032] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:05.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:54:0) after 1m0s
[15:38:05.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:54:0)
[15:38:05.062] Timer tick, asking Buildbucket for the build status
[15:38:05.145] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:05.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:55:0) after 1m0s
[15:39:05.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:55:0)
[15:39:05.245] Timer tick, asking Buildbucket for the build status
[15:39:06.001] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:06.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:56:0) after 1m0s
[15:40:06.097] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:56:0)
[15:40:06.097] Timer tick, asking Buildbucket for the build status
[15:40:06.166] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:06.166] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:57:0) after 1m0s
[15:41:06.148] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:57:0)
[15:41:06.148] Timer tick, asking Buildbucket for the build status
[15:41:06.258] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:06.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:58:0) after 1m0s
[15:42:06.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:58:0)
[15:42:06.379] Timer tick, asking Buildbucket for the build status
[15:42:07.403] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:07.403] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:59:0) after 1m0s
[15:43:07.427] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:59:0)
[15:43:07.427] Timer tick, asking Buildbucket for the build status
[15:43:07.488] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:07.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:60:0) after 1m0s
[15:44:07.479] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:60:0)
[15:44:07.479] Timer tick, asking Buildbucket for the build status
[15:44:07.559] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:07.559] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:61:0) after 1m0s
[15:45:07.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:61:0)
[15:45:07.563] Timer tick, asking Buildbucket for the build status
[15:45:07.673] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:07.673] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:62:0) after 1m0s
[15:46:07.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:62:0)
[15:46:07.726] Timer tick, asking Buildbucket for the build status
[15:46:07.850] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:07.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:63:0) after 1m0s
[15:47:07.860] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:63:0)
[15:47:07.860] Timer tick, asking Buildbucket for the build status
[15:47:07.961] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:07.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:64:0) after 1m0s
[15:48:07.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:64:0)
[15:48:07.952] Timer tick, asking Buildbucket for the build status
[15:48:08.084] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:08.084] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:65:0) after 1m0s
[15:49:08.114] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:65:0)
[15:49:08.114] Timer tick, asking Buildbucket for the build status
[15:49:08.305] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:08.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:66:0) after 1m0s
[15:50:08.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:66:0)
[15:50:08.389] Timer tick, asking Buildbucket for the build status
[15:50:08.469] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:08.469] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:67:0) after 1m0s
[15:51:08.601] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:67:0)
[15:51:08.601] Timer tick, asking Buildbucket for the build status
[15:51:08.914] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:08.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:68:0) after 1m0s
[15:52:08.960] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:68:0)
[15:52:08.960] Timer tick, asking Buildbucket for the build status
[15:52:09.206] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:09.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:69:0) after 1m0s
[15:53:09.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:69:0)
[15:53:09.348] Timer tick, asking Buildbucket for the build status
[15:53:09.478] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:09.478] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:70:0) after 1m0s
[15:54:09.480] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:70:0)
[15:54:09.480] Timer tick, asking Buildbucket for the build status
[15:54:09.554] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:09.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:71:0) after 1m0s
[15:55:09.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:71:0)
[15:55:09.654] Timer tick, asking Buildbucket for the build status
[15:55:09.727] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:09.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:72:0) after 1m0s
[15:56:09.808] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:72:0)
[15:56:09.808] Timer tick, asking Buildbucket for the build status
[15:56:10.064] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:10.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:73:0) after 1m0s
[15:57:10.241] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:73:0)
[15:57:10.241] Timer tick, asking Buildbucket for the build status
[15:57:10.336] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:10.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:74:0) after 1m0s
[15:58:10.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:74:0)
[15:58:10.382] Timer tick, asking Buildbucket for the build status
[15:58:10.496] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:10.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:75:0) after 1m0s
[15:59:10.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:75:0)
[15:59:10.634] Timer tick, asking Buildbucket for the build status
[15:59:10.715] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:10.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:76:0) after 1m0s
[16:00:10.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:76:0)
[16:00:10.785] Timer tick, asking Buildbucket for the build status
[16:00:10.961] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:10.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:77:0) after 1m0s
[16:01:11.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:77:0)
[16:01:11.018] Timer tick, asking Buildbucket for the build status
[16:01:11.212] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:11.212] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:78:0) after 1m0s
[16:02:11.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:78:0)
[16:02:11.299] Timer tick, asking Buildbucket for the build status
[16:02:11.367] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:11.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:79:0) after 1m0s
[16:03:11.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:79:0)
[16:03:11.365] Timer tick, asking Buildbucket for the build status
[16:03:11.591] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:11.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:80:0) after 1m0s
[16:04:11.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:80:0)
[16:04:11.613] Timer tick, asking Buildbucket for the build status
[16:04:11.898] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:11.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:81:0) after 1m0s
[16:05:11.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:81:0)
[16:05:11.939] Timer tick, asking Buildbucket for the build status
[16:05:12.149] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:12.149] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:82:0) after 1m0s
[16:06:12.140] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:82:0)
[16:06:12.140] Timer tick, asking Buildbucket for the build status
[16:06:12.353] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:12.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:83:0) after 1m0s
[16:07:12.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:83:0)
[16:07:12.397] Timer tick, asking Buildbucket for the build status
[16:07:12.492] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:12.492] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:84:0) after 1m0s
[16:08:12.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:84:0)
[16:08:12.531] Timer tick, asking Buildbucket for the build status
[16:08:12.599] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:12.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:85:0) after 1m0s
[16:09:12.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:85:0)
[16:09:12.695] Timer tick, asking Buildbucket for the build status
[16:09:12.766] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:12.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:86:0) after 1m0s
[16:10:12.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:86:0)
[16:10:12.807] Timer tick, asking Buildbucket for the build status
[16:10:12.974] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:12.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:87:0) after 1m0s
[16:11:12.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:87:0)
[16:11:12.999] Timer tick, asking Buildbucket for the build status
[16:11:13.231] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:13.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:88:0) after 1m0s
[16:12:13.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:88:0)
[16:12:13.293] Timer tick, asking Buildbucket for the build status
[16:12:13.401] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:13.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:89:0) after 1m0s
[16:13:13.479] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:89:0)
[16:13:13.479] Timer tick, asking Buildbucket for the build status
[16:13:13.963] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:13.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:90:0) after 1m0s
[16:14:14.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:90:0)
[16:14:14.008] Timer tick, asking Buildbucket for the build status
[16:14:14.108] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:14.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:91:0) after 1m0s
[16:15:14.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:91:0)
[16:15:14.106] Timer tick, asking Buildbucket for the build status
[16:15:14.227] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:14.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:92:0) after 1m0s
[16:16:14.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:92:0)
[16:16:14.325] Timer tick, asking Buildbucket for the build status
[16:16:14.537] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:14.537] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:93:0) after 1m0s
[16:17:14.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:93:0)
[16:17:14.654] Timer tick, asking Buildbucket for the build status
[16:17:14.815] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:14.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:94:0) after 1m0s
[16:18:14.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:94:0)
[16:18:14.883] Timer tick, asking Buildbucket for the build status
[16:18:14.989] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:14.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:95:0) after 1m0s
[16:19:15.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:95:0)
[16:19:15.073] Timer tick, asking Buildbucket for the build status
[16:19:15.139] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:15.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:96:0) after 1m0s
[16:20:15.171] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:96:0)
[16:20:15.171] Timer tick, asking Buildbucket for the build status
[16:20:15.308] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:15.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:97:0) after 1m0s
[16:21:15.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:97:0)
[16:21:15.363] Timer tick, asking Buildbucket for the build status
[16:21:15.536] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:15.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:98:0) after 1m0s
[16:22:15.722] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:98:0)
[16:22:15.722] Timer tick, asking Buildbucket for the build status
[16:22:15.830] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:15.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:99:0) after 1m0s
[16:23:15.937] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:99:0)
[16:23:15.937] Timer tick, asking Buildbucket for the build status
[16:23:16.058] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:16.058] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:100:0) after 1m0s
[16:24:16.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:100:0)
[16:24:16.313] Timer tick, asking Buildbucket for the build status
[16:24:16.496] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:16.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:101:0) after 1m0s
[16:25:16.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:101:0)
[16:25:16.648] Timer tick, asking Buildbucket for the build status
[16:25:16.738] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:16.738] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:102:0) after 1m0s
[16:26:16.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:102:0)
[16:26:16.801] Timer tick, asking Buildbucket for the build status
[16:26:16.924] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:16.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:103:0) after 1m0s
[16:27:16.937] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:103:0)
[16:27:16.937] Timer tick, asking Buildbucket for the build status
[16:27:17.001] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:17.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:104:0) after 1m0s
[16:28:17.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:104:0)
[16:28:17.173] Timer tick, asking Buildbucket for the build status
[16:28:17.257] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:17.257] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:105:0) after 1m0s
[16:29:17.331] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:105:0)
[16:29:17.331] Timer tick, asking Buildbucket for the build status
[16:29:17.425] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:17.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:106:0) after 1m0s
[16:30:17.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:106:0)
[16:30:17.461] Timer tick, asking Buildbucket for the build status
[16:30:17.549] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:17.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:107:0) after 1m0s
[16:31:17.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:107:0)
[16:31:17.605] Timer tick, asking Buildbucket for the build status
[16:31:17.829] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:17.829] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:108:0) after 1m0s
[16:32:17.856] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:108:0)
[16:32:17.856] Timer tick, asking Buildbucket for the build status
[16:32:17.996] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:17.996] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:109:0) after 1m0s
[16:33:18.039] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:109:0)
[16:33:18.039] Timer tick, asking Buildbucket for the build status
[16:33:18.231] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:18.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:110:0) after 1m0s
[16:34:18.280] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:110:0)
[16:34:18.280] Timer tick, asking Buildbucket for the build status
[16:34:18.365] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:18.365] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:111:0) after 1m0s
[16:35:18.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:111:0)
[16:35:18.395] Timer tick, asking Buildbucket for the build status
[16:35:18.494] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:18.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:112:0) after 1m0s
[16:36:18.585] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:112:0)
[16:36:18.585] Timer tick, asking Buildbucket for the build status
[16:36:18.693] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:18.693] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:113:0) after 1m0s
[16:37:18.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:113:0)
[16:37:18.782] Timer tick, asking Buildbucket for the build status
[16:37:19.014] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:19.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:114:0) after 1m0s
[16:38:19.043] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:114:0)
[16:38:19.043] Timer tick, asking Buildbucket for the build status
[16:38:19.114] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:19.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:115:0) after 1m0s
[16:39:19.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:115:0)
[16:39:19.184] Timer tick, asking Buildbucket for the build status
[16:39:19.392] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:19.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:116:0) after 1m0s
[16:40:19.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:116:0)
[16:40:19.681] Timer tick, asking Buildbucket for the build status
[16:40:20.065] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:20.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:117:0) after 1m0s
[16:41:20.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:117:0)
[16:41:20.142] Timer tick, asking Buildbucket for the build status
[16:41:20.285] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:20.285] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:118:0) after 1m0s
[16:42:20.316] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:118:0)
[16:42:20.316] Timer tick, asking Buildbucket for the build status
[16:42:20.383] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:20.383] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:119:0) after 1m0s
[16:43:20.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:119:0)
[16:43:20.481] Timer tick, asking Buildbucket for the build status
[16:43:21.508] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:21.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:120:0) after 1m0s
[16:44:21.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:120:0)
[16:44:21.634] Timer tick, asking Buildbucket for the build status
[16:44:21.716] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:21.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:121:0) after 1m0s
[16:45:21.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:121:0)
[16:45:21.748] Timer tick, asking Buildbucket for the build status
[16:45:21.812] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:21.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:122:0) after 1m0s
[16:46:21.837] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:122:0)
[16:46:21.837] Timer tick, asking Buildbucket for the build status
[16:46:21.996] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:21.996] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:123:0) after 1m0s
[16:47:22.104] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:123:0)
[16:47:22.104] Timer tick, asking Buildbucket for the build status
[16:47:22.315] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:22.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:124:0) after 1m0s
[16:48:22.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:124:0)
[16:48:22.439] Timer tick, asking Buildbucket for the build status
[16:48:22.519] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:22.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:125:0) after 1m0s
[16:49:22.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:125:0)
[16:49:22.649] Timer tick, asking Buildbucket for the build status
[16:49:22.735] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:22.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:126:0) after 1m0s
[16:50:22.870] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:126:0)
[16:50:22.870] Timer tick, asking Buildbucket for the build status
[16:50:22.947] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:22.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:127:0) after 1m0s
[16:51:23.129] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:127:0)
[16:51:23.129] Timer tick, asking Buildbucket for the build status
[16:51:23.410] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:23.410] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:128:0) after 1m0s
[16:52:23.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:128:0)
[16:52:23.508] Timer tick, asking Buildbucket for the build status
[16:52:23.607] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:23.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:129:0) after 1m0s
[16:53:23.631] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:129:0)
[16:53:23.631] Timer tick, asking Buildbucket for the build status
[16:53:23.709] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:23.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:130:0) after 1m0s
[16:54:23.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:130:0)
[16:54:23.737] Timer tick, asking Buildbucket for the build status
[16:54:23.794] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:23.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:131:0) after 1m0s
[16:55:23.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:131:0)
[16:55:23.894] Timer tick, asking Buildbucket for the build status
[16:55:23.959] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:23.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:132:0) after 1m0s
[16:56:24.128] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:132:0)
[16:56:24.128] Timer tick, asking Buildbucket for the build status
[16:56:24.526] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:24.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:133:0) after 1m0s
[16:57:24.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:133:0)
[16:57:24.592] Timer tick, asking Buildbucket for the build status
[16:57:24.669] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:24.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:134:0) after 1m0s
[16:58:24.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:134:0)
[16:58:24.749] Timer tick, asking Buildbucket for the build status
[16:58:24.853] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:24.853] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:135:0) after 1m0s
[16:59:24.890] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:135:0)
[16:59:24.890] Timer tick, asking Buildbucket for the build status
[16:59:24.980] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:24.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:136:0) after 1m0s
[17:00:25.128] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:136:0)
[17:00:25.128] Timer tick, asking Buildbucket for the build status
[17:00:25.242] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:25.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:137:0) after 1m0s
[17:01:25.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:137:0)
[17:01:25.413] Timer tick, asking Buildbucket for the build status
[17:01:25.561] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:25.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:138:0) after 1m0s
[17:02:25.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:138:0)
[17:02:25.593] Timer tick, asking Buildbucket for the build status
[17:02:25.659] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:25.659] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:139:0) after 1m0s
[17:03:25.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:139:0)
[17:03:25.803] Timer tick, asking Buildbucket for the build status
[17:03:25.934] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:25.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:140:0) after 1m0s
[17:04:26.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:140:0)
[17:04:26.076] Timer tick, asking Buildbucket for the build status
[17:04:26.406] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:26.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:141:0) after 1m0s
[17:05:26.515] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:141:0)
[17:05:26.515] Timer tick, asking Buildbucket for the build status
[17:05:26.601] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:26.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:142:0) after 1m0s
[17:06:26.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:142:0)
[17:06:26.656] Timer tick, asking Buildbucket for the build status
[17:06:26.832] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:26.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:143:0) after 1m0s
[17:07:26.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:143:0)
[17:07:26.934] Timer tick, asking Buildbucket for the build status
[17:07:27.044] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:27.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:144:0) after 1m0s
[17:08:27.225] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:144:0)
[17:08:27.226] Timer tick, asking Buildbucket for the build status
[17:08:27.302] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:27.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:145:0) after 1m0s
[17:09:27.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:145:0)
[17:09:27.392] Timer tick, asking Buildbucket for the build status
[17:09:27.816] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:27.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:146:0) after 1m0s
[17:10:27.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:146:0)
[17:10:27.922] Timer tick, asking Buildbucket for the build status
[17:10:28.023] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:28.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:147:0) after 1m0s
[17:11:28.077] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:147:0)
[17:11:28.078] Timer tick, asking Buildbucket for the build status
[17:11:28.280] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:28.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:148:0) after 1m0s
[17:12:28.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:148:0)
[17:12:28.334] Timer tick, asking Buildbucket for the build status
[17:12:28.410] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:28.410] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:149:0) after 1m0s
[17:13:28.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:149:0)
[17:13:28.538] Timer tick, asking Buildbucket for the build status
[17:13:28.714] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:28.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:150:0) after 1m0s
[17:14:28.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:150:0)
[17:14:28.816] Timer tick, asking Buildbucket for the build status
[17:14:28.878] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:28.878] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:151:0) after 1m0s
[17:15:29.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:151:0)
[17:15:29.006] Timer tick, asking Buildbucket for the build status
[17:15:29.069] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:29.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:152:0) after 1m0s
[17:16:29.097] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:152:0)
[17:16:29.097] Timer tick, asking Buildbucket for the build status
[17:16:29.988] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:29.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:153:0) after 1m0s
[17:17:30.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:153:0)
[17:17:30.007] Timer tick, asking Buildbucket for the build status
[17:17:30.222] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:30.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:154:0) after 1m0s
[17:18:30.277] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:154:0)
[17:18:30.277] Timer tick, asking Buildbucket for the build status
[17:18:30.431] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:30.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:155:0) after 1m0s
[17:19:30.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:155:0)
[17:19:30.487] Timer tick, asking Buildbucket for the build status
[17:19:30.555] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:30.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:156:0) after 1m0s
[17:20:30.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:156:0)
[17:20:30.595] Timer tick, asking Buildbucket for the build status
[17:20:30.987] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:30.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:157:0) after 1m0s
[17:21:31.099] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:157:0)
[17:21:31.099] Timer tick, asking Buildbucket for the build status
[17:21:31.398] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:31.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:158:0) after 1m0s
[17:22:31.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:158:0)
[17:22:31.471] Timer tick, asking Buildbucket for the build status
[17:22:31.689] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:31.689] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:159:0) after 1m0s
[17:23:31.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:159:0)
[17:23:31.767] Timer tick, asking Buildbucket for the build status
[17:23:31.836] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:31.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:160:0) after 1m0s
[17:24:31.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:160:0)
[17:24:31.863] Timer tick, asking Buildbucket for the build status
[17:24:31.927] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:31.927] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:161:0) after 1m0s
[17:25:32.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:161:0)
[17:25:32.044] Timer tick, asking Buildbucket for the build status
[17:25:32.106] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:32.106] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:162:0) after 1m0s
[17:26:32.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:162:0)
[17:26:32.177] Timer tick, asking Buildbucket for the build status
[17:26:32.327] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:32.327] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:163:0) after 1m0s
[17:27:32.353] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:163:0)
[17:27:32.353] Timer tick, asking Buildbucket for the build status
[17:27:33.450] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:33.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:164:0) after 1m0s
[17:28:33.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:164:0)
[17:28:33.499] Timer tick, asking Buildbucket for the build status
[17:28:33.578] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:33.578] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:165:0) after 1m0s
[17:29:33.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:165:0)
[17:29:33.603] Timer tick, asking Buildbucket for the build status
[17:29:33.737] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:33.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:166:0) after 1m0s
[17:30:33.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:166:0)
[17:30:33.758] Timer tick, asking Buildbucket for the build status
[17:30:33.829] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:33.829] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:167:0) after 1m0s
[17:31:33.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:167:0)
[17:31:33.863] Timer tick, asking Buildbucket for the build status
[17:31:33.980] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:33.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:168:0) after 1m0s
[17:32:34.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:168:0)
[17:32:34.084] Timer tick, asking Buildbucket for the build status
[17:32:34.399] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:34.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:169:0) after 1m0s
[17:33:34.427] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:169:0)
[17:33:34.427] Timer tick, asking Buildbucket for the build status
[17:33:34.597] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:34.597] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:170:0) after 1m0s
[17:34:34.644] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:170:0)
[17:34:34.644] Timer tick, asking Buildbucket for the build status
[17:34:35.009] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:35.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:171:0) after 1m0s
[17:35:35.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:171:0)
[17:35:35.087] Timer tick, asking Buildbucket for the build status
[17:35:35.571] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:35.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:172:0) after 1m0s
[17:36:35.696] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:172:0)
[17:36:35.696] Timer tick, asking Buildbucket for the build status
[17:36:35.814] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:35.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:173:0) after 1m0s
[17:37:35.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:173:0)
[17:37:35.876] Timer tick, asking Buildbucket for the build status
[17:37:35.940] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:35.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:174:0) after 1m0s
[17:38:35.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:174:0)
[17:38:35.970] Timer tick, asking Buildbucket for the build status
[17:38:36.299] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:36.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:175:0) after 1m0s
[17:39:36.342] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:175:0)
[17:39:36.342] Timer tick, asking Buildbucket for the build status
[17:39:36.407] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:36.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:176:0) after 1m0s
[17:40:36.438] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:176:0)
[17:40:36.438] Timer tick, asking Buildbucket for the build status
[17:40:36.574] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:36.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:177:0) after 1m0s
[17:41:36.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:177:0)
[17:41:36.602] Timer tick, asking Buildbucket for the build status
[17:41:36.775] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:36.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:178:0) after 1m0s
[17:42:36.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:178:0)
[17:42:36.816] Timer tick, asking Buildbucket for the build status
[17:42:36.965] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:36.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:179:0) after 1m0s
[17:43:37.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:179:0)
[17:43:37.001] Timer tick, asking Buildbucket for the build status
[17:43:37.057] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:37.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:180:0) after 1m0s
[17:44:37.121] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:180:0)
[17:44:37.121] Timer tick, asking Buildbucket for the build status
[17:44:37.393] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:37.393] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:181:0) after 1m0s
[17:45:37.420] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:181:0)
[17:45:37.420] Timer tick, asking Buildbucket for the build status
[17:45:37.613] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:37.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:182:0) after 1m0s
[17:46:37.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:182:0)
[17:46:37.649] Timer tick, asking Buildbucket for the build status
[17:46:38.193] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:38.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:183:0) after 1m0s
[17:47:38.229] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:183:0)
[17:47:38.229] Timer tick, asking Buildbucket for the build status
[17:47:38.307] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:38.307] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:184:0) after 1m0s
[17:48:38.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:184:0)
[17:48:38.376] Timer tick, asking Buildbucket for the build status
[17:48:38.443] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:38.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:185:0) after 1m0s
[17:49:38.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:185:0)
[17:49:38.510] Timer tick, asking Buildbucket for the build status
[17:49:38.560] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:38.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:186:0) after 1m0s
[17:50:38.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:186:0)
[17:50:38.607] Timer tick, asking Buildbucket for the build status
[17:50:38.824] Build 8871800075104767520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:38.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9037230137156344624:187:0) after 1m0s
[17:50:42.052] Received PubSub notification, asking Buildbucket for the build status
[17:50:42.130] Build 8871800075104767520: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[17:50:42.130] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1597600241007239",
    "created_by": "project:chromium",
    "created_ts": "1597589150289295",
    "failure_reason": "INFRA_FAILURE",
    "id": "8871800075104767520",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b6da585c095148da1009d659a85b03b9d40c990d\"}}",
    "project": "chromium",
    "result": "FAILURE",
    "result_details_json": "{\"error\": {\"message\": \"recipe infra failure: Uncaught Exception: AttributeError(\\\"'NoneType' object has no attribute 'itervalues'\\\",)\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"windows-deterministic-0-7gci\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 17003, \"got_angle_revision\": \"9ae6d7f2ee9e12b707483dc9cadd7c3529595016\", \"got_dawn_revision\": \"5e9b29fab92d6d79125555ea0d84afde9ace908b\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"b6da585c095148da1009d659a85b03b9d40c990d\", \"got_revision_cp\": \"refs/heads/master@{#798491}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"abe07b9438553f741e776dedb59a2d4b502a9983\", \"got_v8_revision\": \"7dff8b438cd79eed2033ad513857166a60d1584a\", \"got_v8_revision_cp\": \"refs/heads/8.6.385@{#1}\", \"got_webrtc_revision\": \"383f2cfca4a1ebd9626134101fe70d5a716b2d92\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31921}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b6da585c095148da1009d659a85b03b9d40c990d\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Windows deterministic\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-7gci\"], \"image\": [\"chrome-win10-1703-20081200-b8de48ff3cf\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5488-fc78d20\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}, \"ui\": {\"info\": \"recipe infra failure: Uncaught Exception: AttributeError(\\\"'NoneType' object has no attribute 'itervalues'\\\",)\"}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1597590109505244",
    "status": "COMPLETED",
    "status_changed_ts": "1597590110293766",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/17003",
      "builder:Windows deterministic",
      "buildset:commit/git/b6da585c095148da1009d659a85b03b9d40c990d",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b6da585c095148da1009d659a85b03b9d40c990d",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9037230137156344624",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8871800075104767520/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:os:Windows",
      "swarming_tag:recipe_name:swarming/deterministic_build",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:4e108d66a81fcf10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1597600241330937",
    "url": "https://ci.chromium.org/b/8871800075104767520",
    "utcnow_ts": "1597600242121737"
  }
}
[17:50:42.130] Invocation finished in 3h4m53.181534502s with status FAILED