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

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[08:25:16.136] New invocation is queued and will start shortly
[08:25:17.503] Starting the invocation (attempt 1)
[08:25:17.556] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:25:17.556] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:25:17.556] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9106379564475615664",
  "parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Windows deterministic",
    "scheduler_invocation_id:9106379564475615664",
    "scheduler_job_id:chromium/Windows deterministic",
    "user_agent:luci-scheduler",
    "buildset:commit/git/7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb",
    "gitiles_ref:refs/heads/master"
  ]
}
[08:25:19.229] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary": true,
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1531643117640630",
    "id": "8940949502236064896",
    "lease_expiration_ts": "1531704318932320",
    "lease_key": "1567616032",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb\"}}",
    "project": "chromium",
    "result_details_json": "null",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1531643119136980",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/9510",
      "builder:Windows deterministic",
      "buildset:commit/git/7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9106379564475615664",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_dimension:builder:Windows deterministic",
      "swarming_dimension:cores:8",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Windows-10",
      "swarming_dimension:pool:luci.chromium.ci",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.chromium.ci/Windows deterministic/9510",
      "swarming_tag:buildbucket_bucket:luci.chromium.ci",
      "swarming_tag:buildbucket_build_id:8940949502236064896",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:1",
      "swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
      "swarming_tag:builder:Windows deterministic",
      "swarming_tag:buildset:commit/git/7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb",
      "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/8940949502236064896/+/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:9106379564475615664",
      "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:cb76dd9a681a4367362c098d4bb68c8c82db75c2",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:3eb5dcca6c9d0210",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1531643119137060",
    "url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9510",
    "utcnow_ts": "1531643119212760"
  }
}
[08:25:19.229] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9510
[08:25:19.229] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:2:0) after 1m0s
[08:26:19.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:2:0)
[08:26:19.246] Timer tick, asking Buildbucket for the build status
[08:26:19.293] Build 8940949502236064896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:26:19.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:3:0) after 1m0s
[08:27:06.026] Received PubSub notification, asking Buildbucket for the build status
[08:27:06.078] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:19.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:3:0)
[08:27:19.311] Timer tick, asking Buildbucket for the build status
[08:27:19.351] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:19.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:5:0) after 1m0s
[08:28:19.427] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:5:0)
[08:28:19.427] Timer tick, asking Buildbucket for the build status
[08:28:19.498] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:19.498] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:6:0) after 1m0s
[08:29:19.515] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:6:0)
[08:29:19.515] Timer tick, asking Buildbucket for the build status
[08:29:19.608] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:19.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:7:0) after 1m0s
[08:30:19.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:7:0)
[08:30:19.626] Timer tick, asking Buildbucket for the build status
[08:30:19.671] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:19.671] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:8:0) after 1m0s
[08:31:19.690] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:8:0)
[08:31:19.690] Timer tick, asking Buildbucket for the build status
[08:31:19.864] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:19.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:9:0) after 1m0s
[08:32:19.886] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:9:0)
[08:32:19.886] Timer tick, asking Buildbucket for the build status
[08:32:20.009] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:20.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:10:0) after 1m0s
[08:33:20.029] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:10:0)
[08:33:20.029] Timer tick, asking Buildbucket for the build status
[08:33:20.091] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:20.091] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:11:0) after 1m0s
[08:34:20.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:11:0)
[08:34:20.108] Timer tick, asking Buildbucket for the build status
[08:34:20.198] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:20.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:12:0) after 1m0s
[08:35:20.256] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:12:0)
[08:35:20.256] Timer tick, asking Buildbucket for the build status
[08:35:20.328] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:20.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:13:0) after 1m0s
[08:36:20.360] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:13:0)
[08:36:20.360] Timer tick, asking Buildbucket for the build status
[08:36:20.799] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:20.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:14:0) after 1m0s
[08:37:20.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:14:0)
[08:37:20.817] Timer tick, asking Buildbucket for the build status
[08:37:20.888] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:20.888] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:15:0) after 1m0s
[08:38:20.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:15:0)
[08:38:20.911] Timer tick, asking Buildbucket for the build status
[08:38:20.962] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:20.962] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:16:0) after 1m0s
[08:39:20.982] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:16:0)
[08:39:20.982] Timer tick, asking Buildbucket for the build status
[08:39:21.105] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:21.105] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:17:0) after 1m0s
[08:40:21.126] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:17:0)
[08:40:21.126] Timer tick, asking Buildbucket for the build status
[08:40:21.221] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:21.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:18:0) after 1m0s
[08:41:21.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:18:0)
[08:41:21.242] Timer tick, asking Buildbucket for the build status
[08:41:21.464] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:21.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:19:0) after 1m0s
[08:42:21.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:19:0)
[08:42:21.483] Timer tick, asking Buildbucket for the build status
[08:42:21.585] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:21.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:20:0) after 1m0s
[08:43:21.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:20:0)
[08:43:21.650] Timer tick, asking Buildbucket for the build status
[08:43:21.734] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:21.734] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:21:0) after 1m0s
[08:44:21.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:21:0)
[08:44:21.753] Timer tick, asking Buildbucket for the build status
[08:44:21.812] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:21.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:22:0) after 1m0s
[08:45:21.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:22:0)
[08:45:21.850] Timer tick, asking Buildbucket for the build status
[08:45:21.906] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:21.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:23:0) after 1m0s
[08:46:22.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:23:0)
[08:46:22.027] Timer tick, asking Buildbucket for the build status
[08:46:22.529] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:22.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:24:0) after 1m0s
[08:47:22.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:24:0)
[08:47:22.547] Timer tick, asking Buildbucket for the build status
[08:47:22.680] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:22.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:25:0) after 1m0s
[08:48:22.721] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:25:0)
[08:48:22.721] Timer tick, asking Buildbucket for the build status
[08:48:22.779] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:22.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:26:0) after 1m0s
[08:49:22.798] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:26:0)
[08:49:22.798] Timer tick, asking Buildbucket for the build status
[08:49:22.870] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:22.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:27:0) after 1m0s
[08:50:22.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:27:0)
[08:50:22.978] Timer tick, asking Buildbucket for the build status
[08:50:23.062] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:23.062] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:28:0) after 1m0s
[08:51:23.119] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:28:0)
[08:51:23.119] Timer tick, asking Buildbucket for the build status
[08:51:23.222] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:23.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:29:0) after 1m0s
[08:52:23.255] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:29:0)
[08:52:23.255] Timer tick, asking Buildbucket for the build status
[08:52:23.296] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:23.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:30:0) after 1m0s
[08:53:23.317] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:30:0)
[08:53:23.317] Timer tick, asking Buildbucket for the build status
[08:53:23.425] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:23.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:31:0) after 1m0s
[08:54:23.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:31:0)
[08:54:23.449] Timer tick, asking Buildbucket for the build status
[08:54:23.566] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:23.566] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:32:0) after 1m0s
[08:55:23.591] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:32:0)
[08:55:23.591] Timer tick, asking Buildbucket for the build status
[08:55:23.633] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:23.633] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:33:0) after 1m0s
[08:56:23.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:33:0)
[08:56:23.654] Timer tick, asking Buildbucket for the build status
[08:56:23.858] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:23.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:34:0) after 1m0s
[08:57:23.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:34:0)
[08:57:23.880] Timer tick, asking Buildbucket for the build status
[08:57:24.059] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:24.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:35:0) after 1m0s
[08:58:24.252] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:35:0)
[08:58:24.252] Timer tick, asking Buildbucket for the build status
[08:58:24.355] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:24.355] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:36:0) after 1m0s
[08:59:24.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:36:0)
[08:59:24.377] Timer tick, asking Buildbucket for the build status
[08:59:24.433] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:24.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:37:0) after 1m0s
[09:00:24.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:37:0)
[09:00:24.454] Timer tick, asking Buildbucket for the build status
[09:00:24.521] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:24.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:38:0) after 1m0s
[09:01:24.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:38:0)
[09:01:24.540] Timer tick, asking Buildbucket for the build status
[09:01:24.601] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:24.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:39:0) after 1m0s
[09:02:24.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:39:0)
[09:02:24.731] Timer tick, asking Buildbucket for the build status
[09:02:24.910] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:24.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:40:0) after 1m0s
[09:03:24.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:40:0)
[09:03:24.943] Timer tick, asking Buildbucket for the build status
[09:03:25.161] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:25.161] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:41:0) after 1m0s
[09:04:25.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:41:0)
[09:04:25.310] Timer tick, asking Buildbucket for the build status
[09:04:25.366] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:25.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:42:0) after 1m0s
[09:05:25.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:42:0)
[09:05:25.391] Timer tick, asking Buildbucket for the build status
[09:05:25.462] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:25.462] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:43:0) after 1m0s
[09:06:25.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:43:0)
[09:06:25.483] Timer tick, asking Buildbucket for the build status
[09:06:25.552] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:25.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:44:0) after 1m0s
[09:07:25.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:44:0)
[09:07:25.595] Timer tick, asking Buildbucket for the build status
[09:07:25.736] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:25.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:45:0) after 1m0s
[09:08:25.757] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:45:0)
[09:08:25.757] Timer tick, asking Buildbucket for the build status
[09:08:25.827] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:25.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:46:0) after 1m0s
[09:09:25.844] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:46:0)
[09:09:25.844] Timer tick, asking Buildbucket for the build status
[09:09:26.192] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:26.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:47:0) after 1m0s
[09:10:26.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:47:0)
[09:10:26.273] Timer tick, asking Buildbucket for the build status
[09:10:26.374] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:26.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:48:0) after 1m0s
[09:11:26.394] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:48:0)
[09:11:26.394] Timer tick, asking Buildbucket for the build status
[09:11:26.458] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:26.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:49:0) after 1m0s
[09:12:26.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:49:0)
[09:12:26.488] Timer tick, asking Buildbucket for the build status
[09:12:26.576] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:26.576] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:50:0) after 1m0s
[09:13:26.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:50:0)
[09:13:26.597] Timer tick, asking Buildbucket for the build status
[09:13:26.656] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:26.656] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:51:0) after 1m0s
[09:14:26.680] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:51:0)
[09:14:26.680] Timer tick, asking Buildbucket for the build status
[09:14:26.771] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:26.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:52:0) after 1m0s
[09:15:26.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:52:0)
[09:15:26.825] Timer tick, asking Buildbucket for the build status
[09:15:26.914] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:26.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:53:0) after 1m0s
[09:16:27.041] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:53:0)
[09:16:27.041] Timer tick, asking Buildbucket for the build status
[09:16:31.507] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:31.507] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:54:0) after 1m0s
[09:17:31.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:54:0)
[09:17:31.542] Timer tick, asking Buildbucket for the build status
[09:17:31.729] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:31.729] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:55:0) after 1m0s
[09:18:31.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:55:0)
[09:18:31.766] Timer tick, asking Buildbucket for the build status
[09:18:31.841] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:31.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:56:0) after 1m0s
[09:19:31.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:56:0)
[09:19:31.859] Timer tick, asking Buildbucket for the build status
[09:19:31.911] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:31.911] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:57:0) after 1m0s
[09:20:31.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:57:0)
[09:20:31.931] Timer tick, asking Buildbucket for the build status
[09:20:31.967] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:31.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:58:0) after 1m0s
[09:21:31.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:58:0)
[09:21:31.999] Timer tick, asking Buildbucket for the build status
[09:21:32.467] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:32.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:59:0) after 1m0s
[09:22:32.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:59:0)
[09:22:32.510] Timer tick, asking Buildbucket for the build status
[09:22:32.600] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:32.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:60:0) after 1m0s
[09:23:32.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:60:0)
[09:23:32.622] Timer tick, asking Buildbucket for the build status
[09:23:32.705] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:32.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:61:0) after 1m0s
[09:24:32.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:61:0)
[09:24:32.781] Timer tick, asking Buildbucket for the build status
[09:24:32.876] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:32.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:62:0) after 1m0s
[09:25:32.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:62:0)
[09:25:32.902] Timer tick, asking Buildbucket for the build status
[09:25:32.948] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:32.948] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:63:0) after 1m0s
[09:26:32.977] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:63:0)
[09:26:32.977] Timer tick, asking Buildbucket for the build status
[09:26:33.052] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:33.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:64:0) after 1m0s
[09:27:33.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:64:0)
[09:27:33.120] Timer tick, asking Buildbucket for the build status
[09:27:33.278] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:33.278] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:65:0) after 1m0s
[09:28:33.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:65:0)
[09:28:33.301] Timer tick, asking Buildbucket for the build status
[09:28:33.398] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:33.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:66:0) after 1m0s
[09:29:33.438] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:66:0)
[09:29:33.438] Timer tick, asking Buildbucket for the build status
[09:29:33.498] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:33.498] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:67:0) after 1m0s
[09:30:33.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:67:0)
[09:30:33.520] Timer tick, asking Buildbucket for the build status
[09:30:33.568] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:33.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:68:0) after 1m0s
[09:31:33.588] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:68:0)
[09:31:33.588] Timer tick, asking Buildbucket for the build status
[09:31:33.694] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:33.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:69:0) after 1m0s
[09:32:33.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:69:0)
[09:32:33.715] Timer tick, asking Buildbucket for the build status
[09:32:33.832] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:33.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:70:0) after 1m0s
[09:33:33.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:70:0)
[09:33:33.863] Timer tick, asking Buildbucket for the build status
[09:33:33.896] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:33.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:71:0) after 1m0s
[09:34:33.919] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:71:0)
[09:34:33.919] Timer tick, asking Buildbucket for the build status
[09:34:34.086] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:34.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:72:0) after 1m0s
[09:35:34.110] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:72:0)
[09:35:34.110] Timer tick, asking Buildbucket for the build status
[09:35:34.165] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:34.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:73:0) after 1m0s
[09:36:34.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:73:0)
[09:36:34.283] Timer tick, asking Buildbucket for the build status
[09:36:34.377] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:34.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:74:0) after 1m0s
[09:37:34.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:74:0)
[09:37:34.408] Timer tick, asking Buildbucket for the build status
[09:37:34.473] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:34.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:75:0) after 1m0s
[09:38:34.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:75:0)
[09:38:34.498] Timer tick, asking Buildbucket for the build status
[09:38:34.583] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:34.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:76:0) after 1m0s
[09:39:34.606] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:76:0)
[09:39:34.606] Timer tick, asking Buildbucket for the build status
[09:39:34.685] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:34.685] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:77:0) after 1m0s
[09:40:34.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:77:0)
[09:40:34.715] Timer tick, asking Buildbucket for the build status
[09:40:34.780] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:34.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:78:0) after 1m0s
[09:41:34.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:78:0)
[09:41:34.883] Timer tick, asking Buildbucket for the build status
[09:41:34.968] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:34.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:79:0) after 1m0s
[09:42:34.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:79:0)
[09:42:34.988] Timer tick, asking Buildbucket for the build status
[09:42:35.115] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:35.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:80:0) after 1m0s
[09:43:35.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:80:0)
[09:43:35.142] Timer tick, asking Buildbucket for the build status
[09:43:35.264] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:35.264] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:81:0) after 1m0s
[09:44:35.298] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:81:0)
[09:44:35.298] Timer tick, asking Buildbucket for the build status
[09:44:35.384] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:35.384] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:82:0) after 1m0s
[09:45:35.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:82:0)
[09:45:35.553] Timer tick, asking Buildbucket for the build status
[09:45:35.848] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:35.848] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:83:0) after 1m0s
[09:46:35.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:83:0)
[09:46:35.873] Timer tick, asking Buildbucket for the build status
[09:46:36.144] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:36.144] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:84:0) after 1m0s
[09:47:36.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:84:0)
[09:47:36.189] Timer tick, asking Buildbucket for the build status
[09:47:36.261] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:36.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:85:0) after 1m0s
[09:48:36.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:85:0)
[09:48:36.339] Timer tick, asking Buildbucket for the build status
[09:48:36.424] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:36.424] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:86:0) after 1m0s
[09:49:36.445] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:86:0)
[09:49:36.445] Timer tick, asking Buildbucket for the build status
[09:49:36.490] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:36.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:87:0) after 1m0s
[09:50:36.580] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:87:0)
[09:50:36.580] Timer tick, asking Buildbucket for the build status
[09:50:36.795] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:36.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:88:0) after 1m0s
[09:51:36.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:88:0)
[09:51:36.812] Timer tick, asking Buildbucket for the build status
[09:51:36.870] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:36.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:89:0) after 1m0s
[09:52:36.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:89:0)
[09:52:36.895] Timer tick, asking Buildbucket for the build status
[09:52:36.945] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:36.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:90:0) after 1m0s
[09:53:37.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:90:0)
[09:53:37.031] Timer tick, asking Buildbucket for the build status
[09:53:37.158] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:37.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:91:0) after 1m0s
[09:54:37.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:91:0)
[09:54:37.246] Timer tick, asking Buildbucket for the build status
[09:54:37.334] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:37.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:92:0) after 1m0s
[09:55:37.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:92:0)
[09:55:37.418] Timer tick, asking Buildbucket for the build status
[09:55:37.499] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:37.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:93:0) after 1m0s
[09:56:37.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:93:0)
[09:56:37.519] Timer tick, asking Buildbucket for the build status
[09:56:37.574] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:37.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:94:0) after 1m0s
[09:57:37.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:94:0)
[09:57:37.597] Timer tick, asking Buildbucket for the build status
[09:57:37.638] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:37.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:95:0) after 1m0s
[09:58:37.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:95:0)
[09:58:37.668] Timer tick, asking Buildbucket for the build status
[09:58:37.815] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:37.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:96:0) after 1m0s
[09:59:37.842] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:96:0)
[09:59:37.842] Timer tick, asking Buildbucket for the build status
[09:59:37.902] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:37.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:97:0) after 1m0s
[10:00:37.935] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:97:0)
[10:00:37.935] Timer tick, asking Buildbucket for the build status
[10:00:38.040] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:38.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:98:0) after 1m0s
[10:01:38.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:98:0)
[10:01:38.063] Timer tick, asking Buildbucket for the build status
[10:01:38.123] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:38.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:99:0) after 1m0s
[10:02:38.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:99:0)
[10:02:38.197] Timer tick, asking Buildbucket for the build status
[10:02:38.288] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:38.288] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:100:0) after 1m0s
[10:03:38.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:100:0)
[10:03:38.378] Timer tick, asking Buildbucket for the build status
[10:03:38.467] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:38.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:101:0) after 1m0s
[10:04:38.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:101:0)
[10:04:38.496] Timer tick, asking Buildbucket for the build status
[10:04:38.580] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:38.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:102:0) after 1m0s
[10:05:38.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:102:0)
[10:05:38.607] Timer tick, asking Buildbucket for the build status
[10:05:38.668] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:38.668] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:103:0) after 1m0s
[10:06:38.690] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:103:0)
[10:06:38.690] Timer tick, asking Buildbucket for the build status
[10:06:38.755] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:38.755] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:104:0) after 1m0s
[10:07:38.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:104:0)
[10:07:38.892] Timer tick, asking Buildbucket for the build status
[10:07:38.969] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:38.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:105:0) after 1m0s
[10:08:39.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:105:0)
[10:08:39.008] Timer tick, asking Buildbucket for the build status
[10:08:39.072] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:39.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:106:0) after 1m0s
[10:09:39.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:106:0)
[10:09:39.268] Timer tick, asking Buildbucket for the build status
[10:09:39.364] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:39.364] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:107:0) after 1m0s
[10:10:39.493] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:107:0)
[10:10:39.493] Timer tick, asking Buildbucket for the build status
[10:10:39.533] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:39.534] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:108:0) after 1m0s
[10:11:39.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:108:0)
[10:11:39.558] Timer tick, asking Buildbucket for the build status
[10:11:39.662] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:39.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:109:0) after 1m0s
[10:12:39.683] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:109:0)
[10:12:39.683] Timer tick, asking Buildbucket for the build status
[10:12:39.845] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:39.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:110:0) after 1m0s
[10:13:39.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:110:0)
[10:13:39.868] Timer tick, asking Buildbucket for the build status
[10:13:39.997] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:39.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:111:0) after 1m0s
[10:14:40.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:111:0)
[10:14:40.044] Timer tick, asking Buildbucket for the build status
[10:14:40.118] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:40.118] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:112:0) after 1m0s
[10:15:40.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:112:0)
[10:15:40.183] Timer tick, asking Buildbucket for the build status
[10:15:40.258] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:40.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:113:0) after 1m0s
[10:16:40.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:113:0)
[10:16:40.283] Timer tick, asking Buildbucket for the build status
[10:16:40.454] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:40.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:114:0) after 1m0s
[10:17:40.486] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:114:0)
[10:17:40.486] Timer tick, asking Buildbucket for the build status
[10:17:40.610] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:40.610] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:115:0) after 1m0s
[10:18:40.690] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:115:0)
[10:18:40.690] Timer tick, asking Buildbucket for the build status
[10:18:40.764] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:40.764] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:116:0) after 1m0s
[10:19:40.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:116:0)
[10:19:40.788] Timer tick, asking Buildbucket for the build status
[10:19:40.852] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:40.852] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:117:0) after 1m0s
[10:20:40.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:117:0)
[10:20:40.876] Timer tick, asking Buildbucket for the build status
[10:20:40.946] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:40.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:118:0) after 1m0s
[10:21:40.966] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:118:0)
[10:21:40.966] Timer tick, asking Buildbucket for the build status
[10:21:41.064] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:41.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:119:0) after 1m0s
[10:22:41.168] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:119:0)
[10:22:41.168] Timer tick, asking Buildbucket for the build status
[10:22:41.221] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:41.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:120:0) after 1m0s
[10:23:41.244] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:120:0)
[10:23:41.244] Timer tick, asking Buildbucket for the build status
[10:23:41.315] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:41.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:121:0) after 1m0s
[10:24:41.347] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:121:0)
[10:24:41.347] Timer tick, asking Buildbucket for the build status
[10:24:41.409] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:41.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:122:0) after 1m0s
[10:25:41.485] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:122:0)
[10:25:41.485] Timer tick, asking Buildbucket for the build status
[10:25:41.521] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:41.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:123:0) after 1m0s
[10:26:41.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:123:0)
[10:26:41.628] Timer tick, asking Buildbucket for the build status
[10:26:41.860] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:41.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:124:0) after 1m0s
[10:27:41.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:124:0)
[10:27:41.978] Timer tick, asking Buildbucket for the build status
[10:27:42.035] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:42.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:125:0) after 1m0s
[10:28:42.100] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:125:0)
[10:28:42.100] Timer tick, asking Buildbucket for the build status
[10:28:42.184] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:42.184] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:126:0) after 1m0s
[10:29:42.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:126:0)
[10:29:42.296] Timer tick, asking Buildbucket for the build status
[10:29:42.332] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:42.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:127:0) after 1m0s
[10:30:42.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:127:0)
[10:30:42.405] Timer tick, asking Buildbucket for the build status
[10:30:42.557] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:42.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:128:0) after 1m0s
[10:31:42.627] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:128:0)
[10:31:42.627] Timer tick, asking Buildbucket for the build status
[10:31:42.672] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:42.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:129:0) after 1m0s
[10:32:42.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:129:0)
[10:32:42.724] Timer tick, asking Buildbucket for the build status
[10:32:42.806] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:42.806] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:130:0) after 1m0s
[10:33:42.975] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:130:0)
[10:33:42.975] Timer tick, asking Buildbucket for the build status
[10:33:43.162] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:43.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:131:0) after 1m0s
[10:34:43.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:131:0)
[10:34:43.201] Timer tick, asking Buildbucket for the build status
[10:34:43.308] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:43.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:132:0) after 1m0s
[10:35:43.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:132:0)
[10:35:43.328] Timer tick, asking Buildbucket for the build status
[10:35:43.531] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:43.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:133:0) after 1m0s
[10:36:43.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:133:0)
[10:36:43.664] Timer tick, asking Buildbucket for the build status
[10:36:43.702] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:43.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:134:0) after 1m0s
[10:37:43.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:134:0)
[10:37:43.835] Timer tick, asking Buildbucket for the build status
[10:37:44.017] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:44.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:135:0) after 1m0s
[10:38:44.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:135:0)
[10:38:44.044] Timer tick, asking Buildbucket for the build status
[10:38:44.111] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:44.111] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:136:0) after 1m0s
[10:39:44.130] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:136:0)
[10:39:44.130] Timer tick, asking Buildbucket for the build status
[10:39:44.377] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:44.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:137:0) after 1m0s
[10:40:44.398] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:137:0)
[10:40:44.398] Timer tick, asking Buildbucket for the build status
[10:40:44.499] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:44.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:138:0) after 1m0s
[10:41:44.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:138:0)
[10:41:44.523] Timer tick, asking Buildbucket for the build status
[10:41:44.572] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:44.573] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:139:0) after 1m0s
[10:42:44.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:139:0)
[10:42:44.607] Timer tick, asking Buildbucket for the build status
[10:42:44.660] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:44.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:140:0) after 1m0s
[10:43:44.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:140:0)
[10:43:44.697] Timer tick, asking Buildbucket for the build status
[10:43:44.786] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:44.786] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:141:0) after 1m0s
[10:44:44.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:141:0)
[10:44:44.811] Timer tick, asking Buildbucket for the build status
[10:44:44.844] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:44.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:142:0) after 1m0s
[10:45:44.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:142:0)
[10:45:44.867] Timer tick, asking Buildbucket for the build status
[10:45:44.905] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:44.905] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:143:0) after 1m0s
[10:46:44.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:143:0)
[10:46:44.986] Timer tick, asking Buildbucket for the build status
[10:46:45.044] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:45.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:144:0) after 1m0s
[10:47:45.069] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:144:0)
[10:47:45.069] Timer tick, asking Buildbucket for the build status
[10:47:45.156] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:45.156] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:145:0) after 1m0s
[10:48:45.178] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:145:0)
[10:48:45.178] Timer tick, asking Buildbucket for the build status
[10:48:45.276] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:45.276] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:146:0) after 1m0s
[10:49:45.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:146:0)
[10:49:45.303] Timer tick, asking Buildbucket for the build status
[10:49:45.358] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:45.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:147:0) after 1m0s
[10:50:45.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:147:0)
[10:50:45.382] Timer tick, asking Buildbucket for the build status
[10:50:45.431] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:45.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:148:0) after 1m0s
[10:51:45.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:148:0)
[10:51:45.454] Timer tick, asking Buildbucket for the build status
[10:51:45.508] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:45.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:149:0) after 1m0s
[10:52:45.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:149:0)
[10:52:45.537] Timer tick, asking Buildbucket for the build status
[10:52:45.648] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:45.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:150:0) after 1m0s
[10:53:45.679] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:150:0)
[10:53:45.679] Timer tick, asking Buildbucket for the build status
[10:53:45.980] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:45.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:151:0) after 1m0s
[10:54:46.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:151:0)
[10:54:46.004] Timer tick, asking Buildbucket for the build status
[10:54:46.106] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:46.106] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:152:0) after 1m0s
[10:55:46.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:152:0)
[10:55:46.186] Timer tick, asking Buildbucket for the build status
[10:55:46.364] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:46.364] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:153:0) after 1m0s
[10:56:46.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:153:0)
[10:56:46.428] Timer tick, asking Buildbucket for the build status
[10:56:46.481] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:46.481] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:154:0) after 1m0s
[10:57:46.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:154:0)
[10:57:46.505] Timer tick, asking Buildbucket for the build status
[10:57:46.539] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:46.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:155:0) after 1m0s
[10:58:46.579] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:155:0)
[10:58:46.579] Timer tick, asking Buildbucket for the build status
[10:58:46.663] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:46.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:156:0) after 1m0s
[10:59:46.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:156:0)
[10:59:46.766] Timer tick, asking Buildbucket for the build status
[10:59:46.856] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:46.856] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:157:0) after 1m0s
[11:00:46.982] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:157:0)
[11:00:46.982] Timer tick, asking Buildbucket for the build status
[11:00:47.104] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:47.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:158:0) after 1m0s
[11:01:47.187] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:158:0)
[11:01:47.187] Timer tick, asking Buildbucket for the build status
[11:01:47.257] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:47.257] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:159:0) after 1m0s
[11:02:47.347] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:159:0)
[11:02:47.347] Timer tick, asking Buildbucket for the build status
[11:02:47.409] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:47.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:160:0) after 1m0s
[11:03:47.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:160:0)
[11:03:47.540] Timer tick, asking Buildbucket for the build status
[11:03:47.821] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:47.821] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:161:0) after 1m0s
[11:04:47.847] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:161:0)
[11:04:47.848] Timer tick, asking Buildbucket for the build status
[11:04:47.983] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:47.984] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:162:0) after 1m0s
[11:05:48.019] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:162:0)
[11:05:48.019] Timer tick, asking Buildbucket for the build status
[11:05:48.144] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:48.144] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:163:0) after 1m0s
[11:06:48.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:163:0)
[11:06:48.201] Timer tick, asking Buildbucket for the build status
[11:06:48.323] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:48.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:164:0) after 1m0s
[11:07:48.353] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:164:0)
[11:07:48.353] Timer tick, asking Buildbucket for the build status
[11:07:48.471] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:48.471] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:165:0) after 1m0s
[11:08:48.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:165:0)
[11:08:48.498] Timer tick, asking Buildbucket for the build status
[11:08:48.620] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:48.620] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:166:0) after 1m0s
[11:09:48.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:166:0)
[11:09:48.650] Timer tick, asking Buildbucket for the build status
[11:09:48.732] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:48.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:167:0) after 1m0s
[11:10:48.775] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:167:0)
[11:10:48.775] Timer tick, asking Buildbucket for the build status
[11:10:48.875] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:48.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:168:0) after 1m0s
[11:11:48.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:168:0)
[11:11:48.902] Timer tick, asking Buildbucket for the build status
[11:11:48.961] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:48.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:169:0) after 1m0s
[11:12:48.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:169:0)
[11:12:48.986] Timer tick, asking Buildbucket for the build status
[11:12:49.244] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:49.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:170:0) after 1m0s
[11:13:49.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:170:0)
[11:13:49.336] Timer tick, asking Buildbucket for the build status
[11:13:49.371] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:49.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:171:0) after 1m0s
[11:14:49.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:171:0)
[11:14:49.395] Timer tick, asking Buildbucket for the build status
[11:14:49.492] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:49.492] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:172:0) after 1m0s
[11:15:49.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:172:0)
[11:15:49.518] Timer tick, asking Buildbucket for the build status
[11:15:50.037] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:50.037] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:173:0) after 1m0s
[11:16:50.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:173:0)
[11:16:50.063] Timer tick, asking Buildbucket for the build status
[11:16:50.141] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:50.141] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:174:0) after 1m0s
[11:17:50.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:174:0)
[11:17:50.180] Timer tick, asking Buildbucket for the build status
[11:17:50.324] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:50.324] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:175:0) after 1m0s
[11:18:50.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:175:0)
[11:18:50.350] Timer tick, asking Buildbucket for the build status
[11:18:50.423] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:50.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:176:0) after 1m0s
[11:19:50.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:176:0)
[11:19:50.452] Timer tick, asking Buildbucket for the build status
[11:19:50.515] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:50.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:177:0) after 1m0s
[11:20:50.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:177:0)
[11:20:50.547] Timer tick, asking Buildbucket for the build status
[11:20:51.243] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:51.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:178:0) after 1m0s
[11:21:51.272] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:178:0)
[11:21:51.272] Timer tick, asking Buildbucket for the build status
[11:21:51.314] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:51.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:179:0) after 1m0s
[11:22:51.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:179:0)
[11:22:51.336] Timer tick, asking Buildbucket for the build status
[11:22:51.425] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:51.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:180:0) after 1m0s
[11:23:51.462] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:180:0)
[11:23:51.462] Timer tick, asking Buildbucket for the build status
[11:23:51.520] Build 8940949502236064896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:51.520] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9106379564475615664:181:0) after 1m0s
[11:24:27.826] Received PubSub notification, asking Buildbucket for the build status
[11:24:27.863] Build 8940949502236064896: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[11:24:27.863] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary": true,
    "canary_preference": "AUTO",
    "completed_ts": "1531653866395080",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1531643117640630",
    "failure_reason": "BUILD_FAILURE",
    "id": "8940949502236064896",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb\"}}",
    "project": "chromium",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"Failure compare_build_artifacts\\nFailure gsutil upload\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"failure\": {\"failure\": {\"step\": \"gsutil upload\"}, \"humanReason\": \"Infra Failure: Step('gsutil upload') returned 1\"}}, \"recipeExitCode\": {\"value\": 1}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8940949502236064896/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"builder\": [\"Windows deterministic\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3684-658b5dc\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"swarm2173-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"e6ce828ef60c4c1438867b535efbbb5d9a177c0e\", \"got_swarming_client_revision\": \"9a518d097dca20b7b00ce3bdfc5d418ccc79893a\", \"got_revision\": \"7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#23976}\", \"$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@{#575179}\", \"branch\": \"refs/heads/master\", \"revision\": \"7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"c528c0a07f85cc8ff0880f0401fb272878dfdf10\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"76c1d14b8e212db9822a6398343a344ff9028298\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1531643117640630, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9106379564475615664\", \"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\": \"8940949502236064896\"}}, \"got_v8_revision\": \"0551e649579849729ba87ab38e80af5ecd66bbb3\", \"got_v8_revision_cp\": \"refs/heads/6.9.389@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 9510, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"0dd5c6f980d22be96b728155249df2da355989d9\"}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1531643224620210",
    "status": "COMPLETED",
    "status_changed_ts": "1531653867271860",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/9510",
      "builder:Windows deterministic",
      "buildset:commit/git/7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9106379564475615664",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_dimension:builder:Windows deterministic",
      "swarming_dimension:cores:8",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Windows-10",
      "swarming_dimension:pool:luci.chromium.ci",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.chromium.ci/Windows deterministic/9510",
      "swarming_tag:buildbucket_bucket:luci.chromium.ci",
      "swarming_tag:buildbucket_build_id:8940949502236064896",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:1",
      "swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
      "swarming_tag:builder:Windows deterministic",
      "swarming_tag:buildset:commit/git/7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ef0438cd5b2d5b05320bda2fb4cc3bd681186fb",
      "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/8940949502236064896/+/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:9106379564475615664",
      "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:cb76dd9a681a4367362c098d4bb68c8c82db75c2",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:3eb5dcca6c9d0210",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1531653867273580",
    "url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9510",
    "utcnow_ts": "1531653867851910"
  }
}
[11:24:27.863] Invocation finished in 2h59m11.743292968s with status FAILED