LUCI Scheduler :: chromium :: Windows deterministic

Status: FAILED

Triggered by: -

Duration: 2 hours

Actions:

Definition (rev 4c3247f4ed8a00ea6dc37d6edf987ff8d0e003c5)

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

Incoming triggers

db31179773112e31108d97d148f3fed382cdbfe1 (7 years ago)
faaa279bbc2e1656811684ffac781e8418a665a0 (7 years ago)
61e3ffbd225acfc1ed280a780fece13981d1e032 (7 years ago)
2831df88737aee78641e94ef661ea9d7e179db6a (7 years ago)
afe350c66cab481750b9623fb1b8540a7d23148d (7 years ago)
c470cedc635f679911b9c4ee8a66c19f1f1f34ee (7 years ago)
099c25fdfbbaacfdc165ce61ce6e710c21a1057a (7 years ago)
17e4730bf2b29ee549adbcdb955740360f7da0a2 (7 years ago)
08aed290f42041ab29fc82ef6e127c33e2871b47 (7 years ago)
8a588776cbc6b0b9d240d01df6c6723eb2ea7686 (7 years ago)
9db0419223cc52d9f2bb05c4c0ae1a9995a8f437 (7 years ago)
eef6caef5b84e632e27867618d3e3e77d0aee29d (7 years ago)
a875e918720c9aacbe18316f50a44e8c29efebd1 (7 years ago)
c76d8f8e89a57da69f1747b209d7aa816ab2ae0c (7 years ago)
4c5080dad87cc589e6fb21c696942a575a5153cb (7 years ago)
c114317110c46d1ee35db54df79f2bcb9c5c2ffb (7 years ago)
74ed83f004dce34ff89eaa73a805f7cf19721490 (7 years ago)
d9a83211b4a844fd3a9454804f4592910880df5c (7 years ago)
d3ed8bf5413044fa2970f07a3a46ac204d2bc4f6 (7 years ago)
8a796386c11afd362231d68d10fddea5fee4bb62 (7 years ago)
18f3108b32cfc23e9d6d0d29e3c04633c9fd7ad3 (7 years ago)
7740e10ebbe917e45adcf5205bc183ca06f74bff (7 years ago)
f61f302c753a1e4bc2abcb206a984e1b51c8d4b4 (7 years ago)
0094b2fcb0f199474d42f6e21e6bee9ef1aa6a60 (7 years ago)
0ec491f17f72fd16ea90db2103f8fc52eade12a1 (7 years ago)
03d0731cbabcfa72e36d9bbe2b5afa238fd55f5d (7 years ago)
9de1ab09c3569b156fa02df9fe8d3a3810ca0323 (7 years ago)
aa9c7c217a846c43dced445cf2e9c86e14f8a8fa (7 years ago)
1c052c978e972780aed2373d104081e28cd29211 (7 years ago)
6500528f8b17bbbfb0846962d8bf754e02aeeb07 (7 years ago)
4205d6e8d3370bc816d722e908a372921936dd8a (7 years ago)
2e90ccc0173b0e47cbf6f2ba5c6c408c4ef96747 (7 years ago)
8e7f855713efc04354d85186c8fe71eb022c660a (7 years ago)
de610823c81c9740c5e5174dc748389caeb37f35 (7 years ago)
15240176470e8e27cbb130a064415fb5401a2cc2 (7 years ago)
a54ca0d43b47c139953f45f8639fb99b90ae939a (7 years ago)
64c192c467773e40249baf225ad3d2756694b174 (7 years ago)
fc57cefb32d9767c137b3fa41a5a2f578b099621 (7 years ago)
0d97abe82fb0f4bfaf9ca4c21231add9c358344f (7 years ago)
58db3f4abe63721b8508ae2668457fd0afb18d7c (7 years ago)
227bf604108c1a7c139d992c5b4e416c7cc501be (7 years ago)
9eca44242f7b0f42a4af33e1dbda178785ca91af (7 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[20:38:18.389] New invocation is queued and will start shortly
[20:38:19.716] Starting the invocation (attempt 1)
[20:38:19.758] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:38:19.758] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:38:19.758] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9089120022124784320",
  "parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"9eca44242f7b0f42a4af33e1dbda178785ca91af\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Windows deterministic",
    "scheduler_invocation_id:9089120022124784320",
    "scheduler_job_id:chromium/Windows deterministic",
    "user_agent:luci-scheduler",
    "buildset:commit/git/9eca44242f7b0f42a4af33e1dbda178785ca91af",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9eca44242f7b0f42a4af33e1dbda178785ca91af",
    "gitiles_ref:refs/heads/master"
  ]
}
[20:38:21.129] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary": true,
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1548103099831133",
    "id": "8923689959950235392",
    "lease_expiration_ts": "1548221900940177",
    "lease_key": "28931448",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9eca44242f7b0f42a4af33e1dbda178785ca91af\"}}",
    "project": "chromium",
    "result_details_json": "null",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1548103101027967",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/11697",
      "builder:Windows deterministic",
      "buildset:commit/git/9eca44242f7b0f42a4af33e1dbda178785ca91af",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9eca44242f7b0f42a4af33e1dbda178785ca91af",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9089120022124784320",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_dimension:builder:Windows deterministic",
      "swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
      "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/11697",
      "swarming_tag:buildbucket_bucket:chromium/ci",
      "swarming_tag:buildbucket_build_id:8923689959950235392",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:1",
      "swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
      "swarming_tag:builder:Windows deterministic",
      "swarming_tag:buildset:commit/git/9eca44242f7b0f42a4af33e1dbda178785ca91af",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9eca44242f7b0f42a4af33e1dbda178785ca91af",
      "swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
      "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/8923689959950235392/+/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:9089120022124784320",
      "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:4122e711faf74a549260c6de6a369a8fe79a9d3e",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:428af430c76fc710",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1548103101028046",
    "url": "https://ci.chromium.org/b/8923689959950235392",
    "utcnow_ts": "1548103101118876"
  }
}
[20:38:21.129] Task URL: https://ci.chromium.org/b/8923689959950235392
[20:38:21.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:2:0) after 1m0s
[20:39:21.181] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:2:0)
[20:39:21.181] Timer tick, asking Buildbucket for the build status
[20:39:21.331] Build 8923689959950235392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:39:21.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:3:0) after 1m0s
[20:40:04.755] Received PubSub notification, asking Buildbucket for the build status
[20:40:04.893] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:21.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:3:0)
[20:40:21.351] Timer tick, asking Buildbucket for the build status
[20:40:21.426] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:21.426] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:5:0) after 1m0s
[20:41:21.441] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:5:0)
[20:41:21.441] Timer tick, asking Buildbucket for the build status
[20:41:21.627] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:21.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:6:0) after 1m0s
[20:42:21.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:6:0)
[20:42:21.642] Timer tick, asking Buildbucket for the build status
[20:42:21.742] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:21.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:7:0) after 1m0s
[20:43:21.760] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:7:0)
[20:43:21.760] Timer tick, asking Buildbucket for the build status
[20:43:21.803] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:21.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:8:0) after 1m0s
[20:44:21.865] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:8:0)
[20:44:21.865] Timer tick, asking Buildbucket for the build status
[20:44:22.009] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:22.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:9:0) after 1m0s
[20:45:22.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:9:0)
[20:45:22.028] Timer tick, asking Buildbucket for the build status
[20:45:22.076] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:22.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:10:0) after 1m0s
[20:46:22.168] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:10:0)
[20:46:22.168] Timer tick, asking Buildbucket for the build status
[20:46:22.326] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:22.326] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:11:0) after 1m0s
[20:47:22.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:11:0)
[20:47:22.343] Timer tick, asking Buildbucket for the build status
[20:47:22.390] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:22.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:12:0) after 1m0s
[20:48:22.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:12:0)
[20:48:22.406] Timer tick, asking Buildbucket for the build status
[20:48:22.586] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:22.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:13:0) after 1m0s
[20:49:22.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:13:0)
[20:49:22.675] Timer tick, asking Buildbucket for the build status
[20:49:22.810] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:22.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:14:0) after 1m0s
[20:50:22.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:14:0)
[20:50:22.888] Timer tick, asking Buildbucket for the build status
[20:50:23.062] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:23.062] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:15:0) after 1m0s
[20:51:23.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:15:0)
[20:51:23.086] Timer tick, asking Buildbucket for the build status
[20:51:23.149] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:23.149] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:16:0) after 1m0s
[20:52:23.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:16:0)
[20:52:23.198] Timer tick, asking Buildbucket for the build status
[20:52:23.240] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:23.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:17:0) after 1m0s
[20:53:23.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:17:0)
[20:53:23.319] Timer tick, asking Buildbucket for the build status
[20:53:23.356] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:23.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:18:0) after 1m0s
[20:54:23.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:18:0)
[20:54:23.406] Timer tick, asking Buildbucket for the build status
[20:54:23.555] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:23.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:19:0) after 1m0s
[20:55:23.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:19:0)
[20:55:23.576] Timer tick, asking Buildbucket for the build status
[20:55:23.617] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:23.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:20:0) after 1m0s
[20:56:23.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:20:0)
[20:56:23.634] Timer tick, asking Buildbucket for the build status
[20:56:23.834] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:23.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:21:0) after 1m0s
[20:57:23.854] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:21:0)
[20:57:23.854] Timer tick, asking Buildbucket for the build status
[20:57:24.034] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:24.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:22:0) after 1m0s
[20:58:24.055] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:22:0)
[20:58:24.055] Timer tick, asking Buildbucket for the build status
[20:58:24.126] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:24.126] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:23:0) after 1m0s
[20:59:24.146] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:23:0)
[20:59:24.146] Timer tick, asking Buildbucket for the build status
[20:59:24.335] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:24.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:24:0) after 1m0s
[21:00:24.355] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:24:0)
[21:00:24.355] Timer tick, asking Buildbucket for the build status
[21:00:24.460] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:24.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:25:0) after 1m0s
[21:01:24.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:25:0)
[21:01:24.476] Timer tick, asking Buildbucket for the build status
[21:01:24.880] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:24.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:26:0) after 1m0s
[21:02:24.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:26:0)
[21:02:24.897] Timer tick, asking Buildbucket for the build status
[21:02:24.961] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:24.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:27:0) after 1m0s
[21:03:24.993] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:27:0)
[21:03:24.993] Timer tick, asking Buildbucket for the build status
[21:03:25.076] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:25.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:28:0) after 1m0s
[21:04:25.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:28:0)
[21:04:25.095] Timer tick, asking Buildbucket for the build status
[21:04:25.179] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:25.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:29:0) after 1m0s
[21:05:25.206] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:29:0)
[21:05:25.206] Timer tick, asking Buildbucket for the build status
[21:05:25.363] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:25.363] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:30:0) after 1m0s
[21:06:25.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:30:0)
[21:06:25.448] Timer tick, asking Buildbucket for the build status
[21:06:25.488] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:25.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:31:0) after 1m0s
[21:07:25.543] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:31:0)
[21:07:25.543] Timer tick, asking Buildbucket for the build status
[21:07:25.605] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:25.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:32:0) after 1m0s
[21:08:25.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:32:0)
[21:08:25.624] Timer tick, asking Buildbucket for the build status
[21:08:25.660] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:25.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:33:0) after 1m0s
[21:09:25.679] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:33:0)
[21:09:25.679] Timer tick, asking Buildbucket for the build status
[21:09:25.744] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:25.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:34:0) after 1m0s
[21:10:25.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:34:0)
[21:10:25.762] Timer tick, asking Buildbucket for the build status
[21:10:25.802] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:25.802] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:35:0) after 1m0s
[21:11:25.819] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:35:0)
[21:11:25.819] Timer tick, asking Buildbucket for the build status
[21:11:25.953] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:25.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:36:0) after 1m0s
[21:12:25.984] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:36:0)
[21:12:25.984] Timer tick, asking Buildbucket for the build status
[21:12:26.040] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:26.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:37:0) after 1m0s
[21:13:26.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:37:0)
[21:13:26.064] Timer tick, asking Buildbucket for the build status
[21:13:26.133] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:26.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:38:0) after 1m0s
[21:14:26.171] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:38:0)
[21:14:26.171] Timer tick, asking Buildbucket for the build status
[21:14:26.227] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:26.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:39:0) after 1m0s
[21:15:26.253] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:39:0)
[21:15:26.253] Timer tick, asking Buildbucket for the build status
[21:15:26.723] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:26.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:40:0) after 1m0s
[21:16:26.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:40:0)
[21:16:26.742] Timer tick, asking Buildbucket for the build status
[21:16:26.789] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:26.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:41:0) after 1m0s
[21:17:26.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:41:0)
[21:17:26.864] Timer tick, asking Buildbucket for the build status
[21:17:26.915] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:26.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:42:0) after 1m0s
[21:18:26.968] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:42:0)
[21:18:26.968] Timer tick, asking Buildbucket for the build status
[21:18:27.044] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:27.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:43:0) after 1m0s
[21:19:27.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:43:0)
[21:19:27.064] Timer tick, asking Buildbucket for the build status
[21:19:27.214] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:27.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:44:0) after 1m0s
[21:20:27.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:44:0)
[21:20:27.236] Timer tick, asking Buildbucket for the build status
[21:20:27.290] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:27.290] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:45:0) after 1m0s
[21:21:27.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:45:0)
[21:21:27.308] Timer tick, asking Buildbucket for the build status
[21:21:27.342] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:27.342] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:46:0) after 1m0s
[21:22:27.362] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:46:0)
[21:22:27.362] Timer tick, asking Buildbucket for the build status
[21:22:27.435] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:27.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:47:0) after 1m0s
[21:23:27.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:47:0)
[21:23:27.456] Timer tick, asking Buildbucket for the build status
[21:23:27.545] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:27.545] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:48:0) after 1m0s
[21:24:27.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:48:0)
[21:24:27.562] Timer tick, asking Buildbucket for the build status
[21:24:27.636] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:27.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:49:0) after 1m0s
[21:25:27.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:49:0)
[21:25:27.657] Timer tick, asking Buildbucket for the build status
[21:25:27.743] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:27.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:50:0) after 1m0s
[21:26:27.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:50:0)
[21:26:27.761] Timer tick, asking Buildbucket for the build status
[21:26:27.923] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:27.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:51:0) after 1m0s
[21:27:27.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:51:0)
[21:27:27.941] Timer tick, asking Buildbucket for the build status
[21:27:27.995] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:27.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:52:0) after 1m0s
[21:28:28.015] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:52:0)
[21:28:28.015] Timer tick, asking Buildbucket for the build status
[21:28:28.136] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:28.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:53:0) after 1m0s
[21:29:28.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:53:0)
[21:29:28.200] Timer tick, asking Buildbucket for the build status
[21:29:28.248] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:28.249] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:54:0) after 1m0s
[21:30:28.267] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:54:0)
[21:30:28.267] Timer tick, asking Buildbucket for the build status
[21:30:28.352] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:28.352] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:55:0) after 1m0s
[21:31:28.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:55:0)
[21:31:28.371] Timer tick, asking Buildbucket for the build status
[21:31:28.437] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:28.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:56:0) after 1m0s
[21:32:28.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:56:0)
[21:32:28.455] Timer tick, asking Buildbucket for the build status
[21:32:28.546] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:28.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:57:0) after 1m0s
[21:33:28.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:57:0)
[21:33:28.563] Timer tick, asking Buildbucket for the build status
[21:33:28.742] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:28.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:58:0) after 1m0s
[21:34:28.759] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:58:0)
[21:34:28.759] Timer tick, asking Buildbucket for the build status
[21:34:28.802] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:28.802] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:59:0) after 1m0s
[21:35:28.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:59:0)
[21:35:28.821] Timer tick, asking Buildbucket for the build status
[21:35:28.875] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:28.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:60:0) after 1m0s
[21:36:28.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:60:0)
[21:36:28.895] Timer tick, asking Buildbucket for the build status
[21:36:28.962] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:28.962] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:61:0) after 1m0s
[21:37:28.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:61:0)
[21:37:28.983] Timer tick, asking Buildbucket for the build status
[21:37:29.031] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:29.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:62:0) after 1m0s
[21:38:29.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:62:0)
[21:38:29.048] Timer tick, asking Buildbucket for the build status
[21:38:29.141] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:29.141] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:63:0) after 1m0s
[21:39:29.161] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:63:0)
[21:39:29.161] Timer tick, asking Buildbucket for the build status
[21:39:29.223] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:29.223] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:64:0) after 1m0s
[21:40:29.243] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:64:0)
[21:40:29.243] Timer tick, asking Buildbucket for the build status
[21:40:29.310] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:29.310] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:65:0) after 1m0s
[21:41:29.393] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:65:0)
[21:41:29.393] Timer tick, asking Buildbucket for the build status
[21:41:29.427] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:29.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:66:0) after 1m0s
[21:42:29.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:66:0)
[21:42:29.505] Timer tick, asking Buildbucket for the build status
[21:42:29.638] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:29.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:67:0) after 1m0s
[21:43:29.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:67:0)
[21:43:29.657] Timer tick, asking Buildbucket for the build status
[21:43:29.742] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:29.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:68:0) after 1m0s
[21:44:29.759] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:68:0)
[21:44:29.759] Timer tick, asking Buildbucket for the build status
[21:44:29.815] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:29.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:69:0) after 1m0s
[21:45:29.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:69:0)
[21:45:29.922] Timer tick, asking Buildbucket for the build status
[21:45:29.955] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:29.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:70:0) after 1m0s
[21:46:29.980] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:70:0)
[21:46:29.980] Timer tick, asking Buildbucket for the build status
[21:46:30.053] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:30.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:71:0) after 1m0s
[21:47:30.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:71:0)
[21:47:30.073] Timer tick, asking Buildbucket for the build status
[21:47:30.186] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:30.186] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:72:0) after 1m0s
[21:48:30.225] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:72:0)
[21:48:30.225] Timer tick, asking Buildbucket for the build status
[21:48:30.294] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:30.294] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:73:0) after 1m0s
[21:49:30.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:73:0)
[21:49:30.325] Timer tick, asking Buildbucket for the build status
[21:49:30.399] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:30.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:74:0) after 1m0s
[21:50:30.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:74:0)
[21:50:30.419] Timer tick, asking Buildbucket for the build status
[21:50:30.464] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:30.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:75:0) after 1m0s
[21:51:30.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:75:0)
[21:51:30.497] Timer tick, asking Buildbucket for the build status
[21:51:30.533] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:30.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:76:0) after 1m0s
[21:52:30.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:76:0)
[21:52:30.553] Timer tick, asking Buildbucket for the build status
[21:52:30.619] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:30.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:77:0) after 1m0s
[21:53:30.687] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:77:0)
[21:53:30.687] Timer tick, asking Buildbucket for the build status
[21:53:30.720] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:30.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:78:0) after 1m0s
[21:54:30.790] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:78:0)
[21:54:30.790] Timer tick, asking Buildbucket for the build status
[21:54:30.831] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:30.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:79:0) after 1m0s
[21:55:30.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:79:0)
[21:55:30.874] Timer tick, asking Buildbucket for the build status
[21:55:30.931] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:30.931] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:80:0) after 1m0s
[21:56:31.029] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:80:0)
[21:56:31.029] Timer tick, asking Buildbucket for the build status
[21:56:31.102] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:31.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:81:0) after 1m0s
[21:57:31.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:81:0)
[21:57:31.176] Timer tick, asking Buildbucket for the build status
[21:57:31.231] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:31.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:82:0) after 1m0s
[21:58:31.254] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:82:0)
[21:58:31.254] Timer tick, asking Buildbucket for the build status
[21:58:31.317] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:31.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:83:0) after 1m0s
[21:59:31.435] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:83:0)
[21:59:31.435] Timer tick, asking Buildbucket for the build status
[21:59:31.513] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:31.513] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:84:0) after 1m0s
[22:00:31.533] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:84:0)
[22:00:31.533] Timer tick, asking Buildbucket for the build status
[22:00:31.595] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:31.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:85:0) after 1m0s
[22:01:31.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:85:0)
[22:01:31.638] Timer tick, asking Buildbucket for the build status
[22:01:31.703] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:31.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:86:0) after 1m0s
[22:02:31.754] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:86:0)
[22:02:31.754] Timer tick, asking Buildbucket for the build status
[22:02:31.793] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:31.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:87:0) after 1m0s
[22:03:31.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:87:0)
[22:03:31.813] Timer tick, asking Buildbucket for the build status
[22:03:32.128] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:32.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:88:0) after 1m0s
[22:04:32.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:88:0)
[22:04:32.149] Timer tick, asking Buildbucket for the build status
[22:04:32.196] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:32.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:89:0) after 1m0s
[22:05:32.223] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:89:0)
[22:05:32.223] Timer tick, asking Buildbucket for the build status
[22:05:32.273] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:32.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:90:0) after 1m0s
[22:06:32.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:90:0)
[22:06:32.296] Timer tick, asking Buildbucket for the build status
[22:06:32.355] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:32.355] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:91:0) after 1m0s
[22:07:32.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:91:0)
[22:07:32.385] Timer tick, asking Buildbucket for the build status
[22:07:32.427] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:32.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:92:0) after 1m0s
[22:08:32.451] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:92:0)
[22:08:32.451] Timer tick, asking Buildbucket for the build status
[22:08:32.481] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:32.481] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:93:0) after 1m0s
[22:09:32.577] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:93:0)
[22:09:32.577] Timer tick, asking Buildbucket for the build status
[22:09:32.611] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:32.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:94:0) after 1m0s
[22:10:32.632] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:94:0)
[22:10:32.632] Timer tick, asking Buildbucket for the build status
[22:10:32.748] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:32.748] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:95:0) after 1m0s
[22:11:32.769] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:95:0)
[22:11:32.769] Timer tick, asking Buildbucket for the build status
[22:11:32.819] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:32.819] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:96:0) after 1m0s
[22:12:32.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:96:0)
[22:12:32.840] Timer tick, asking Buildbucket for the build status
[22:12:32.891] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:32.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:97:0) after 1m0s
[22:13:32.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:97:0)
[22:13:32.911] Timer tick, asking Buildbucket for the build status
[22:13:33.010] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:33.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:98:0) after 1m0s
[22:14:33.029] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:98:0)
[22:14:33.029] Timer tick, asking Buildbucket for the build status
[22:14:33.066] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:33.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:99:0) after 1m0s
[22:15:33.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:99:0)
[22:15:33.093] Timer tick, asking Buildbucket for the build status
[22:15:33.135] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:33.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:100:0) after 1m0s
[22:16:33.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:100:0)
[22:16:33.155] Timer tick, asking Buildbucket for the build status
[22:16:33.338] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:33.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:101:0) after 1m0s
[22:17:33.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:101:0)
[22:17:33.400] Timer tick, asking Buildbucket for the build status
[22:17:33.533] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:33.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:102:0) after 1m0s
[22:18:33.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:102:0)
[22:18:33.553] Timer tick, asking Buildbucket for the build status
[22:18:33.600] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:33.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:103:0) after 1m0s
[22:19:33.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:103:0)
[22:19:33.624] Timer tick, asking Buildbucket for the build status
[22:19:33.677] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:33.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:104:0) after 1m0s
[22:20:33.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:104:0)
[22:20:33.695] Timer tick, asking Buildbucket for the build status
[22:20:33.836] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:33.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:105:0) after 1m0s
[22:21:33.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:105:0)
[22:21:33.912] Timer tick, asking Buildbucket for the build status
[22:21:34.031] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:34.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:106:0) after 1m0s
[22:22:34.054] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:106:0)
[22:22:34.054] Timer tick, asking Buildbucket for the build status
[22:22:34.122] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:34.122] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:107:0) after 1m0s
[22:23:34.148] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:107:0)
[22:23:34.148] Timer tick, asking Buildbucket for the build status
[22:23:34.323] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:34.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:108:0) after 1m0s
[22:24:34.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:108:0)
[22:24:34.375] Timer tick, asking Buildbucket for the build status
[22:24:34.407] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:34.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:109:0) after 1m0s
[22:25:34.436] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:109:0)
[22:25:34.436] Timer tick, asking Buildbucket for the build status
[22:25:34.490] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:34.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:110:0) after 1m0s
[22:26:34.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:110:0)
[22:26:34.532] Timer tick, asking Buildbucket for the build status
[22:26:34.658] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:34.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:111:0) after 1m0s
[22:27:34.680] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:111:0)
[22:27:34.680] Timer tick, asking Buildbucket for the build status
[22:27:34.715] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:34.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:112:0) after 1m0s
[22:28:34.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:112:0)
[22:28:34.734] Timer tick, asking Buildbucket for the build status
[22:28:34.800] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:34.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:113:0) after 1m0s
[22:29:34.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:113:0)
[22:29:34.821] Timer tick, asking Buildbucket for the build status
[22:29:34.890] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:34.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:114:0) after 1m0s
[22:30:34.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:114:0)
[22:30:34.912] Timer tick, asking Buildbucket for the build status
[22:30:34.945] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:34.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:115:0) after 1m0s
[22:31:34.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:115:0)
[22:31:34.971] Timer tick, asking Buildbucket for the build status
[22:31:35.043] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:35.043] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:116:0) after 1m0s
[22:32:35.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:116:0)
[22:32:35.062] Timer tick, asking Buildbucket for the build status
[22:32:35.119] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:35.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:117:0) after 1m0s
[22:33:35.227] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:117:0)
[22:33:35.227] Timer tick, asking Buildbucket for the build status
[22:33:35.317] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:35.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:118:0) after 1m0s
[22:34:35.337] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:118:0)
[22:34:35.337] Timer tick, asking Buildbucket for the build status
[22:34:35.469] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:35.469] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:119:0) after 1m0s
[22:35:35.514] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:119:0)
[22:35:35.514] Timer tick, asking Buildbucket for the build status
[22:35:35.567] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:35.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:120:0) after 1m0s
[22:36:35.586] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:120:0)
[22:36:35.586] Timer tick, asking Buildbucket for the build status
[22:36:35.664] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:35.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:121:0) after 1m0s
[22:37:35.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:121:0)
[22:37:35.685] Timer tick, asking Buildbucket for the build status
[22:37:35.757] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:35.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:122:0) after 1m0s
[22:38:35.780] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:122:0)
[22:38:35.780] Timer tick, asking Buildbucket for the build status
[22:38:35.842] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:35.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:123:0) after 1m0s
[22:39:35.861] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:123:0)
[22:39:35.861] Timer tick, asking Buildbucket for the build status
[22:39:35.916] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:35.916] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:124:0) after 1m0s
[22:40:35.936] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:124:0)
[22:40:35.936] Timer tick, asking Buildbucket for the build status
[22:40:36.001] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:36.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:125:0) after 1m0s
[22:41:36.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:125:0)
[22:41:36.021] Timer tick, asking Buildbucket for the build status
[22:41:36.174] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:36.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:126:0) after 1m0s
[22:42:36.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:126:0)
[22:42:36.196] Timer tick, asking Buildbucket for the build status
[22:42:36.226] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:36.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:127:0) after 1m0s
[22:43:36.248] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:127:0)
[22:43:36.248] Timer tick, asking Buildbucket for the build status
[22:43:36.333] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:36.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:128:0) after 1m0s
[22:44:36.353] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:128:0)
[22:44:36.353] Timer tick, asking Buildbucket for the build status
[22:44:36.397] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:36.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:129:0) after 1m0s
[22:45:36.417] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:129:0)
[22:45:36.417] Timer tick, asking Buildbucket for the build status
[22:45:36.462] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:36.462] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:130:0) after 1m0s
[22:46:36.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:130:0)
[22:46:36.481] Timer tick, asking Buildbucket for the build status
[22:46:36.603] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:36.603] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:131:0) after 1m0s
[22:47:36.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:131:0)
[22:47:36.623] Timer tick, asking Buildbucket for the build status
[22:47:36.715] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:36.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:132:0) after 1m0s
[22:48:36.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:132:0)
[22:48:36.738] Timer tick, asking Buildbucket for the build status
[22:48:36.776] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:36.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:133:0) after 1m0s
[22:49:36.796] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:133:0)
[22:49:36.796] Timer tick, asking Buildbucket for the build status
[22:49:36.857] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:36.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:134:0) after 1m0s
[22:50:36.878] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:134:0)
[22:50:36.878] Timer tick, asking Buildbucket for the build status
[22:50:36.928] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:36.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:135:0) after 1m0s
[22:51:36.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:135:0)
[22:51:36.950] Timer tick, asking Buildbucket for the build status
[22:51:36.997] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:36.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:136:0) after 1m0s
[22:52:37.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:136:0)
[22:52:37.016] Timer tick, asking Buildbucket for the build status
[22:52:37.108] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:37.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:137:0) after 1m0s
[22:53:37.129] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:137:0)
[22:53:37.129] Timer tick, asking Buildbucket for the build status
[22:53:37.172] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:37.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:138:0) after 1m0s
[22:54:37.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:138:0)
[22:54:37.198] Timer tick, asking Buildbucket for the build status
[22:54:37.347] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:37.347] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:139:0) after 1m0s
[22:55:37.370] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:139:0)
[22:55:37.370] Timer tick, asking Buildbucket for the build status
[22:55:37.511] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:37.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:140:0) after 1m0s
[22:56:37.548] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:140:0)
[22:56:37.548] Timer tick, asking Buildbucket for the build status
[22:56:37.584] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:37.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:141:0) after 1m0s
[22:57:37.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:141:0)
[22:57:37.605] Timer tick, asking Buildbucket for the build status
[22:57:37.669] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:37.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:142:0) after 1m0s
[22:58:37.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:142:0)
[22:58:37.695] Timer tick, asking Buildbucket for the build status
[22:58:37.758] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:37.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:143:0) after 1m0s
[22:59:37.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:143:0)
[22:59:37.777] Timer tick, asking Buildbucket for the build status
[22:59:37.832] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:37.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:144:0) after 1m0s
[23:00:37.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:144:0)
[23:00:37.852] Timer tick, asking Buildbucket for the build status
[23:00:37.974] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:37.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:145:0) after 1m0s
[23:01:38.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:145:0)
[23:01:38.017] Timer tick, asking Buildbucket for the build status
[23:01:38.075] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:38.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:146:0) after 1m0s
[23:02:38.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:146:0)
[23:02:38.106] Timer tick, asking Buildbucket for the build status
[23:02:38.172] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:38.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:147:0) after 1m0s
[23:03:38.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:147:0)
[23:03:38.211] Timer tick, asking Buildbucket for the build status
[23:03:38.248] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:38.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:148:0) after 1m0s
[23:04:38.267] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:148:0)
[23:04:38.267] Timer tick, asking Buildbucket for the build status
[23:04:38.324] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:38.324] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:149:0) after 1m0s
[23:05:38.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:149:0)
[23:05:38.349] Timer tick, asking Buildbucket for the build status
[23:05:38.413] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:38.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:150:0) after 1m0s
[23:06:38.436] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:150:0)
[23:06:38.436] Timer tick, asking Buildbucket for the build status
[23:06:38.493] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:38.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:151:0) after 1m0s
[23:07:38.517] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:151:0)
[23:07:38.517] Timer tick, asking Buildbucket for the build status
[23:07:38.555] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:38.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:152:0) after 1m0s
[23:08:38.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:152:0)
[23:08:38.576] Timer tick, asking Buildbucket for the build status
[23:08:38.654] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:38.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:153:0) after 1m0s
[23:09:38.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:153:0)
[23:09:38.675] Timer tick, asking Buildbucket for the build status
[23:09:38.732] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:38.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:154:0) after 1m0s
[23:10:38.752] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:154:0)
[23:10:38.752] Timer tick, asking Buildbucket for the build status
[23:10:38.960] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:38.960] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:155:0) after 1m0s
[23:11:38.982] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:155:0)
[23:11:38.982] Timer tick, asking Buildbucket for the build status
[23:11:39.012] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:39.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:156:0) after 1m0s
[23:12:39.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:156:0)
[23:12:39.087] Timer tick, asking Buildbucket for the build status
[23:12:39.129] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:39.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:157:0) after 1m0s
[23:13:39.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:157:0)
[23:13:39.155] Timer tick, asking Buildbucket for the build status
[23:13:39.225] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:39.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:158:0) after 1m0s
[23:14:39.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:158:0)
[23:14:39.247] Timer tick, asking Buildbucket for the build status
[23:14:39.282] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:39.282] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:159:0) after 1m0s
[23:15:39.305] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:159:0)
[23:15:39.305] Timer tick, asking Buildbucket for the build status
[23:15:39.435] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:39.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:160:0) after 1m0s
[23:16:39.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:160:0)
[23:16:39.520] Timer tick, asking Buildbucket for the build status
[23:16:39.560] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:39.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:161:0) after 1m0s
[23:17:39.582] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:161:0)
[23:17:39.582] Timer tick, asking Buildbucket for the build status
[23:17:39.623] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:39.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:162:0) after 1m0s
[23:18:39.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:162:0)
[23:18:39.647] Timer tick, asking Buildbucket for the build status
[23:18:39.698] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:39.698] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:163:0) after 1m0s
[23:19:39.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:163:0)
[23:19:39.724] Timer tick, asking Buildbucket for the build status
[23:19:39.809] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:39.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:164:0) after 1m0s
[23:20:39.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:164:0)
[23:20:39.858] Timer tick, asking Buildbucket for the build status
[23:20:39.937] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:39.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:165:0) after 1m0s
[23:21:39.958] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:165:0)
[23:21:39.958] Timer tick, asking Buildbucket for the build status
[23:21:40.096] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:40.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:166:0) after 1m0s
[23:22:40.119] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:166:0)
[23:22:40.119] Timer tick, asking Buildbucket for the build status
[23:22:40.158] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:40.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:167:0) after 1m0s
[23:23:40.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:167:0)
[23:23:40.194] Timer tick, asking Buildbucket for the build status
[23:23:40.252] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:40.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:168:0) after 1m0s
[23:24:40.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:168:0)
[23:24:40.273] Timer tick, asking Buildbucket for the build status
[23:24:40.319] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:40.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:169:0) after 1m0s
[23:25:40.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:169:0)
[23:25:40.344] Timer tick, asking Buildbucket for the build status
[23:25:40.406] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:40.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:170:0) after 1m0s
[23:26:40.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:170:0)
[23:26:40.428] Timer tick, asking Buildbucket for the build status
[23:26:40.736] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:40.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:171:0) after 1m0s
[23:27:40.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:171:0)
[23:27:40.762] Timer tick, asking Buildbucket for the build status
[23:27:40.936] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:40.936] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:172:0) after 1m0s
[23:28:40.960] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:172:0)
[23:28:40.960] Timer tick, asking Buildbucket for the build status
[23:28:40.995] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:40.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:173:0) after 1m0s
[23:29:41.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:173:0)
[23:29:41.016] Timer tick, asking Buildbucket for the build status
[23:29:41.053] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:41.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:174:0) after 1m0s
[23:30:41.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:174:0)
[23:30:41.076] Timer tick, asking Buildbucket for the build status
[23:30:41.128] Build 8923689959950235392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:41.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9089120022124784320:175:0) after 1m0s
[23:31:03.713] Received PubSub notification, asking Buildbucket for the build status
[23:31:03.804] Build 8923689959950235392: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[23:31:03.804] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary": true,
    "canary_preference": "AUTO",
    "completed_ts": "1548113461936778",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1548103099831133",
    "failure_reason": "BUILD_FAILURE",
    "id": "8923689959950235392",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9eca44242f7b0f42a4af33e1dbda178785ca91af\"}}",
    "project": "chromium",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"Failure compare_build_artifacts\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"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\"], \"id\": [\"swarm2173-c4\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4012-9647885\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"ff15c51d20785fa51c0ef03ccb480b87299acbeb\", \"got_swarming_client_revision\": \"0e3e1c4dc4e79f25a5b58fcbc135dc93183c0c54\", \"got_revision\": \"9eca44242f7b0f42a4af33e1dbda178785ca91af\", \"recipe\": \"swarming/deterministic_build\", \"got_dawn_revision\": \"c0f31e73e481f32d308cb6232e75e6d860d97063\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#26298}\", \"$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@{#624646}\", \"branch\": \"refs/heads/master\", \"revision\": \"9eca44242f7b0f42a4af33e1dbda178785ca91af\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"74ba99062c48b278675cfe52643719202296fddc\", \"mastername\": \"chromium.win\", \"got_angle_revision\": \"bf433727853d2330412766bfeb0611c1c0c1e55a\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1548103099831133, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/9eca44242f7b0f42a4af33e1dbda178785ca91af\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9eca44242f7b0f42a4af33e1dbda178785ca91af\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9089120022124784320\", \"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\": \"8923689959950235392\"}}, \"got_v8_revision\": \"5f328d27f54cba497f2a906b490d52ade9c3837a\", \"got_v8_revision_cp\": \"refs/heads/7.3.462@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 11697, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"2f02e1f363b1af2715536f38e239853f04ec1497\"}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1548103203397079",
    "status": "COMPLETED",
    "status_changed_ts": "1548113463277115",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/11697",
      "builder:Windows deterministic",
      "buildset:commit/git/9eca44242f7b0f42a4af33e1dbda178785ca91af",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9eca44242f7b0f42a4af33e1dbda178785ca91af",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9089120022124784320",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_dimension:builder:Windows deterministic",
      "swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
      "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/11697",
      "swarming_tag:buildbucket_bucket:chromium/ci",
      "swarming_tag:buildbucket_build_id:8923689959950235392",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:1",
      "swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
      "swarming_tag:builder:Windows deterministic",
      "swarming_tag:buildset:commit/git/9eca44242f7b0f42a4af33e1dbda178785ca91af",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9eca44242f7b0f42a4af33e1dbda178785ca91af",
      "swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
      "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/8923689959950235392/+/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:9089120022124784320",
      "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:4122e711faf74a549260c6de6a369a8fe79a9d3e",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:428af430c76fc710",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1548113463280526",
    "url": "https://ci.chromium.org/b/8923689959950235392",
    "utcnow_ts": "1548113463765232"
  }
}
[23:31:03.804] Invocation finished in 2h52m45.431423854s with status FAILED