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

• 3813411d14c88cb8349a0b398bdb069c824b8467 (7 years ago)

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

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

[09:46:04.250] New invocation is queued and will start shortly
[09:46:05.506] Starting the invocation (attempt 1)
[09:46:05.538] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:46:05.538] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:46:05.538] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9103837765801809680",
  "parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"3813411d14c88cb8349a0b398bdb069c824b8467\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Windows deterministic",
    "scheduler_invocation_id:9103837765801809680",
    "scheduler_job_id:chromium/Windows deterministic",
    "user_agent:luci-scheduler",
    "buildset:commit/git/3813411d14c88cb8349a0b398bdb069c824b8467",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3813411d14c88cb8349a0b398bdb069c824b8467",
    "gitiles_ref:refs/heads/master"
  ]
}
[09:46:06.930] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary": true,
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1534067165610390",
    "id": "8938407703711877904",
    "lease_expiration_ts": "1534211166532430",
    "lease_key": "531092155",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"3813411d14c88cb8349a0b398bdb069c824b8467\"}}",
    "project": "chromium",
    "result_details_json": "null",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1534067166787150",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/9713",
      "builder:Windows deterministic",
      "buildset:commit/git/3813411d14c88cb8349a0b398bdb069c824b8467",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3813411d14c88cb8349a0b398bdb069c824b8467",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9103837765801809680",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_dimension:builder:Windows deterministic",
      "swarming_dimension:cores:8",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Windows-10",
      "swarming_dimension:pool:luci.chromium.ci",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.chromium.ci/Windows deterministic/9713",
      "swarming_tag:buildbucket_bucket:luci.chromium.ci",
      "swarming_tag:buildbucket_build_id:8938407703711877904",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:1",
      "swarming_tag:buildbucket_template_revision:477c78a99beff1a2cb211f905b69db7eeb4c6c44",
      "swarming_tag:builder:Windows deterministic",
      "swarming_tag:buildset:commit/git/3813411d14c88cb8349a0b398bdb069c824b8467",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3813411d14c88cb8349a0b398bdb069c824b8467",
      "swarming_tag:cores:8",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8938407703711877904/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:os:Windows-10",
      "swarming_tag:pool:luci.chromium.ci",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:swarming/deterministic_build",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9103837765801809680",
      "swarming_tag:scheduler_job_id:chromium/Windows deterministic",
      "swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:f4e8a443fc6511d05aa1aaa96ecce4b5b4e69d60",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:3f4658d493f77410",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1534067166787330",
    "url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9713",
    "utcnow_ts": "1534067166917890"
  }
}
[09:46:06.930] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9713
[09:46:06.930] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:2:0) after 1m0s
[09:47:07.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:2:0)
[09:47:07.005] Timer tick, asking Buildbucket for the build status
[09:47:07.161] Build 8938407703711877904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:47:07.161] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:3:0) after 1m0s
[09:47:52.984] Received PubSub notification, asking Buildbucket for the build status
[09:47:53.021] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:07.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:3:0)
[09:48:07.180] Timer tick, asking Buildbucket for the build status
[09:48:07.420] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:07.420] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:5:0) after 1m0s
[09:49:07.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:5:0)
[09:49:07.437] Timer tick, asking Buildbucket for the build status
[09:49:07.507] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:07.507] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:6:0) after 1m0s
[09:50:07.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:6:0)
[09:50:07.526] Timer tick, asking Buildbucket for the build status
[09:50:07.644] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:07.644] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:7:0) after 1m0s
[09:51:07.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:7:0)
[09:51:07.660] Timer tick, asking Buildbucket for the build status
[09:51:07.756] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:07.756] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:8:0) after 1m0s
[09:52:07.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:8:0)
[09:52:07.773] Timer tick, asking Buildbucket for the build status
[09:52:07.876] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:07.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:9:0) after 1m0s
[09:53:07.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:9:0)
[09:53:07.897] Timer tick, asking Buildbucket for the build status
[09:53:08.257] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:08.257] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:10:0) after 1m0s
[09:54:08.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:10:0)
[09:54:08.274] Timer tick, asking Buildbucket for the build status
[09:54:08.323] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:08.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:11:0) after 1m0s
[09:55:08.340] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:11:0)
[09:55:08.340] Timer tick, asking Buildbucket for the build status
[09:55:08.435] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:08.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:12:0) after 1m0s
[09:56:08.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:12:0)
[09:56:08.452] Timer tick, asking Buildbucket for the build status
[09:56:08.492] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:08.492] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:13:0) after 1m0s
[09:57:08.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:13:0)
[09:57:08.538] Timer tick, asking Buildbucket for the build status
[09:57:08.582] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:08.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:14:0) after 1m0s
[09:58:08.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:14:0)
[09:58:08.660] Timer tick, asking Buildbucket for the build status
[09:58:08.716] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:08.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:15:0) after 1m0s
[09:59:08.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:15:0)
[09:59:08.795] Timer tick, asking Buildbucket for the build status
[09:59:08.914] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:08.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:16:0) after 1m0s
[10:00:08.933] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:16:0)
[10:00:08.933] Timer tick, asking Buildbucket for the build status
[10:00:08.975] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:08.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:17:0) after 1m0s
[10:01:09.129] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:17:0)
[10:01:09.129] Timer tick, asking Buildbucket for the build status
[10:01:09.178] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:09.178] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:18:0) after 1m0s
[10:02:09.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:18:0)
[10:02:09.328] Timer tick, asking Buildbucket for the build status
[10:02:09.399] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:09.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:19:0) after 1m0s
[10:03:09.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:19:0)
[10:03:09.524] Timer tick, asking Buildbucket for the build status
[10:03:09.593] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:09.593] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:20:0) after 1m0s
[10:04:09.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:20:0)
[10:04:09.753] Timer tick, asking Buildbucket for the build status
[10:04:09.836] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:09.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:21:0) after 1m0s
[10:05:09.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:21:0)
[10:05:09.910] Timer tick, asking Buildbucket for the build status
[10:05:10.075] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:10.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:22:0) after 1m0s
[10:06:10.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:22:0)
[10:06:10.095] Timer tick, asking Buildbucket for the build status
[10:06:10.128] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:10.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:23:0) after 1m0s
[10:07:10.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:23:0)
[10:07:10.185] Timer tick, asking Buildbucket for the build status
[10:07:10.246] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:10.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:24:0) after 1m0s
[10:08:10.442] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:24:0)
[10:08:10.442] Timer tick, asking Buildbucket for the build status
[10:08:10.509] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:10.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:25:0) after 1m0s
[10:09:10.551] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:25:0)
[10:09:10.551] Timer tick, asking Buildbucket for the build status
[10:09:10.588] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:10.588] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:26:0) after 1m0s
[10:10:10.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:26:0)
[10:10:10.719] Timer tick, asking Buildbucket for the build status
[10:10:10.790] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:10.790] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:27:0) after 1m0s
[10:11:10.808] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:27:0)
[10:11:10.808] Timer tick, asking Buildbucket for the build status
[10:11:10.865] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:10.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:28:0) after 1m0s
[10:12:10.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:28:0)
[10:12:10.941] Timer tick, asking Buildbucket for the build status
[10:12:11.042] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:11.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:29:0) after 1m0s
[10:13:11.166] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:29:0)
[10:13:11.166] Timer tick, asking Buildbucket for the build status
[10:13:11.255] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:11.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:30:0) after 1m0s
[10:14:11.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:30:0)
[10:14:11.339] Timer tick, asking Buildbucket for the build status
[10:14:11.411] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:11.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:31:0) after 1m0s
[10:15:11.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:31:0)
[10:15:11.443] Timer tick, asking Buildbucket for the build status
[10:15:11.577] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:11.577] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:32:0) after 1m0s
[10:16:11.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:32:0)
[10:16:11.693] Timer tick, asking Buildbucket for the build status
[10:16:11.794] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:11.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:33:0) after 1m0s
[10:17:11.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:33:0)
[10:17:11.928] Timer tick, asking Buildbucket for the build status
[10:17:12.039] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:12.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:34:0) after 1m0s
[10:18:12.166] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:34:0)
[10:18:12.166] Timer tick, asking Buildbucket for the build status
[10:18:12.314] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:12.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:35:0) after 1m0s
[10:19:12.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:35:0)
[10:19:12.415] Timer tick, asking Buildbucket for the build status
[10:19:12.505] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:12.505] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:36:0) after 1m0s
[10:20:12.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:36:0)
[10:20:12.635] Timer tick, asking Buildbucket for the build status
[10:20:12.744] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:12.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:37:0) after 1m0s
[10:21:12.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:37:0)
[10:21:12.857] Timer tick, asking Buildbucket for the build status
[10:21:12.991] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:12.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:38:0) after 1m0s
[10:22:13.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:38:0)
[10:22:13.145] Timer tick, asking Buildbucket for the build status
[10:22:13.199] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:13.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:39:0) after 1m0s
[10:23:13.326] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:39:0)
[10:23:13.326] Timer tick, asking Buildbucket for the build status
[10:23:13.385] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:13.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:40:0) after 1m0s
[10:24:13.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:40:0)
[10:24:13.529] Timer tick, asking Buildbucket for the build status
[10:24:13.585] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:13.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:41:0) after 1m0s
[10:25:13.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:41:0)
[10:25:13.670] Timer tick, asking Buildbucket for the build status
[10:25:13.744] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:13.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:42:0) after 1m0s
[10:26:13.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:42:0)
[10:26:13.762] Timer tick, asking Buildbucket for the build status
[10:26:13.876] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:13.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:43:0) after 1m0s
[10:27:13.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:43:0)
[10:27:13.932] Timer tick, asking Buildbucket for the build status
[10:27:14.133] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:14.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:44:0) after 1m0s
[10:28:14.150] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:44:0)
[10:28:14.150] Timer tick, asking Buildbucket for the build status
[10:28:14.243] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:14.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:45:0) after 1m0s
[10:29:14.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:45:0)
[10:29:14.288] Timer tick, asking Buildbucket for the build status
[10:29:14.361] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:14.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:46:0) after 1m0s
[10:30:14.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:46:0)
[10:30:14.379] Timer tick, asking Buildbucket for the build status
[10:30:14.438] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:14.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:47:0) after 1m0s
[10:31:14.459] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:47:0)
[10:31:14.459] Timer tick, asking Buildbucket for the build status
[10:31:14.601] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:14.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:48:0) after 1m0s
[10:32:14.619] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:48:0)
[10:32:14.619] Timer tick, asking Buildbucket for the build status
[10:32:14.722] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:14.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:49:0) after 1m0s
[10:33:14.744] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:49:0)
[10:33:14.744] Timer tick, asking Buildbucket for the build status
[10:33:14.813] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:14.813] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:50:0) after 1m0s
[10:34:14.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:50:0)
[10:34:14.834] Timer tick, asking Buildbucket for the build status
[10:34:14.911] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:14.911] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:51:0) after 1m0s
[10:35:14.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:51:0)
[10:35:14.932] Timer tick, asking Buildbucket for the build status
[10:35:15.008] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:15.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:52:0) after 1m0s
[10:36:15.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:52:0)
[10:36:15.063] Timer tick, asking Buildbucket for the build status
[10:36:15.211] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:15.211] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:53:0) after 1m0s
[10:37:15.228] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:53:0)
[10:37:15.228] Timer tick, asking Buildbucket for the build status
[10:37:15.301] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:15.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:54:0) after 1m0s
[10:38:15.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:54:0)
[10:38:15.339] Timer tick, asking Buildbucket for the build status
[10:38:15.429] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:15.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:55:0) after 1m0s
[10:39:15.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:55:0)
[10:39:15.448] Timer tick, asking Buildbucket for the build status
[10:39:15.514] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:15.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:56:0) after 1m0s
[10:40:15.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:56:0)
[10:40:15.532] Timer tick, asking Buildbucket for the build status
[10:40:15.591] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:15.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:57:0) after 1m0s
[10:41:15.614] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:57:0)
[10:41:15.614] Timer tick, asking Buildbucket for the build status
[10:41:15.952] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:15.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:58:0) after 1m0s
[10:42:16.029] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:58:0)
[10:42:16.029] Timer tick, asking Buildbucket for the build status
[10:42:16.139] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:16.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:59:0) after 1m0s
[10:43:16.160] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:59:0)
[10:43:16.160] Timer tick, asking Buildbucket for the build status
[10:43:16.241] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:16.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:60:0) after 1m0s
[10:44:16.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:60:0)
[10:44:16.261] Timer tick, asking Buildbucket for the build status
[10:44:16.346] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:16.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:61:0) after 1m0s
[10:45:16.368] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:61:0)
[10:45:16.368] Timer tick, asking Buildbucket for the build status
[10:45:16.415] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:16.415] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:62:0) after 1m0s
[10:46:16.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:62:0)
[10:46:16.461] Timer tick, asking Buildbucket for the build status
[10:46:16.591] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:16.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:63:0) after 1m0s
[10:47:16.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:63:0)
[10:47:16.697] Timer tick, asking Buildbucket for the build status
[10:47:16.872] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:16.872] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:64:0) after 1m0s
[10:48:17.029] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:64:0)
[10:48:17.029] Timer tick, asking Buildbucket for the build status
[10:48:17.070] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:17.070] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:65:0) after 1m0s
[10:49:17.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:65:0)
[10:49:17.087] Timer tick, asking Buildbucket for the build status
[10:49:17.200] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:17.200] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:66:0) after 1m0s
[10:50:17.368] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:66:0)
[10:50:17.368] Timer tick, asking Buildbucket for the build status
[10:50:17.427] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:17.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:67:0) after 1m0s
[10:51:17.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:67:0)
[10:51:17.529] Timer tick, asking Buildbucket for the build status
[10:51:17.588] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:17.588] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:68:0) after 1m0s
[10:52:17.708] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:68:0)
[10:52:17.708] Timer tick, asking Buildbucket for the build status
[10:52:17.818] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:17.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:69:0) after 1m0s
[10:53:17.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:69:0)
[10:53:17.908] Timer tick, asking Buildbucket for the build status
[10:53:17.953] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:17.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:70:0) after 1m0s
[10:54:17.972] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:70:0)
[10:54:17.972] Timer tick, asking Buildbucket for the build status
[10:54:18.041] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:18.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:71:0) after 1m0s
[10:55:18.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:71:0)
[10:55:18.064] Timer tick, asking Buildbucket for the build status
[10:55:18.232] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:18.232] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:72:0) after 1m0s
[10:56:18.252] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:72:0)
[10:56:18.252] Timer tick, asking Buildbucket for the build status
[10:56:20.486] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:20.486] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:73:0) after 1m0s
[10:57:20.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:73:0)
[10:57:20.506] Timer tick, asking Buildbucket for the build status
[10:57:20.647] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:20.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:74:0) after 1m0s
[10:58:20.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:74:0)
[10:58:20.667] Timer tick, asking Buildbucket for the build status
[10:58:20.705] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:20.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:75:0) after 1m0s
[10:59:20.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:75:0)
[10:59:20.724] Timer tick, asking Buildbucket for the build status
[10:59:20.763] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:20.763] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:76:0) after 1m0s
[11:00:20.791] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:76:0)
[11:00:20.791] Timer tick, asking Buildbucket for the build status
[11:00:20.952] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:20.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:77:0) after 1m0s
[11:01:21.050] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:77:0)
[11:01:21.050] Timer tick, asking Buildbucket for the build status
[11:01:21.106] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:21.106] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:78:0) after 1m0s
[11:02:21.127] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:78:0)
[11:02:21.127] Timer tick, asking Buildbucket for the build status
[11:02:21.175] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:21.175] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:79:0) after 1m0s
[11:03:21.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:79:0)
[11:03:21.196] Timer tick, asking Buildbucket for the build status
[11:03:21.273] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:21.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:80:0) after 1m0s
[11:04:21.366] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:80:0)
[11:04:21.366] Timer tick, asking Buildbucket for the build status
[11:04:21.418] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:21.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:81:0) after 1m0s
[11:05:21.441] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:81:0)
[11:05:21.441] Timer tick, asking Buildbucket for the build status
[11:05:21.480] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:21.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:82:0) after 1m0s
[11:06:21.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:82:0)
[11:06:21.513] Timer tick, asking Buildbucket for the build status
[11:06:21.627] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:21.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:83:0) after 1m0s
[11:07:21.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:83:0)
[11:07:21.647] Timer tick, asking Buildbucket for the build status
[11:07:21.720] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:21.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:84:0) after 1m0s
[11:08:21.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:84:0)
[11:08:21.782] Timer tick, asking Buildbucket for the build status
[11:08:21.819] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:21.819] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:85:0) after 1m0s
[11:09:21.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:85:0)
[11:09:21.874] Timer tick, asking Buildbucket for the build status
[11:09:21.938] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:21.938] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:86:0) after 1m0s
[11:10:21.960] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:86:0)
[11:10:21.960] Timer tick, asking Buildbucket for the build status
[11:10:22.041] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:22.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:87:0) after 1m0s
[11:11:22.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:87:0)
[11:11:22.063] Timer tick, asking Buildbucket for the build status
[11:11:22.262] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:22.262] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:88:0) after 1m0s
[11:12:22.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:88:0)
[11:12:22.328] Timer tick, asking Buildbucket for the build status
[11:12:22.414] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:22.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:89:0) after 1m0s
[11:13:22.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:89:0)
[11:13:22.473] Timer tick, asking Buildbucket for the build status
[11:13:22.512] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:22.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:90:0) after 1m0s
[11:14:22.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:90:0)
[11:14:22.624] Timer tick, asking Buildbucket for the build status
[11:14:22.749] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:22.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:91:0) after 1m0s
[11:15:22.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:91:0)
[11:15:22.880] Timer tick, asking Buildbucket for the build status
[11:15:23.488] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:23.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:92:0) after 1m0s
[11:16:23.521] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:92:0)
[11:16:23.521] Timer tick, asking Buildbucket for the build status
[11:16:23.996] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:23.996] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:93:0) after 1m0s
[11:17:24.019] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:93:0)
[11:17:24.019] Timer tick, asking Buildbucket for the build status
[11:17:24.231] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:24.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:94:0) after 1m0s
[11:18:24.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:94:0)
[11:18:24.251] Timer tick, asking Buildbucket for the build status
[11:18:24.323] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:24.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:95:0) after 1m0s
[11:19:24.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:95:0)
[11:19:24.343] Timer tick, asking Buildbucket for the build status
[11:19:24.443] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:24.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:96:0) after 1m0s
[11:20:24.486] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:96:0)
[11:20:24.486] Timer tick, asking Buildbucket for the build status
[11:20:24.572] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:24.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:97:0) after 1m0s
[11:21:24.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:97:0)
[11:21:24.629] Timer tick, asking Buildbucket for the build status
[11:21:24.952] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:24.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:98:0) after 1m0s
[11:22:24.990] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:98:0)
[11:22:24.990] Timer tick, asking Buildbucket for the build status
[11:22:25.086] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:25.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:99:0) after 1m0s
[11:23:25.118] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:99:0)
[11:23:25.118] Timer tick, asking Buildbucket for the build status
[11:23:25.197] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:25.197] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:100:0) after 1m0s
[11:24:25.217] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:100:0)
[11:24:25.217] Timer tick, asking Buildbucket for the build status
[11:24:25.425] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:25.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:101:0) after 1m0s
[11:25:25.445] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:101:0)
[11:25:25.445] Timer tick, asking Buildbucket for the build status
[11:25:25.508] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:25.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:102:0) after 1m0s
[11:26:25.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:102:0)
[11:26:25.529] Timer tick, asking Buildbucket for the build status
[11:26:25.658] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:25.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:103:0) after 1m0s
[11:27:25.769] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:103:0)
[11:27:25.769] Timer tick, asking Buildbucket for the build status
[11:27:25.838] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:25.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:104:0) after 1m0s
[11:28:25.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:104:0)
[11:28:25.889] Timer tick, asking Buildbucket for the build status
[11:28:26.035] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:26.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:105:0) after 1m0s
[11:29:26.058] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:105:0)
[11:29:26.058] Timer tick, asking Buildbucket for the build status
[11:29:26.092] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:26.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:106:0) after 1m0s
[11:30:26.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:106:0)
[11:30:26.111] Timer tick, asking Buildbucket for the build status
[11:30:26.187] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:26.187] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:107:0) after 1m0s
[11:31:26.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:107:0)
[11:31:26.348] Timer tick, asking Buildbucket for the build status
[11:31:26.469] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:26.469] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:108:0) after 1m0s
[11:32:26.491] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:108:0)
[11:32:26.491] Timer tick, asking Buildbucket for the build status
[11:32:26.551] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:26.551] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:109:0) after 1m0s
[11:33:26.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:109:0)
[11:33:26.576] Timer tick, asking Buildbucket for the build status
[11:33:26.664] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:26.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:110:0) after 1m0s
[11:34:26.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:110:0)
[11:34:26.689] Timer tick, asking Buildbucket for the build status
[11:34:26.763] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:26.763] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:111:0) after 1m0s
[11:35:26.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:111:0)
[11:35:26.795] Timer tick, asking Buildbucket for the build status
[11:35:26.867] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:26.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:112:0) after 1m0s
[11:36:26.886] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:112:0)
[11:36:26.886] Timer tick, asking Buildbucket for the build status
[11:36:27.003] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:27.003] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:113:0) after 1m0s
[11:37:27.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:113:0)
[11:37:27.024] Timer tick, asking Buildbucket for the build status
[11:37:27.124] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:27.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:114:0) after 1m0s
[11:38:27.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:114:0)
[11:38:27.144] Timer tick, asking Buildbucket for the build status
[11:38:27.385] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:27.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:115:0) after 1m0s
[11:39:27.404] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:115:0)
[11:39:27.404] Timer tick, asking Buildbucket for the build status
[11:39:27.480] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:27.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:116:0) after 1m0s
[11:40:27.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:116:0)
[11:40:27.510] Timer tick, asking Buildbucket for the build status
[11:40:27.548] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:27.548] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:117:0) after 1m0s
[11:41:27.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:117:0)
[11:41:27.571] Timer tick, asking Buildbucket for the build status
[11:41:27.658] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:27.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:118:0) after 1m0s
[11:42:27.677] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:118:0)
[11:42:27.677] Timer tick, asking Buildbucket for the build status
[11:42:27.731] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:27.731] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:119:0) after 1m0s
[11:43:27.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:119:0)
[11:43:27.753] Timer tick, asking Buildbucket for the build status
[11:43:27.858] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:27.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:120:0) after 1m0s
[11:44:27.915] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:120:0)
[11:44:27.915] Timer tick, asking Buildbucket for the build status
[11:44:27.987] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:27.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:121:0) after 1m0s
[11:45:28.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:121:0)
[11:45:28.010] Timer tick, asking Buildbucket for the build status
[11:45:28.108] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:28.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:122:0) after 1m0s
[11:46:28.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:122:0)
[11:46:28.284] Timer tick, asking Buildbucket for the build status
[11:46:28.347] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:28.347] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:123:0) after 1m0s
[11:47:28.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:123:0)
[11:47:28.475] Timer tick, asking Buildbucket for the build status
[11:47:28.533] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:28.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:124:0) after 1m0s
[11:48:28.631] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:124:0)
[11:48:28.631] Timer tick, asking Buildbucket for the build status
[11:48:28.803] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:28.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:125:0) after 1m0s
[11:49:28.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:125:0)
[11:49:28.945] Timer tick, asking Buildbucket for the build status
[11:49:29.009] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:29.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:126:0) after 1m0s
[11:50:29.204] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:126:0)
[11:50:29.204] Timer tick, asking Buildbucket for the build status
[11:50:29.270] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:29.270] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:127:0) after 1m0s
[11:51:29.383] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:127:0)
[11:51:29.383] Timer tick, asking Buildbucket for the build status
[11:51:29.455] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:29.455] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:128:0) after 1m0s
[11:52:29.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:128:0)
[11:52:29.590] Timer tick, asking Buildbucket for the build status
[11:52:29.699] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:29.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:129:0) after 1m0s
[11:53:29.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:129:0)
[11:53:29.756] Timer tick, asking Buildbucket for the build status
[11:53:29.954] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:29.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:130:0) after 1m0s
[11:54:29.974] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:130:0)
[11:54:29.974] Timer tick, asking Buildbucket for the build status
[11:54:30.069] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:30.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:131:0) after 1m0s
[11:55:30.175] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:131:0)
[11:55:30.175] Timer tick, asking Buildbucket for the build status
[11:55:30.301] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:30.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:132:0) after 1m0s
[11:56:30.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:132:0)
[11:56:30.399] Timer tick, asking Buildbucket for the build status
[11:56:30.510] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:30.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:133:0) after 1m0s
[11:57:30.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:133:0)
[11:57:30.626] Timer tick, asking Buildbucket for the build status
[11:57:30.855] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:30.855] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:134:0) after 1m0s
[11:58:30.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:134:0)
[11:58:30.877] Timer tick, asking Buildbucket for the build status
[11:58:30.944] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:30.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:135:0) after 1m0s
[11:59:30.966] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:135:0)
[11:59:30.966] Timer tick, asking Buildbucket for the build status
[11:59:31.117] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:31.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:136:0) after 1m0s
[12:00:31.143] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:136:0)
[12:00:31.143] Timer tick, asking Buildbucket for the build status
[12:00:31.250] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:31.250] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:137:0) after 1m0s
[12:01:31.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:137:0)
[12:01:31.330] Timer tick, asking Buildbucket for the build status
[12:01:31.419] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:31.419] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:138:0) after 1m0s
[12:02:31.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:138:0)
[12:02:31.531] Timer tick, asking Buildbucket for the build status
[12:02:31.644] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:31.644] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:139:0) after 1m0s
[12:03:31.725] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:139:0)
[12:03:31.725] Timer tick, asking Buildbucket for the build status
[12:03:31.843] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:31.843] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:140:0) after 1m0s
[12:04:31.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:140:0)
[12:04:31.868] Timer tick, asking Buildbucket for the build status
[12:04:31.999] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:31.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:141:0) after 1m0s
[12:05:32.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:141:0)
[12:05:32.025] Timer tick, asking Buildbucket for the build status
[12:05:32.131] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:32.131] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:142:0) after 1m0s
[12:06:32.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:142:0)
[12:06:32.152] Timer tick, asking Buildbucket for the build status
[12:06:32.231] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:32.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:143:0) after 1m0s
[12:07:32.254] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:143:0)
[12:07:32.255] Timer tick, asking Buildbucket for the build status
[12:07:32.322] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:32.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:144:0) after 1m0s
[12:08:32.434] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:144:0)
[12:08:32.434] Timer tick, asking Buildbucket for the build status
[12:08:32.526] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:32.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:145:0) after 1m0s
[12:09:32.551] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:145:0)
[12:09:32.551] Timer tick, asking Buildbucket for the build status
[12:09:32.692] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:32.692] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:146:0) after 1m0s
[12:10:32.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:146:0)
[12:10:32.718] Timer tick, asking Buildbucket for the build status
[12:10:32.874] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:32.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:147:0) after 1m0s
[12:11:32.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:147:0)
[12:11:32.939] Timer tick, asking Buildbucket for the build status
[12:11:33.030] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:33.030] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:148:0) after 1m0s
[12:12:33.051] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:148:0)
[12:12:33.051] Timer tick, asking Buildbucket for the build status
[12:12:33.226] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:33.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:149:0) after 1m0s
[12:13:33.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:149:0)
[12:13:33.249] Timer tick, asking Buildbucket for the build status
[12:13:33.311] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:33.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:150:0) after 1m0s
[12:14:33.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:150:0)
[12:14:33.334] Timer tick, asking Buildbucket for the build status
[12:14:33.392] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:33.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:151:0) after 1m0s
[12:15:33.438] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:151:0)
[12:15:33.438] Timer tick, asking Buildbucket for the build status
[12:15:33.662] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:33.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:152:0) after 1m0s
[12:16:33.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:152:0)
[12:16:33.741] Timer tick, asking Buildbucket for the build status
[12:16:33.896] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:33.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:153:0) after 1m0s
[12:17:33.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:153:0)
[12:17:33.964] Timer tick, asking Buildbucket for the build status
[12:17:34.086] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:34.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:154:0) after 1m0s
[12:18:34.250] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:154:0)
[12:18:34.250] Timer tick, asking Buildbucket for the build status
[12:18:34.429] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:34.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:155:0) after 1m0s
[12:19:34.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:155:0)
[12:19:34.562] Timer tick, asking Buildbucket for the build status
[12:19:34.670] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:34.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:156:0) after 1m0s
[12:20:34.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:156:0)
[12:20:34.751] Timer tick, asking Buildbucket for the build status
[12:20:34.835] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:34.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:157:0) after 1m0s
[12:21:34.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:157:0)
[12:21:34.922] Timer tick, asking Buildbucket for the build status
[12:21:34.981] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:34.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:158:0) after 1m0s
[12:22:35.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:158:0)
[12:22:35.045] Timer tick, asking Buildbucket for the build status
[12:22:35.123] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:35.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:159:0) after 1m0s
[12:23:35.270] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:159:0)
[12:23:35.270] Timer tick, asking Buildbucket for the build status
[12:23:35.457] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:35.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:160:0) after 1m0s
[12:24:35.591] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:160:0)
[12:24:35.591] Timer tick, asking Buildbucket for the build status
[12:24:35.724] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:35.724] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:161:0) after 1m0s
[12:25:35.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:161:0)
[12:25:35.750] Timer tick, asking Buildbucket for the build status
[12:25:35.824] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:35.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:162:0) after 1m0s
[12:26:35.890] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:162:0)
[12:26:35.890] Timer tick, asking Buildbucket for the build status
[12:26:36.057] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:36.058] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:163:0) after 1m0s
[12:27:36.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:163:0)
[12:27:36.159] Timer tick, asking Buildbucket for the build status
[12:27:36.272] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:36.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:164:0) after 1m0s
[12:28:36.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:164:0)
[12:28:36.382] Timer tick, asking Buildbucket for the build status
[12:28:36.522] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:36.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:165:0) after 1m0s
[12:29:36.604] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:165:0)
[12:29:36.604] Timer tick, asking Buildbucket for the build status
[12:29:36.743] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:36.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:166:0) after 1m0s
[12:30:36.769] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:166:0)
[12:30:36.769] Timer tick, asking Buildbucket for the build status
[12:30:37.089] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:37.089] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:167:0) after 1m0s
[12:31:37.114] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:167:0)
[12:31:37.114] Timer tick, asking Buildbucket for the build status
[12:31:37.217] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:37.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:168:0) after 1m0s
[12:32:37.241] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:168:0)
[12:32:37.241] Timer tick, asking Buildbucket for the build status
[12:32:37.377] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:37.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:169:0) after 1m0s
[12:33:37.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:169:0)
[12:33:37.413] Timer tick, asking Buildbucket for the build status
[12:33:37.594] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:37.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:170:0) after 1m0s
[12:34:37.619] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:170:0)
[12:34:37.619] Timer tick, asking Buildbucket for the build status
[12:34:37.952] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:37.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:171:0) after 1m0s
[12:35:37.977] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:171:0)
[12:35:37.977] Timer tick, asking Buildbucket for the build status
[12:35:38.055] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:38.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:172:0) after 1m0s
[12:36:38.090] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:172:0)
[12:36:38.090] Timer tick, asking Buildbucket for the build status
[12:36:38.217] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:38.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:173:0) after 1m0s
[12:37:38.243] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:173:0)
[12:37:38.243] Timer tick, asking Buildbucket for the build status
[12:37:38.302] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:38.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:174:0) after 1m0s
[12:38:38.333] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:174:0)
[12:38:38.333] Timer tick, asking Buildbucket for the build status
[12:38:38.429] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:38.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:175:0) after 1m0s
[12:39:38.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:175:0)
[12:39:38.460] Timer tick, asking Buildbucket for the build status
[12:39:38.575] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:38.576] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:176:0) after 1m0s
[12:40:38.606] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:176:0)
[12:40:38.606] Timer tick, asking Buildbucket for the build status
[12:40:38.728] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:38.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:177:0) after 1m0s
[12:41:38.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:177:0)
[12:41:38.753] Timer tick, asking Buildbucket for the build status
[12:41:38.818] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:38.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:178:0) after 1m0s
[12:42:38.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:178:0)
[12:42:38.843] Timer tick, asking Buildbucket for the build status
[12:42:39.031] Build 8938407703711877904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:39.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9103837765801809680:179:0) after 1m0s
[12:42:57.820] Received PubSub notification, asking Buildbucket for the build status
[12:42:57.876] Build 8938407703711877904: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:42:57.876] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary": true,
    "canary_preference": "AUTO",
    "completed_ts": "1534077776603330",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1534067165610390",
    "failure_reason": "BUILD_FAILURE",
    "id": "8938407703711877904",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"3813411d14c88cb8349a0b398bdb069c824b8467\"}}",
    "project": "chromium",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"Failure compare_build_artifacts\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"failure\": {\"failure\": {\"step\": \"compare_build_artifacts\"}, \"humanReason\": \"Step('compare_build_artifacts') failed with return_code 1\"}}, \"recipeExitCode\": {\"value\": 1}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8938407703711877904/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"builder\": [\"Windows deterministic\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3712-19aca72\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"swarm2173-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"96088f46727b75b2f6a24e1b62e5cc59ddb4612d\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"3813411d14c88cb8349a0b398bdb069c824b8467\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24267}\", \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"got_revision_cp\": \"refs/heads/master@{#582472}\", \"branch\": \"refs/heads/master\", \"revision\": \"3813411d14c88cb8349a0b398bdb069c824b8467\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"656d609a952aadee549126f56b9e5cbb9d2e85b0\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"7ae70d8fb360a3defe4d6734687748a786d565ae\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1534067165610390, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/3813411d14c88cb8349a0b398bdb069c824b8467\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3813411d14c88cb8349a0b398bdb069c824b8467\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9103837765801809680\", \"scheduler_job_id:chromium/Windows deterministic\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8938407703711877904\"}}, \"got_v8_revision\": \"4fe3de13fc5c2592559bb5e49e1a81a6d09a2efd\", \"got_v8_revision_cp\": \"refs/heads/7.0.193@{#2}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 9713, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"9a90d9aaadeb5e04327ed05775f45132e4b3523f\"}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1534067271714180",
    "status": "COMPLETED",
    "status_changed_ts": "1534077777194230",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/9713",
      "builder:Windows deterministic",
      "buildset:commit/git/3813411d14c88cb8349a0b398bdb069c824b8467",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3813411d14c88cb8349a0b398bdb069c824b8467",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9103837765801809680",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_dimension:builder:Windows deterministic",
      "swarming_dimension:cores:8",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Windows-10",
      "swarming_dimension:pool:luci.chromium.ci",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.chromium.ci/Windows deterministic/9713",
      "swarming_tag:buildbucket_bucket:luci.chromium.ci",
      "swarming_tag:buildbucket_build_id:8938407703711877904",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:1",
      "swarming_tag:buildbucket_template_revision:477c78a99beff1a2cb211f905b69db7eeb4c6c44",
      "swarming_tag:builder:Windows deterministic",
      "swarming_tag:buildset:commit/git/3813411d14c88cb8349a0b398bdb069c824b8467",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3813411d14c88cb8349a0b398bdb069c824b8467",
      "swarming_tag:cores:8",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8938407703711877904/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:os:Windows-10",
      "swarming_tag:pool:luci.chromium.ci",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:swarming/deterministic_build",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9103837765801809680",
      "swarming_tag:scheduler_job_id:chromium/Windows deterministic",
      "swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:f4e8a443fc6511d05aa1aaa96ecce4b5b4e69d60",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:3f4658d493f77410",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1534077777195960",
    "url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9713",
    "utcnow_ts": "1534077777862700"
  }
}
[12:42:57.876] Invocation finished in 2h56m53.643112158s with status FAILED