LUCI Scheduler :: chromium :: Windows deterministic

Status: FAILED

Triggered by: -

Duration: 3 hours

Actions:

Definition (rev 4c3247f4ed8a00ea6dc37d6edf987ff8d0e003c5)

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

Incoming triggers

af59cc8ae82bbae4b4856583a9f2fd2572d69b8e (7 years ago)
98dbee3a496427115cca76409e8ed40dd021a7d9 (7 years ago)
0c2746c4060cd6cb3ba2b84cfd7dc280e24f0851 (7 years ago)
eb3ad4144067f94063114f76418e1722d01f5f06 (7 years ago)
900bffbdd3a9e68aaac235fe07ea96ff6cd42c87 (7 years ago)
d2a2eeefcca0c5d6c3456eed9598477423f1eeca (7 years ago)
9582d13a410027becc2e8163ddef88ec97e21c03 (7 years ago)
9ba5ac607758e83bcc43d5e49528ae7ef1711151 (7 years ago)
ece95a5b450386af5a9bf65a36f5433068992f51 (7 years ago)
cf2c3819650145de494d9081b419018ca484d4d1 (7 years ago)
48e042f1b25b509ac7c52de8816c54af12e88e84 (7 years ago)
4c4e17573222c6145bade0e087274ddee7857acb (7 years ago)
fd8f57c75915026f6c14e27993068ad34ab5a2af (7 years ago)
dc06aba46baef19b5aebc89eeb5195b70a7d4f14 (7 years ago)
b76b8d93df590f9bfa502db97e5b8d3ebdf39ae3 (7 years ago)
68d064bc3c24b0eb9a464ab37d573a81129c1c8f (7 years ago)
d1d6586b3beca9bfdf3f2e1b9951e4bbf074604c (7 years ago)
f8cbfab43427ba4a0bf8618e06fe237f771eb49c (7 years ago)
8427edc829adcacc490a1886aa7623c69c3e49f5 (7 years ago)
dd481f562b7dd2b65b72a50d13f40f1704cbb767 (7 years ago)
e931516af4786536722aa351c56af8fedb00d01b (7 years ago)
d5acc726d652800c3bcbadabdf3588f75fb3f7c1 (7 years ago)
53801a30c6430a817f484b8da6cf18f2d3b9f062 (7 years ago)
0a81ee342e26549e348ccd738b1dc64ef3bf835a (7 years ago)
8e470e32ba80f52073bd3a8cfe2c038675034d9b (7 years ago)
12445b718fed85b698a777a2af2d3ce6b5f0d0de (7 years ago)
771dd2a0c9992bb88fe899b1c70dc3f277499ad6 (7 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[16:47:47.415] New invocation is queued and will start shortly
[16:47:48.726] Starting the invocation (attempt 1)
[16:47:48.847] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:47:48.847] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:47:48.847] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9088772137096342144",
  "parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"771dd2a0c9992bb88fe899b1c70dc3f277499ad6\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Windows deterministic",
    "scheduler_invocation_id:9088772137096342144",
    "scheduler_job_id:chromium/Windows deterministic",
    "user_agent:luci-scheduler",
    "buildset:commit/git/771dd2a0c9992bb88fe899b1c70dc3f277499ad6",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/771dd2a0c9992bb88fe899b1c70dc3f277499ad6",
    "gitiles_ref:refs/heads/master"
  ]
}
[16:47:50.178] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1548434868937827",
    "id": "8923342074827495136",
    "lease_expiration_ts": "1548553669755696",
    "lease_key": "913318176",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"771dd2a0c9992bb88fe899b1c70dc3f277499ad6\"}}",
    "project": "chromium",
    "result_details_json": "null",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1548434869921719",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/11728",
      "builder:Windows deterministic",
      "buildset:commit/git/771dd2a0c9992bb88fe899b1c70dc3f277499ad6",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/771dd2a0c9992bb88fe899b1c70dc3f277499ad6",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9088772137096342144",
      "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/11728",
      "swarming_tag:buildbucket_bucket:chromium/ci",
      "swarming_tag:buildbucket_build_id:8923342074827495136",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
      "swarming_tag:builder:Windows deterministic",
      "swarming_tag:buildset:commit/git/771dd2a0c9992bb88fe899b1c70dc3f277499ad6",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/771dd2a0c9992bb88fe899b1c70dc3f277499ad6",
      "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/8923342074827495136/+/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:9088772137096342144",
      "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:94890bdecada961bdaac48b21056d360bdd2b026",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:429eba95155bec10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1548434869921735",
    "url": "https://ci.chromium.org/b/8923342074827495136",
    "utcnow_ts": "1548434870149667"
  }
}
[16:47:50.178] Task URL: https://ci.chromium.org/b/8923342074827495136
[16:47:50.178] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:2:0) after 1m0s
[16:47:53.667] Received PubSub notification, asking Buildbucket for the build status
[16:47:53.716] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:50.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:2:0)
[16:48:50.195] Timer tick, asking Buildbucket for the build status
[16:48:50.239] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:50.239] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:4:0) after 1m0s
[16:49:50.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:4:0)
[16:49:50.264] Timer tick, asking Buildbucket for the build status
[16:49:50.344] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:50.344] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:5:0) after 1m0s
[16:50:50.360] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:5:0)
[16:50:50.360] Timer tick, asking Buildbucket for the build status
[16:50:50.396] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:50.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:6:0) after 1m0s
[16:51:50.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:6:0)
[16:51:50.492] Timer tick, asking Buildbucket for the build status
[16:51:50.552] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:50.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:7:0) after 1m0s
[16:52:50.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:7:0)
[16:52:50.590] Timer tick, asking Buildbucket for the build status
[16:52:50.712] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:50.712] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:8:0) after 1m0s
[16:53:50.733] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:8:0)
[16:53:50.733] Timer tick, asking Buildbucket for the build status
[16:53:50.789] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:50.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:9:0) after 1m0s
[16:54:50.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:9:0)
[16:54:50.834] Timer tick, asking Buildbucket for the build status
[16:54:50.869] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:50.869] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:10:0) after 1m0s
[16:55:50.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:10:0)
[16:55:50.893] Timer tick, asking Buildbucket for the build status
[16:55:50.975] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:50.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:11:0) after 1m0s
[16:56:51.046] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:11:0)
[16:56:51.046] Timer tick, asking Buildbucket for the build status
[16:56:51.151] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:51.151] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:12:0) after 1m0s
[16:57:51.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:12:0)
[16:57:51.170] Timer tick, asking Buildbucket for the build status
[16:57:51.285] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:51.285] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:13:0) after 1m0s
[16:58:51.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:13:0)
[16:58:51.307] Timer tick, asking Buildbucket for the build status
[16:58:51.354] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:51.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:14:0) after 1m0s
[16:59:51.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:14:0)
[16:59:51.506] Timer tick, asking Buildbucket for the build status
[16:59:51.578] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:51.578] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:15:0) after 1m0s
[17:00:51.596] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:15:0)
[17:00:51.596] Timer tick, asking Buildbucket for the build status
[17:00:51.647] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:51.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:16:0) after 1m0s
[17:01:51.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:16:0)
[17:01:51.672] Timer tick, asking Buildbucket for the build status
[17:01:51.907] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:51.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:17:0) after 1m0s
[17:02:51.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:17:0)
[17:02:51.942] Timer tick, asking Buildbucket for the build status
[17:02:52.017] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:52.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:18:0) after 1m0s
[17:03:52.127] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:18:0)
[17:03:52.127] Timer tick, asking Buildbucket for the build status
[17:03:52.196] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:52.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:19:0) after 1m0s
[17:04:52.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:19:0)
[17:04:52.219] Timer tick, asking Buildbucket for the build status
[17:04:52.296] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:52.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:20:0) after 1m0s
[17:05:52.324] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:20:0)
[17:05:52.324] Timer tick, asking Buildbucket for the build status
[17:05:52.375] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:52.375] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:21:0) after 1m0s
[17:06:52.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:21:0)
[17:06:52.408] Timer tick, asking Buildbucket for the build status
[17:06:52.469] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:52.469] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:22:0) after 1m0s
[17:07:52.565] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:22:0)
[17:07:52.565] Timer tick, asking Buildbucket for the build status
[17:07:52.611] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:52.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:23:0) after 1m0s
[17:08:52.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:23:0)
[17:08:52.650] Timer tick, asking Buildbucket for the build status
[17:08:52.711] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:52.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:24:0) after 1m0s
[17:09:52.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:24:0)
[17:09:52.734] Timer tick, asking Buildbucket for the build status
[17:09:52.767] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:52.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:25:0) after 1m0s
[17:10:52.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:25:0)
[17:10:52.789] Timer tick, asking Buildbucket for the build status
[17:10:52.902] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:52.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:26:0) after 1m0s
[17:11:52.958] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:26:0)
[17:11:52.958] Timer tick, asking Buildbucket for the build status
[17:11:53.081] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:53.081] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:27:0) after 1m0s
[17:12:53.114] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:27:0)
[17:12:53.114] Timer tick, asking Buildbucket for the build status
[17:12:53.152] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:53.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:28:0) after 1m0s
[17:13:53.564] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:28:0)
[17:13:53.565] Timer tick, asking Buildbucket for the build status
[17:13:53.634] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:53.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:29:0) after 1m0s
[17:14:53.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:29:0)
[17:14:53.671] Timer tick, asking Buildbucket for the build status
[17:14:53.704] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:53.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:30:0) after 1m0s
[17:15:53.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:30:0)
[17:15:53.821] Timer tick, asking Buildbucket for the build status
[17:15:53.857] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:53.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:31:0) after 1m0s
[17:16:53.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:31:0)
[17:16:53.879] Timer tick, asking Buildbucket for the build status
[17:16:53.923] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:53.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:32:0) after 1m0s
[17:17:53.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:32:0)
[17:17:53.973] Timer tick, asking Buildbucket for the build status
[17:17:54.029] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:54.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:33:0) after 1m0s
[17:18:54.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:33:0)
[17:18:54.071] Timer tick, asking Buildbucket for the build status
[17:18:54.158] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:54.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:34:0) after 1m0s
[17:19:54.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:34:0)
[17:19:54.208] Timer tick, asking Buildbucket for the build status
[17:19:54.264] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:54.264] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:35:0) after 1m0s
[17:20:54.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:35:0)
[17:20:54.283] Timer tick, asking Buildbucket for the build status
[17:20:54.382] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:54.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:36:0) after 1m0s
[17:21:54.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:36:0)
[17:21:54.463] Timer tick, asking Buildbucket for the build status
[17:21:54.579] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:54.579] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:37:0) after 1m0s
[17:22:54.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:37:0)
[17:22:54.609] Timer tick, asking Buildbucket for the build status
[17:22:54.770] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:54.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:38:0) after 1m0s
[17:23:54.819] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:38:0)
[17:23:54.819] Timer tick, asking Buildbucket for the build status
[17:23:54.868] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:54.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:39:0) after 1m0s
[17:24:54.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:39:0)
[17:24:54.902] Timer tick, asking Buildbucket for the build status
[17:24:54.933] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:54.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:40:0) after 1m0s
[17:25:54.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:40:0)
[17:25:54.973] Timer tick, asking Buildbucket for the build status
[17:25:55.053] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:55.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:41:0) after 1m0s
[17:26:55.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:41:0)
[17:26:55.074] Timer tick, asking Buildbucket for the build status
[17:26:55.158] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:55.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:42:0) after 1m0s
[17:27:55.179] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:42:0)
[17:27:55.179] Timer tick, asking Buildbucket for the build status
[17:27:55.269] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:55.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:43:0) after 1m0s
[17:28:55.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:43:0)
[17:28:55.307] Timer tick, asking Buildbucket for the build status
[17:28:55.353] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:55.353] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:44:0) after 1m0s
[17:29:55.373] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:44:0)
[17:29:55.373] Timer tick, asking Buildbucket for the build status
[17:29:55.435] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:55.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:45:0) after 1m0s
[17:30:55.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:45:0)
[17:30:55.476] Timer tick, asking Buildbucket for the build status
[17:30:55.575] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:55.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:46:0) after 1m0s
[17:31:55.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:46:0)
[17:31:55.602] Timer tick, asking Buildbucket for the build status
[17:31:55.656] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:55.656] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:47:0) after 1m0s
[17:32:55.680] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:47:0)
[17:32:55.680] Timer tick, asking Buildbucket for the build status
[17:32:55.777] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:55.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:48:0) after 1m0s
[17:33:55.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:48:0)
[17:33:55.799] Timer tick, asking Buildbucket for the build status
[17:33:55.879] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:55.879] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:49:0) after 1m0s
[17:34:55.923] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:49:0)
[17:34:55.923] Timer tick, asking Buildbucket for the build status
[17:34:55.976] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:55.977] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:50:0) after 1m0s
[17:35:55.997] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:50:0)
[17:35:55.997] Timer tick, asking Buildbucket for the build status
[17:35:56.033] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:56.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:51:0) after 1m0s
[17:36:56.054] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:51:0)
[17:36:56.054] Timer tick, asking Buildbucket for the build status
[17:36:56.117] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:56.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:52:0) after 1m0s
[17:37:56.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:52:0)
[17:37:56.145] Timer tick, asking Buildbucket for the build status
[17:37:56.177] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:56.177] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:53:0) after 1m0s
[17:38:56.265] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:53:0)
[17:38:56.265] Timer tick, asking Buildbucket for the build status
[17:38:56.369] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:56.369] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:54:0) after 1m0s
[17:39:56.466] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:54:0)
[17:39:56.466] Timer tick, asking Buildbucket for the build status
[17:39:56.542] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:56.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:55:0) after 1m0s
[17:40:56.564] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:55:0)
[17:40:56.564] Timer tick, asking Buildbucket for the build status
[17:40:56.627] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:56.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:56:0) after 1m0s
[17:41:56.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:56:0)
[17:41:56.647] Timer tick, asking Buildbucket for the build status
[17:41:56.701] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:56.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:57:0) after 1m0s
[17:42:56.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:57:0)
[17:42:56.724] Timer tick, asking Buildbucket for the build status
[17:42:56.798] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:56.798] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:58:0) after 1m0s
[17:43:56.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:58:0)
[17:43:56.818] Timer tick, asking Buildbucket for the build status
[17:43:56.850] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:56.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:59:0) after 1m0s
[17:44:56.871] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:59:0)
[17:44:56.871] Timer tick, asking Buildbucket for the build status
[17:44:56.924] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:56.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:60:0) after 1m0s
[17:45:57.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:60:0)
[17:45:57.008] Timer tick, asking Buildbucket for the build status
[17:45:57.047] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:57.047] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:61:0) after 1m0s
[17:46:57.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:61:0)
[17:46:57.089] Timer tick, asking Buildbucket for the build status
[17:46:57.174] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:57.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:62:0) after 1m0s
[17:47:57.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:62:0)
[17:47:57.211] Timer tick, asking Buildbucket for the build status
[17:47:57.315] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:57.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:63:0) after 1m0s
[17:48:57.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:63:0)
[17:48:57.378] Timer tick, asking Buildbucket for the build status
[17:48:57.479] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:57.479] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:64:0) after 1m0s
[17:49:57.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:64:0)
[17:49:57.553] Timer tick, asking Buildbucket for the build status
[17:49:57.587] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:57.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:65:0) after 1m0s
[17:50:57.625] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:65:0)
[17:50:57.625] Timer tick, asking Buildbucket for the build status
[17:50:57.658] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:57.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:66:0) after 1m0s
[17:51:57.683] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:66:0)
[17:51:57.683] Timer tick, asking Buildbucket for the build status
[17:51:57.750] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:57.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:67:0) after 1m0s
[17:52:57.786] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:67:0)
[17:52:57.786] Timer tick, asking Buildbucket for the build status
[17:52:57.825] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:57.825] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:68:0) after 1m0s
[17:53:57.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:68:0)
[17:53:57.916] Timer tick, asking Buildbucket for the build status
[17:53:57.975] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:57.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:69:0) after 1m0s
[17:54:58.011] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:69:0)
[17:54:58.011] Timer tick, asking Buildbucket for the build status
[17:54:58.069] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:58.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:70:0) after 1m0s
[17:55:58.090] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:70:0)
[17:55:58.090] Timer tick, asking Buildbucket for the build status
[17:55:58.133] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:58.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:71:0) after 1m0s
[17:56:58.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:71:0)
[17:56:58.159] Timer tick, asking Buildbucket for the build status
[17:56:58.206] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:58.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:72:0) after 1m0s
[17:57:58.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:72:0)
[17:57:58.230] Timer tick, asking Buildbucket for the build status
[17:57:58.263] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:58.263] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:73:0) after 1m0s
[17:58:58.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:73:0)
[17:58:58.288] Timer tick, asking Buildbucket for the build status
[17:58:58.363] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:58.363] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:74:0) after 1m0s
[17:59:58.386] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:74:0)
[17:59:58.386] Timer tick, asking Buildbucket for the build status
[17:59:58.420] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:58.420] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:75:0) after 1m0s
[18:00:58.451] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:75:0)
[18:00:58.451] Timer tick, asking Buildbucket for the build status
[18:00:58.575] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:58.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:76:0) after 1m0s
[18:01:58.612] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:76:0)
[18:01:58.612] Timer tick, asking Buildbucket for the build status
[18:01:58.807] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:58.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:77:0) after 1m0s
[18:02:58.830] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:77:0)
[18:02:58.830] Timer tick, asking Buildbucket for the build status
[18:02:58.907] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:58.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:78:0) after 1m0s
[18:03:58.967] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:78:0)
[18:03:58.967] Timer tick, asking Buildbucket for the build status
[18:03:58.999] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:58.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:79:0) after 1m0s
[18:04:59.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:79:0)
[18:04:59.105] Timer tick, asking Buildbucket for the build status
[18:04:59.153] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:59.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:80:0) after 1m0s
[18:05:59.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:80:0)
[18:05:59.183] Timer tick, asking Buildbucket for the build status
[18:05:59.261] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:59.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:81:0) after 1m0s
[18:06:59.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:81:0)
[18:06:59.290] Timer tick, asking Buildbucket for the build status
[18:06:59.343] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:59.343] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:82:0) after 1m0s
[18:07:59.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:82:0)
[18:07:59.371] Timer tick, asking Buildbucket for the build status
[18:07:59.407] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:59.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:83:0) after 1m0s
[18:08:59.442] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:83:0)
[18:08:59.442] Timer tick, asking Buildbucket for the build status
[18:08:59.482] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:59.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:84:0) after 1m0s
[18:09:59.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:84:0)
[18:09:59.507] Timer tick, asking Buildbucket for the build status
[18:09:59.639] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:59.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:85:0) after 1m0s
[18:10:59.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:85:0)
[18:10:59.663] Timer tick, asking Buildbucket for the build status
[18:10:59.699] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:59.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:86:0) after 1m0s
[18:11:59.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:86:0)
[18:11:59.727] Timer tick, asking Buildbucket for the build status
[18:11:59.772] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:59.772] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:87:0) after 1m0s
[18:12:59.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:87:0)
[18:12:59.795] Timer tick, asking Buildbucket for the build status
[18:12:59.880] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:59.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:88:0) after 1m0s
[18:13:59.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:88:0)
[18:13:59.908] Timer tick, asking Buildbucket for the build status
[18:14:00.158] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:00.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:89:0) after 1m0s
[18:15:00.259] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:89:0)
[18:15:00.259] Timer tick, asking Buildbucket for the build status
[18:15:00.370] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:00.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:90:0) after 1m0s
[18:16:00.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:90:0)
[18:16:00.418] Timer tick, asking Buildbucket for the build status
[18:16:00.458] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:00.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:91:0) after 1m0s
[18:17:00.485] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:91:0)
[18:17:00.485] Timer tick, asking Buildbucket for the build status
[18:17:00.546] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:00.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:92:0) after 1m0s
[18:18:00.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:92:0)
[18:18:00.571] Timer tick, asking Buildbucket for the build status
[18:18:00.637] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:00.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:93:0) after 1m0s
[18:19:00.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:93:0)
[18:19:00.660] Timer tick, asking Buildbucket for the build status
[18:19:00.691] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:00.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:94:0) after 1m0s
[18:20:00.732] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:94:0)
[18:20:00.732] Timer tick, asking Buildbucket for the build status
[18:20:00.775] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:00.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:95:0) after 1m0s
[18:21:00.805] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:95:0)
[18:21:00.805] Timer tick, asking Buildbucket for the build status
[18:21:00.926] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:00.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:96:0) after 1m0s
[18:22:00.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:96:0)
[18:22:00.952] Timer tick, asking Buildbucket for the build status
[18:22:00.984] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:00.984] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:97:0) after 1m0s
[18:23:01.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:97:0)
[18:23:01.056] Timer tick, asking Buildbucket for the build status
[18:23:01.223] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:01.223] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:98:0) after 1m0s
[18:24:01.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:98:0)
[18:24:01.246] Timer tick, asking Buildbucket for the build status
[18:24:01.280] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:01.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:99:0) after 1m0s
[18:25:01.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:99:0)
[18:25:01.315] Timer tick, asking Buildbucket for the build status
[18:25:01.374] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:01.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:100:0) after 1m0s
[18:26:01.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:100:0)
[18:26:01.397] Timer tick, asking Buildbucket for the build status
[18:26:01.447] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:01.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:101:0) after 1m0s
[18:27:01.480] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:101:0)
[18:27:01.480] Timer tick, asking Buildbucket for the build status
[18:27:01.535] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:01.535] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:102:0) after 1m0s
[18:28:01.580] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:102:0)
[18:28:01.580] Timer tick, asking Buildbucket for the build status
[18:28:01.645] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:01.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:103:0) after 1m0s
[18:29:01.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:103:0)
[18:29:01.675] Timer tick, asking Buildbucket for the build status
[18:29:01.796] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:01.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:104:0) after 1m0s
[18:30:01.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:104:0)
[18:30:01.822] Timer tick, asking Buildbucket for the build status
[18:30:01.876] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:01.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:105:0) after 1m0s
[18:31:01.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:105:0)
[18:31:01.899] Timer tick, asking Buildbucket for the build status
[18:31:01.946] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:01.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:106:0) after 1m0s
[18:32:01.996] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:106:0)
[18:32:01.996] Timer tick, asking Buildbucket for the build status
[18:32:02.170] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:02.170] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:107:0) after 1m0s
[18:33:02.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:107:0)
[18:33:02.269] Timer tick, asking Buildbucket for the build status
[18:33:02.345] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:02.345] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:108:0) after 1m0s
[18:34:02.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:108:0)
[18:34:02.399] Timer tick, asking Buildbucket for the build status
[18:34:02.464] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:02.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:109:0) after 1m0s
[18:35:02.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:109:0)
[18:35:02.484] Timer tick, asking Buildbucket for the build status
[18:35:02.584] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:02.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:110:0) after 1m0s
[18:36:02.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:110:0)
[18:36:02.648] Timer tick, asking Buildbucket for the build status
[18:36:02.682] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:02.682] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:111:0) after 1m0s
[18:37:02.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:111:0)
[18:37:02.719] Timer tick, asking Buildbucket for the build status
[18:37:02.779] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:02.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:112:0) after 1m0s
[18:38:02.848] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:112:0)
[18:38:02.848] Timer tick, asking Buildbucket for the build status
[18:38:02.916] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:02.916] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:113:0) after 1m0s
[18:39:02.961] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:113:0)
[18:39:02.961] Timer tick, asking Buildbucket for the build status
[18:39:03.092] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:03.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:114:0) after 1m0s
[18:40:03.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:114:0)
[18:40:03.117] Timer tick, asking Buildbucket for the build status
[18:40:03.168] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:03.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:115:0) after 1m0s
[18:41:03.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:115:0)
[18:41:03.197] Timer tick, asking Buildbucket for the build status
[18:41:03.268] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:03.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:116:0) after 1m0s
[18:42:03.314] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:116:0)
[18:42:03.314] Timer tick, asking Buildbucket for the build status
[18:42:03.390] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:03.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:117:0) after 1m0s
[18:43:03.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:117:0)
[18:43:03.421] Timer tick, asking Buildbucket for the build status
[18:43:03.482] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:03.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:118:0) after 1m0s
[18:44:03.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:118:0)
[18:44:03.541] Timer tick, asking Buildbucket for the build status
[18:44:03.574] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:03.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:119:0) after 1m0s
[18:45:03.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:119:0)
[18:45:03.602] Timer tick, asking Buildbucket for the build status
[18:45:03.665] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:03.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:120:0) after 1m0s
[18:46:03.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:120:0)
[18:46:03.742] Timer tick, asking Buildbucket for the build status
[18:46:03.780] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:03.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:121:0) after 1m0s
[18:47:03.805] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:121:0)
[18:47:03.805] Timer tick, asking Buildbucket for the build status
[18:47:03.863] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:03.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:122:0) after 1m0s
[18:48:03.914] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:122:0)
[18:48:03.914] Timer tick, asking Buildbucket for the build status
[18:48:03.984] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:03.984] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:123:0) after 1m0s
[18:49:04.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:123:0)
[18:49:04.018] Timer tick, asking Buildbucket for the build status
[18:49:04.095] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:04.095] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:124:0) after 1m0s
[18:50:04.119] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:124:0)
[18:50:04.119] Timer tick, asking Buildbucket for the build status
[18:50:04.164] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:04.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:125:0) after 1m0s
[18:51:04.191] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:125:0)
[18:51:04.191] Timer tick, asking Buildbucket for the build status
[18:51:04.249] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:04.249] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:126:0) after 1m0s
[18:52:04.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:126:0)
[18:52:04.286] Timer tick, asking Buildbucket for the build status
[18:52:04.327] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:04.327] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:127:0) after 1m0s
[18:53:04.361] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:127:0)
[18:53:04.361] Timer tick, asking Buildbucket for the build status
[18:53:04.403] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:04.403] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:128:0) after 1m0s
[18:54:04.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:128:0)
[18:54:04.428] Timer tick, asking Buildbucket for the build status
[18:54:04.518] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:04.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:129:0) after 1m0s
[18:55:04.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:129:0)
[18:55:04.567] Timer tick, asking Buildbucket for the build status
[18:55:04.674] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:04.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:130:0) after 1m0s
[18:56:04.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:130:0)
[18:56:04.773] Timer tick, asking Buildbucket for the build status
[18:56:04.810] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:04.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:131:0) after 1m0s
[18:57:04.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:131:0)
[18:57:04.841] Timer tick, asking Buildbucket for the build status
[18:57:04.928] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:04.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:132:0) after 1m0s
[18:58:04.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:132:0)
[18:58:04.956] Timer tick, asking Buildbucket for the build status
[18:58:04.996] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:04.996] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:133:0) after 1m0s
[18:59:05.052] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:133:0)
[18:59:05.052] Timer tick, asking Buildbucket for the build status
[18:59:05.116] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:05.116] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:134:0) after 1m0s
[19:00:05.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:134:0)
[19:00:05.268] Timer tick, asking Buildbucket for the build status
[19:00:05.312] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:05.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:135:0) after 1m0s
[19:01:05.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:135:0)
[19:01:05.422] Timer tick, asking Buildbucket for the build status
[19:01:05.479] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:05.479] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:136:0) after 1m0s
[19:02:05.560] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:136:0)
[19:02:05.560] Timer tick, asking Buildbucket for the build status
[19:02:05.935] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:05.935] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:137:0) after 1m0s
[19:03:05.959] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:137:0)
[19:03:05.959] Timer tick, asking Buildbucket for the build status
[19:03:06.101] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:06.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:138:0) after 1m0s
[19:04:06.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:138:0)
[19:04:06.151] Timer tick, asking Buildbucket for the build status
[19:04:06.190] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:06.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:139:0) after 1m0s
[19:05:06.294] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:139:0)
[19:05:06.294] Timer tick, asking Buildbucket for the build status
[19:05:06.347] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:06.347] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:140:0) after 1m0s
[19:06:06.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:140:0)
[19:06:06.369] Timer tick, asking Buildbucket for the build status
[19:06:06.453] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:06.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:141:0) after 1m0s
[19:07:06.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:141:0)
[19:07:06.492] Timer tick, asking Buildbucket for the build status
[19:07:06.528] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:06.528] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:142:0) after 1m0s
[19:08:06.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:142:0)
[19:08:06.647] Timer tick, asking Buildbucket for the build status
[19:08:06.775] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:06.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:143:0) after 1m0s
[19:09:06.798] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:143:0)
[19:09:06.798] Timer tick, asking Buildbucket for the build status
[19:09:06.832] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:06.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:144:0) after 1m0s
[19:10:06.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:144:0)
[19:10:06.858] Timer tick, asking Buildbucket for the build status
[19:10:06.897] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:06.897] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:145:0) after 1m0s
[19:11:06.967] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:145:0)
[19:11:06.967] Timer tick, asking Buildbucket for the build status
[19:11:07.098] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:07.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:146:0) after 1m0s
[19:12:07.147] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:146:0)
[19:12:07.147] Timer tick, asking Buildbucket for the build status
[19:12:07.244] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:07.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:147:0) after 1m0s
[19:13:07.279] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:147:0)
[19:13:07.279] Timer tick, asking Buildbucket for the build status
[19:13:07.316] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:07.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:148:0) after 1m0s
[19:14:07.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:148:0)
[19:14:07.343] Timer tick, asking Buildbucket for the build status
[19:14:07.397] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:07.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:149:0) after 1m0s
[19:15:07.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:149:0)
[19:15:07.422] Timer tick, asking Buildbucket for the build status
[19:15:07.561] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:07.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:150:0) after 1m0s
[19:16:07.644] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:150:0)
[19:16:07.644] Timer tick, asking Buildbucket for the build status
[19:16:07.768] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:07.768] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:151:0) after 1m0s
[19:17:07.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:151:0)
[19:17:07.799] Timer tick, asking Buildbucket for the build status
[19:17:07.862] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:07.862] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:152:0) after 1m0s
[19:18:07.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:152:0)
[19:18:07.906] Timer tick, asking Buildbucket for the build status
[19:18:07.939] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:07.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:153:0) after 1m0s
[19:19:08.049] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:153:0)
[19:19:08.049] Timer tick, asking Buildbucket for the build status
[19:19:08.192] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:08.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:154:0) after 1m0s
[19:20:08.280] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:154:0)
[19:20:08.280] Timer tick, asking Buildbucket for the build status
[19:20:08.526] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:08.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:155:0) after 1m0s
[19:21:08.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:155:0)
[19:21:08.553] Timer tick, asking Buildbucket for the build status
[19:21:08.699] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:08.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:156:0) after 1m0s
[19:22:08.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:156:0)
[19:22:08.724] Timer tick, asking Buildbucket for the build status
[19:22:08.757] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:08.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:157:0) after 1m0s
[19:23:08.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:157:0)
[19:23:08.784] Timer tick, asking Buildbucket for the build status
[19:23:08.839] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:08.839] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:158:0) after 1m0s
[19:24:08.865] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:158:0)
[19:24:08.865] Timer tick, asking Buildbucket for the build status
[19:24:08.914] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:08.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:159:0) after 1m0s
[19:25:08.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:159:0)
[19:25:08.941] Timer tick, asking Buildbucket for the build status
[19:25:09.025] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:09.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:160:0) after 1m0s
[19:26:09.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:160:0)
[19:26:09.139] Timer tick, asking Buildbucket for the build status
[19:26:09.176] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:09.176] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:161:0) after 1m0s
[19:27:09.228] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:161:0)
[19:27:09.228] Timer tick, asking Buildbucket for the build status
[19:27:09.297] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:09.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:162:0) after 1m0s
[19:28:09.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:162:0)
[19:28:09.354] Timer tick, asking Buildbucket for the build status
[19:28:09.437] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:09.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:163:0) after 1m0s
[19:29:09.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:163:0)
[19:29:09.488] Timer tick, asking Buildbucket for the build status
[19:29:09.540] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:09.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:164:0) after 1m0s
[19:30:09.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:164:0)
[19:30:09.566] Timer tick, asking Buildbucket for the build status
[19:30:09.615] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:09.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:165:0) after 1m0s
[19:31:09.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:165:0)
[19:31:09.656] Timer tick, asking Buildbucket for the build status
[19:31:09.704] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:09.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:166:0) after 1m0s
[19:32:09.760] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:166:0)
[19:32:09.760] Timer tick, asking Buildbucket for the build status
[19:32:09.789] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:09.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:167:0) after 1m0s
[19:33:09.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:167:0)
[19:33:09.835] Timer tick, asking Buildbucket for the build status
[19:33:09.898] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:09.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:168:0) after 1m0s
[19:34:09.930] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:168:0)
[19:34:09.930] Timer tick, asking Buildbucket for the build status
[19:34:15.910] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:15.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:169:0) after 1m0s
[19:35:15.936] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:169:0)
[19:35:15.937] Timer tick, asking Buildbucket for the build status
[19:35:16.860] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:16.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:170:0) after 1m0s
[19:36:16.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:170:0)
[19:36:16.893] Timer tick, asking Buildbucket for the build status
[19:36:16.928] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:16.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:171:0) after 1m0s
[19:37:16.955] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:171:0)
[19:37:16.955] Timer tick, asking Buildbucket for the build status
[19:37:17.002] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:17.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:172:0) after 1m0s
[19:38:17.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:172:0)
[19:38:17.086] Timer tick, asking Buildbucket for the build status
[19:38:17.158] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:17.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:173:0) after 1m0s
[19:39:17.187] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:173:0)
[19:39:17.187] Timer tick, asking Buildbucket for the build status
[19:39:17.222] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:17.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:174:0) after 1m0s
[19:40:17.267] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:174:0)
[19:40:17.267] Timer tick, asking Buildbucket for the build status
[19:40:17.304] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:17.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:175:0) after 1m0s
[19:41:17.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:175:0)
[19:41:17.391] Timer tick, asking Buildbucket for the build status
[19:41:17.444] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:17.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:176:0) after 1m0s
[19:42:17.480] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:176:0)
[19:42:17.480] Timer tick, asking Buildbucket for the build status
[19:42:17.529] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:17.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:177:0) after 1m0s
[19:43:17.555] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:177:0)
[19:43:17.555] Timer tick, asking Buildbucket for the build status
[19:43:17.594] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:17.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:178:0) after 1m0s
[19:44:17.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:178:0)
[19:44:17.635] Timer tick, asking Buildbucket for the build status
[19:44:17.954] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:17.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:179:0) after 1m0s
[19:45:17.982] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:179:0)
[19:45:17.982] Timer tick, asking Buildbucket for the build status
[19:45:18.024] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:18.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:180:0) after 1m0s
[19:46:18.057] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:180:0)
[19:46:18.057] Timer tick, asking Buildbucket for the build status
[19:46:18.100] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:18.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:181:0) after 1m0s
[19:47:18.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:181:0)
[19:47:18.201] Timer tick, asking Buildbucket for the build status
[19:47:18.283] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:18.283] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:182:0) after 1m0s
[19:48:18.355] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:182:0)
[19:48:18.355] Timer tick, asking Buildbucket for the build status
[19:48:18.386] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:18.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:183:0) after 1m0s
[19:49:18.528] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:183:0)
[19:49:18.528] Timer tick, asking Buildbucket for the build status
[19:49:18.630] Build 8923342074827495136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:18.630] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9088772137096342144:184:0) after 1m0s
[19:49:54.774] Received PubSub notification, asking Buildbucket for the build status
[19:49:54.805] Build 8923342074827495136: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[19:49:54.805] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "AUTO",
    "completed_ts": "1548445793760287",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1548434868937827",
    "failure_reason": "INFRA_FAILURE",
    "id": "8923342074827495136",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"771dd2a0c9992bb88fe899b1c70dc3f277499ad6\"}}",
    "project": "chromium",
    "result": "FAILURE",
    "result_details_json": "{\"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\": [\"4030-894db91\"], \"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\"]}}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1548434872813165",
    "status": "COMPLETED",
    "status_changed_ts": "1548445794295093",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/11728",
      "builder:Windows deterministic",
      "buildset:commit/git/771dd2a0c9992bb88fe899b1c70dc3f277499ad6",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/771dd2a0c9992bb88fe899b1c70dc3f277499ad6",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9088772137096342144",
      "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/11728",
      "swarming_tag:buildbucket_bucket:chromium/ci",
      "swarming_tag:buildbucket_build_id:8923342074827495136",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
      "swarming_tag:builder:Windows deterministic",
      "swarming_tag:buildset:commit/git/771dd2a0c9992bb88fe899b1c70dc3f277499ad6",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/771dd2a0c9992bb88fe899b1c70dc3f277499ad6",
      "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/8923342074827495136/+/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:9088772137096342144",
      "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:94890bdecada961bdaac48b21056d360bdd2b026",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:429eba95155bec10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1548445794296675",
    "url": "https://ci.chromium.org/b/8923342074827495136",
    "utcnow_ts": "1548445794795959"
  }
}
[19:49:54.805] Invocation finished in 3h2m7.414645651s with status FAILED