Status: SUCCEEDED
Triggered by: -
Duration: 3 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": "d49590e37364cbef099acaf820b9ea9eafef0b51"
}

Incoming tags

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

Debug log (UTC)

[18:07:02.669] New invocation is queued and will start shortly
[18:07:04.260] Starting the invocation (attempt 1)
[18:07:04.317] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:07:04.317] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:07:04.317] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9074815218017324256",
  "parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"d49590e37364cbef099acaf820b9ea9eafef0b51\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Windows deterministic",
    "scheduler_invocation_id:9074815218017324256",
    "scheduler_job_id:chromium/Windows deterministic",
    "user_agent:luci-scheduler",
    "buildset:commit/git/d49590e37364cbef099acaf820b9ea9eafef0b51",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d49590e37364cbef099acaf820b9ea9eafef0b51",
    "gitiles_ref:refs/heads/master"
  ]
}
[18:07:05.037] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1561745224471386",
    "id": "8909385155463052000",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d49590e37364cbef099acaf820b9ea9eafef0b51\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1561745224874402",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/13963",
      "builder:Windows deterministic",
      "buildset:commit/git/d49590e37364cbef099acaf820b9ea9eafef0b51",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d49590e37364cbef099acaf820b9ea9eafef0b51",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9074815218017324256",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8909385155463052000/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:recipe_name:swarming/deterministic_build",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1561745224874507",
    "url": "https://ci.chromium.org/b/8909385155463052000",
    "utcnow_ts": "1561745225030407"
  }
}
[18:07:05.037] Task URL: https://ci.chromium.org/b/8909385155463052000
[18:07:05.037] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:2:0) after 1m0s
[18:08:05.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:2:0)
[18:08:05.247] Timer tick, asking Buildbucket for the build status
[18:08:05.476] Build 8909385155463052000: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:08:05.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:3:0) after 1m0s
[18:09:06.588] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:3:0)
[18:09:06.588] Timer tick, asking Buildbucket for the build status
[18:09:06.793] Build 8909385155463052000: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:09:06.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:4:0) after 1m0s
[18:09:34.292] Received PubSub notification, asking Buildbucket for the build status
[18:09:34.470] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:06.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:4:0)
[18:10:06.812] Timer tick, asking Buildbucket for the build status
[18:10:07.811] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:07.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:6:0) after 1m0s
[18:11:07.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:6:0)
[18:11:07.875] Timer tick, asking Buildbucket for the build status
[18:11:08.185] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:08.185] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:7:0) after 1m0s
[18:12:08.272] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:7:0)
[18:12:08.272] Timer tick, asking Buildbucket for the build status
[18:12:08.472] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:08.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:8:0) after 1m0s
[18:13:08.533] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:8:0)
[18:13:08.533] Timer tick, asking Buildbucket for the build status
[18:13:09.038] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:09.038] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:9:0) after 1m0s
[18:14:09.061] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:9:0)
[18:14:09.061] Timer tick, asking Buildbucket for the build status
[18:14:09.667] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:09.667] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:10:0) after 1m0s
[18:15:09.666] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:10:0)
[18:15:09.666] Timer tick, asking Buildbucket for the build status
[18:15:11.873] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:11.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:11:0) after 1m0s
[18:16:11.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:11:0)
[18:16:11.874] Timer tick, asking Buildbucket for the build status
[18:16:12.056] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:12.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:12:0) after 1m0s
[18:17:12.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:12:0)
[18:17:12.071] Timer tick, asking Buildbucket for the build status
[18:17:12.818] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:12.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:13:0) after 1m0s
[18:18:12.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:13:0)
[18:18:12.906] Timer tick, asking Buildbucket for the build status
[18:18:13.988] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:13.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:14:0) after 1m0s
[18:19:14.083] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:14:0)
[18:19:14.083] Timer tick, asking Buildbucket for the build status
[18:19:14.483] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:14.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:15:0) after 1m0s
[18:20:14.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:15:0)
[18:20:14.507] Timer tick, asking Buildbucket for the build status
[18:20:14.616] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:14.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:16:0) after 1m0s
[18:21:14.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:16:0)
[18:21:14.662] Timer tick, asking Buildbucket for the build status
[18:21:16.650] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:16.650] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:17:0) after 1m0s
[18:22:16.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:17:0)
[18:22:16.788] Timer tick, asking Buildbucket for the build status
[18:22:17.882] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:17.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:18:0) after 1m0s
[18:23:17.989] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:18:0)
[18:23:17.989] Timer tick, asking Buildbucket for the build status
[18:23:18.169] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:18.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:19:0) after 1m0s
[18:24:18.358] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:19:0)
[18:24:18.358] Timer tick, asking Buildbucket for the build status
[18:24:18.913] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:18.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:20:0) after 1m0s
[18:25:19.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:20:0)
[18:25:19.185] Timer tick, asking Buildbucket for the build status
[18:25:20.421] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:20.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:21:0) after 1m0s
[18:26:20.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:21:0)
[18:26:20.745] Timer tick, asking Buildbucket for the build status
[18:26:20.844] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:20.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:22:0) after 1m0s
[18:27:21.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:22:0)
[18:27:21.016] Timer tick, asking Buildbucket for the build status
[18:27:21.142] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:21.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:23:0) after 1m0s
[18:28:21.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:23:0)
[18:28:21.185] Timer tick, asking Buildbucket for the build status
[18:28:22.114] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:22.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:24:0) after 1m0s
[18:29:22.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:24:0)
[18:29:22.139] Timer tick, asking Buildbucket for the build status
[18:29:22.465] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:22.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:25:0) after 1m0s
[18:30:22.500] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:25:0)
[18:30:22.501] Timer tick, asking Buildbucket for the build status
[18:30:25.094] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:25.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:26:0) after 1m0s
[18:31:25.125] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:26:0)
[18:31:25.125] Timer tick, asking Buildbucket for the build status
[18:31:25.427] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:25.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:27:0) after 1m0s
[18:32:25.444] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:27:0)
[18:32:25.444] Timer tick, asking Buildbucket for the build status
[18:32:25.774] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:25.774] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:28:0) after 1m0s
[18:33:25.823] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:28:0)
[18:33:25.823] Timer tick, asking Buildbucket for the build status
[18:33:26.091] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:26.091] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:29:0) after 1m0s
[18:34:26.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:29:0)
[18:34:26.184] Timer tick, asking Buildbucket for the build status
[18:34:26.725] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:26.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:30:0) after 1m0s
[18:35:26.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:30:0)
[18:35:26.913] Timer tick, asking Buildbucket for the build status
[18:35:27.186] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:27.186] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:31:0) after 1m0s
[18:36:27.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:31:0)
[18:36:27.211] Timer tick, asking Buildbucket for the build status
[18:36:28.702] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:28.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:32:0) after 1m0s
[18:37:28.774] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:32:0)
[18:37:28.774] Timer tick, asking Buildbucket for the build status
[18:37:28.930] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:28.930] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:33:0) after 1m0s
[18:38:29.225] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:33:0)
[18:38:29.225] Timer tick, asking Buildbucket for the build status
[18:38:29.526] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:29.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:34:0) after 1m0s
[18:39:29.711] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:34:0)
[18:39:29.711] Timer tick, asking Buildbucket for the build status
[18:39:30.291] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:30.291] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:35:0) after 1m0s
[18:40:30.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:35:0)
[18:40:30.448] Timer tick, asking Buildbucket for the build status
[18:40:31.533] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:31.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:36:0) after 1m0s
[18:41:31.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:36:0)
[18:41:31.753] Timer tick, asking Buildbucket for the build status
[18:41:32.022] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:32.022] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:37:0) after 1m0s
[18:42:32.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:37:0)
[18:42:32.249] Timer tick, asking Buildbucket for the build status
[18:42:32.933] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:32.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:38:0) after 1m0s
[18:43:33.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:38:0)
[18:43:33.048] Timer tick, asking Buildbucket for the build status
[18:43:33.405] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:33.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:39:0) after 1m0s
[18:44:33.423] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:39:0)
[18:44:33.423] Timer tick, asking Buildbucket for the build status
[18:44:33.941] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:33.941] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:40:0) after 1m0s
[18:45:33.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:40:0)
[18:45:33.973] Timer tick, asking Buildbucket for the build status
[18:45:34.297] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:34.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:41:0) after 1m0s
[18:46:34.316] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:41:0)
[18:46:34.316] Timer tick, asking Buildbucket for the build status
[18:46:34.441] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:34.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:42:0) after 1m0s
[18:47:34.509] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:42:0)
[18:47:34.509] Timer tick, asking Buildbucket for the build status
[18:47:35.632] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:35.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:43:0) after 1m0s
[18:48:35.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:43:0)
[18:48:35.655] Timer tick, asking Buildbucket for the build status
[18:48:36.036] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:36.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:44:0) after 1m0s
[18:49:36.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:44:0)
[18:49:36.311] Timer tick, asking Buildbucket for the build status
[18:49:36.662] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:36.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:45:0) after 1m0s
[18:50:38.352] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:45:0)
[18:50:38.352] Timer tick, asking Buildbucket for the build status
[18:50:39.895] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:39.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:46:0) after 1m0s
[18:51:40.138] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:46:0)
[18:51:40.138] Timer tick, asking Buildbucket for the build status
[18:51:41.447] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:41.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:47:0) after 1m0s
[18:52:41.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:47:0)
[18:52:41.727] Timer tick, asking Buildbucket for the build status
[18:52:42.013] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:42.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:48:0) after 1m0s
[18:53:42.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:48:0)
[18:53:42.380] Timer tick, asking Buildbucket for the build status
[18:53:42.915] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:42.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:49:0) after 1m0s
[18:54:42.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:49:0)
[18:54:42.979] Timer tick, asking Buildbucket for the build status
[18:54:43.496] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:43.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:50:0) after 1m0s
[18:55:43.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:50:0)
[18:55:43.698] Timer tick, asking Buildbucket for the build status
[18:55:46.234] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:46.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:51:0) after 1m0s
[18:56:46.360] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:51:0)
[18:56:46.360] Timer tick, asking Buildbucket for the build status
[18:56:47.049] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:47.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:52:0) after 1m0s
[18:57:47.312] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:52:0)
[18:57:47.312] Timer tick, asking Buildbucket for the build status
[18:57:47.834] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:47.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:53:0) after 1m0s
[18:58:47.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:53:0)
[18:58:47.902] Timer tick, asking Buildbucket for the build status
[18:58:48.283] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:48.283] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:54:0) after 1m0s
[18:59:48.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:54:0)
[18:59:48.422] Timer tick, asking Buildbucket for the build status
[18:59:49.004] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:49.004] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:55:0) after 1m0s
[19:00:49.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:55:0)
[19:00:49.106] Timer tick, asking Buildbucket for the build status
[19:00:49.227] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:49.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:56:0) after 1m0s
[19:01:49.244] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:56:0)
[19:01:49.244] Timer tick, asking Buildbucket for the build status
[19:01:50.318] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:50.318] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:57:0) after 1m0s
[19:02:50.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:57:0)
[19:02:50.413] Timer tick, asking Buildbucket for the build status
[19:02:50.568] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:50.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:58:0) after 1m0s
[19:03:50.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:58:0)
[19:03:50.655] Timer tick, asking Buildbucket for the build status
[19:03:50.837] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:50.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:59:0) after 1m0s
[19:04:50.884] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:59:0)
[19:04:50.884] Timer tick, asking Buildbucket for the build status
[19:04:51.019] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:51.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:60:0) after 1m0s
[19:05:51.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:60:0)
[19:05:51.079] Timer tick, asking Buildbucket for the build status
[19:05:51.228] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:51.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:61:0) after 1m0s
[19:06:51.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:61:0)
[19:06:51.286] Timer tick, asking Buildbucket for the build status
[19:06:54.594] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:54.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:62:0) after 1m0s
[19:07:54.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:62:0)
[19:07:54.598] Timer tick, asking Buildbucket for the build status
[19:07:54.978] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:54.978] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:63:0) after 1m0s
[19:08:55.150] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:63:0)
[19:08:55.150] Timer tick, asking Buildbucket for the build status
[19:08:55.709] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:55.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:64:0) after 1m0s
[19:09:55.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:64:0)
[19:09:55.766] Timer tick, asking Buildbucket for the build status
[19:09:56.323] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:56.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:65:0) after 1m0s
[19:10:56.486] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:65:0)
[19:10:56.486] Timer tick, asking Buildbucket for the build status
[19:10:56.798] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:56.798] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:66:0) after 1m0s
[19:11:56.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:66:0)
[19:11:56.824] Timer tick, asking Buildbucket for the build status
[19:11:57.787] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:57.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:67:0) after 1m0s
[19:12:57.815] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:67:0)
[19:12:57.815] Timer tick, asking Buildbucket for the build status
[19:12:58.155] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:58.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:68:0) after 1m0s
[19:13:58.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:68:0)
[19:13:58.183] Timer tick, asking Buildbucket for the build status
[19:13:58.571] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:58.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:69:0) after 1m0s
[19:14:58.606] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:69:0)
[19:14:58.606] Timer tick, asking Buildbucket for the build status
[19:15:00.418] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:00.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:70:0) after 1m0s
[19:16:00.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:70:0)
[19:16:00.505] Timer tick, asking Buildbucket for the build status
[19:16:01.518] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:01.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:71:0) after 1m0s
[19:17:01.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:71:0)
[19:17:01.584] Timer tick, asking Buildbucket for the build status
[19:17:02.264] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:02.264] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:72:0) after 1m0s
[19:18:02.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:72:0)
[19:18:02.290] Timer tick, asking Buildbucket for the build status
[19:18:03.776] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:03.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:73:0) after 1m0s
[19:19:03.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:73:0)
[19:19:03.784] Timer tick, asking Buildbucket for the build status
[19:19:03.972] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:03.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:74:0) after 1m0s
[19:20:03.972] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:74:0)
[19:20:03.972] Timer tick, asking Buildbucket for the build status
[19:20:04.371] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:04.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:75:0) after 1m0s
[19:21:04.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:75:0)
[19:21:04.408] Timer tick, asking Buildbucket for the build status
[19:21:04.611] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:04.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:76:0) after 1m0s
[19:22:04.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:76:0)
[19:22:04.697] Timer tick, asking Buildbucket for the build status
[19:22:04.979] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:04.979] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:77:0) after 1m0s
[19:23:05.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:77:0)
[19:23:05.008] Timer tick, asking Buildbucket for the build status
[19:23:05.367] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:05.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:78:0) after 1m0s
[19:24:05.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:78:0)
[19:24:05.550] Timer tick, asking Buildbucket for the build status
[19:24:05.689] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:05.689] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:79:0) after 1m0s
[19:25:05.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:79:0)
[19:25:05.809] Timer tick, asking Buildbucket for the build status
[19:25:05.927] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:05.927] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:80:0) after 1m0s
[19:26:06.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:80:0)
[19:26:06.085] Timer tick, asking Buildbucket for the build status
[19:26:08.183] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:08.183] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:81:0) after 1m0s
[19:27:08.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:81:0)
[19:27:08.185] Timer tick, asking Buildbucket for the build status
[19:27:09.569] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:09.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:82:0) after 1m0s
[19:28:09.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:82:0)
[19:28:09.698] Timer tick, asking Buildbucket for the build status
[19:28:10.311] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:10.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:83:0) after 1m0s
[19:29:10.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:83:0)
[19:29:10.350] Timer tick, asking Buildbucket for the build status
[19:29:10.547] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:10.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:84:0) after 1m0s
[19:30:10.594] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:84:0)
[19:30:10.594] Timer tick, asking Buildbucket for the build status
[19:30:11.336] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:11.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:85:0) after 1m0s
[19:31:12.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:85:0)
[19:31:12.994] Timer tick, asking Buildbucket for the build status
[19:31:13.482] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:13.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:86:0) after 1m0s
[19:32:13.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:86:0)
[19:32:13.477] Timer tick, asking Buildbucket for the build status
[19:32:15.638] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:15.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:87:0) after 1m0s
[19:33:18.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:87:0)
[19:33:18.431] Timer tick, asking Buildbucket for the build status
[19:33:18.645] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:18.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:88:0) after 1m0s
[19:34:19.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:88:0)
[19:34:19.247] Timer tick, asking Buildbucket for the build status
[19:34:19.637] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:19.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:89:0) after 1m0s
[19:35:19.989] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:89:0)
[19:35:19.989] Timer tick, asking Buildbucket for the build status
[19:35:21.569] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:21.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:90:0) after 1m0s
[19:36:21.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:90:0)
[19:36:21.881] Timer tick, asking Buildbucket for the build status
[19:36:22.036] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:22.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:91:0) after 1m0s
[19:37:22.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:91:0)
[19:37:22.182] Timer tick, asking Buildbucket for the build status
[19:37:23.231] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:23.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:92:0) after 1m0s
[19:38:23.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:92:0)
[19:38:23.266] Timer tick, asking Buildbucket for the build status
[19:38:23.422] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:23.422] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:93:0) after 1m0s
[19:39:23.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:93:0)
[19:39:23.473] Timer tick, asking Buildbucket for the build status
[19:39:24.552] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:24.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:94:0) after 1m0s
[19:40:24.591] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:94:0)
[19:40:24.591] Timer tick, asking Buildbucket for the build status
[19:40:24.841] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:24.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:95:0) after 1m0s
[19:41:24.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:95:0)
[19:41:24.926] Timer tick, asking Buildbucket for the build status
[19:41:25.077] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:25.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:96:0) after 1m0s
[19:42:25.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:96:0)
[19:42:25.144] Timer tick, asking Buildbucket for the build status
[19:42:26.194] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:26.194] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:97:0) after 1m0s
[19:43:26.221] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:97:0)
[19:43:26.221] Timer tick, asking Buildbucket for the build status
[19:43:26.406] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:26.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:98:0) after 1m0s
[19:44:26.645] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:98:0)
[19:44:26.645] Timer tick, asking Buildbucket for the build status
[19:44:27.914] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:27.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:99:0) after 1m0s
[19:45:27.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:99:0)
[19:45:27.994] Timer tick, asking Buildbucket for the build status
[19:45:28.314] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:28.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:100:0) after 1m0s
[19:46:28.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:100:0)
[19:46:28.492] Timer tick, asking Buildbucket for the build status
[19:46:30.926] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:30.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:101:0) after 1m0s
[19:47:30.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:101:0)
[19:47:30.952] Timer tick, asking Buildbucket for the build status
[19:47:32.727] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:32.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:102:0) after 1m0s
[19:48:32.764] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:102:0)
[19:48:32.764] Timer tick, asking Buildbucket for the build status
[19:48:34.023] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:34.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:103:0) after 1m0s
[19:49:34.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:103:0)
[19:49:34.189] Timer tick, asking Buildbucket for the build status
[19:49:34.740] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:34.740] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:104:0) after 1m0s
[19:50:34.905] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:104:0)
[19:50:34.905] Timer tick, asking Buildbucket for the build status
[19:50:35.182] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:35.182] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:105:0) after 1m0s
[19:51:36.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:105:0)
[19:51:36.729] Timer tick, asking Buildbucket for the build status
[19:51:37.055] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:37.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:106:0) after 1m0s
[19:52:37.161] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:106:0)
[19:52:37.161] Timer tick, asking Buildbucket for the build status
[19:52:37.770] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:37.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:107:0) after 1m0s
[19:53:37.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:107:0)
[19:53:37.874] Timer tick, asking Buildbucket for the build status
[19:53:38.007] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:38.007] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:108:0) after 1m0s
[19:54:38.127] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:108:0)
[19:54:38.127] Timer tick, asking Buildbucket for the build status
[19:54:38.286] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:38.286] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:109:0) after 1m0s
[19:55:38.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:109:0)
[19:55:38.375] Timer tick, asking Buildbucket for the build status
[19:55:42.875] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:42.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:110:0) after 1m0s
[19:56:43.178] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:110:0)
[19:56:43.179] Timer tick, asking Buildbucket for the build status
[19:56:43.510] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:43.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:111:0) after 1m0s
[19:57:43.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:111:0)
[19:57:43.626] Timer tick, asking Buildbucket for the build status
[19:57:43.816] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:43.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:112:0) after 1m0s
[19:58:43.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:112:0)
[19:58:43.869] Timer tick, asking Buildbucket for the build status
[19:58:44.232] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:44.232] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:113:0) after 1m0s
[19:59:44.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:113:0)
[19:59:44.343] Timer tick, asking Buildbucket for the build status
[19:59:44.935] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:44.936] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:114:0) after 1m0s
[20:00:44.963] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:114:0)
[20:00:44.963] Timer tick, asking Buildbucket for the build status
[20:00:45.092] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:45.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:115:0) after 1m0s
[20:01:45.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:115:0)
[20:01:45.111] Timer tick, asking Buildbucket for the build status
[20:01:45.370] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:45.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:116:0) after 1m0s
[20:02:45.393] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:116:0)
[20:02:45.393] Timer tick, asking Buildbucket for the build status
[20:02:45.570] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:45.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:117:0) after 1m0s
[20:03:45.661] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:117:0)
[20:03:45.661] Timer tick, asking Buildbucket for the build status
[20:03:45.896] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:45.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:118:0) after 1m0s
[20:04:45.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:118:0)
[20:04:45.964] Timer tick, asking Buildbucket for the build status
[20:04:46.805] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:46.805] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:119:0) after 1m0s
[20:05:46.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:119:0)
[20:05:46.829] Timer tick, asking Buildbucket for the build status
[20:05:47.111] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:47.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:120:0) after 1m0s
[20:06:47.146] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:120:0)
[20:06:47.146] Timer tick, asking Buildbucket for the build status
[20:06:47.241] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:47.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:121:0) after 1m0s
[20:07:47.317] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:121:0)
[20:07:47.317] Timer tick, asking Buildbucket for the build status
[20:07:48.219] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:48.219] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:122:0) after 1m0s
[20:08:48.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:122:0)
[20:08:48.306] Timer tick, asking Buildbucket for the build status
[20:08:48.425] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:48.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:123:0) after 1m0s
[20:09:48.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:123:0)
[20:09:48.447] Timer tick, asking Buildbucket for the build status
[20:09:48.673] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:48.673] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:124:0) after 1m0s
[20:10:48.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:124:0)
[20:10:48.777] Timer tick, asking Buildbucket for the build status
[20:10:49.403] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:49.403] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:125:0) after 1m0s
[20:11:50.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:125:0)
[20:11:50.071] Timer tick, asking Buildbucket for the build status
[20:11:50.392] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:50.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:126:0) after 1m0s
[20:12:50.495] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:126:0)
[20:12:50.495] Timer tick, asking Buildbucket for the build status
[20:12:50.767] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:50.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:127:0) after 1m0s
[20:13:50.839] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:127:0)
[20:13:50.839] Timer tick, asking Buildbucket for the build status
[20:13:51.443] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:51.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:128:0) after 1m0s
[20:14:51.548] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:128:0)
[20:14:51.548] Timer tick, asking Buildbucket for the build status
[20:14:51.704] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:51.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:129:0) after 1m0s
[20:15:51.711] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:129:0)
[20:15:51.711] Timer tick, asking Buildbucket for the build status
[20:15:52.454] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:52.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:130:0) after 1m0s
[20:16:52.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:130:0)
[20:16:52.592] Timer tick, asking Buildbucket for the build status
[20:16:52.788] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:52.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:131:0) after 1m0s
[20:17:52.918] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:131:0)
[20:17:52.918] Timer tick, asking Buildbucket for the build status
[20:17:53.039] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:53.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:132:0) after 1m0s
[20:18:53.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:132:0)
[20:18:53.180] Timer tick, asking Buildbucket for the build status
[20:18:53.340] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:53.340] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:133:0) after 1m0s
[20:19:53.458] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:133:0)
[20:19:53.458] Timer tick, asking Buildbucket for the build status
[20:19:53.585] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:53.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:134:0) after 1m0s
[20:20:53.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:134:0)
[20:20:53.691] Timer tick, asking Buildbucket for the build status
[20:20:54.015] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:54.015] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:135:0) after 1m0s
[20:21:54.097] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:135:0)
[20:21:54.097] Timer tick, asking Buildbucket for the build status
[20:21:55.292] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:55.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:136:0) after 1m0s
[20:22:55.352] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:136:0)
[20:22:55.352] Timer tick, asking Buildbucket for the build status
[20:22:56.128] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:56.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:137:0) after 1m0s
[20:23:56.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:137:0)
[20:23:56.145] Timer tick, asking Buildbucket for the build status
[20:23:56.305] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:56.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:138:0) after 1m0s
[20:24:56.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:138:0)
[20:24:56.388] Timer tick, asking Buildbucket for the build status
[20:24:56.554] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:56.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:139:0) after 1m0s
[20:25:56.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:139:0)
[20:25:56.571] Timer tick, asking Buildbucket for the build status
[20:25:56.754] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:56.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:140:0) after 1m0s
[20:26:56.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:140:0)
[20:26:56.756] Timer tick, asking Buildbucket for the build status
[20:26:57.265] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:57.265] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:141:0) after 1m0s
[20:27:57.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:141:0)
[20:27:57.289] Timer tick, asking Buildbucket for the build status
[20:27:57.416] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:57.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:142:0) after 1m0s
[20:28:57.468] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:142:0)
[20:28:57.468] Timer tick, asking Buildbucket for the build status
[20:28:58.273] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:58.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:143:0) after 1m0s
[20:29:58.367] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:143:0)
[20:29:58.367] Timer tick, asking Buildbucket for the build status
[20:29:58.745] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:58.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:144:0) after 1m0s
[20:30:58.779] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:144:0)
[20:30:58.779] Timer tick, asking Buildbucket for the build status
[20:30:58.935] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:58.935] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:145:0) after 1m0s
[20:31:59.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:145:0)
[20:31:59.301] Timer tick, asking Buildbucket for the build status
[20:31:59.427] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:59.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:146:0) after 1m0s
[20:32:59.456] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:146:0)
[20:32:59.456] Timer tick, asking Buildbucket for the build status
[20:32:59.888] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:59.888] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:147:0) after 1m0s
[20:33:59.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:147:0)
[20:33:59.887] Timer tick, asking Buildbucket for the build status
[20:34:00.049] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:00.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:148:0) after 1m0s
[20:35:00.077] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:148:0)
[20:35:00.077] Timer tick, asking Buildbucket for the build status
[20:35:00.209] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:00.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:149:0) after 1m0s
[20:36:00.244] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:149:0)
[20:36:00.244] Timer tick, asking Buildbucket for the build status
[20:36:00.695] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:00.695] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:150:0) after 1m0s
[20:37:00.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:150:0)
[20:37:00.801] Timer tick, asking Buildbucket for the build status
[20:37:03.441] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:03.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:151:0) after 1m0s
[20:38:03.517] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:151:0)
[20:38:03.517] Timer tick, asking Buildbucket for the build status
[20:38:03.616] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:03.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:152:0) after 1m0s
[20:39:03.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:152:0)
[20:39:03.688] Timer tick, asking Buildbucket for the build status
[20:39:03.903] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:03.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:153:0) after 1m0s
[20:40:04.002] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:153:0)
[20:40:04.002] Timer tick, asking Buildbucket for the build status
[20:40:05.016] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:05.016] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:154:0) after 1m0s
[20:41:05.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:154:0)
[20:41:05.016] Timer tick, asking Buildbucket for the build status
[20:41:05.823] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:05.823] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:155:0) after 1m0s
[20:42:05.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:155:0)
[20:42:05.869] Timer tick, asking Buildbucket for the build status
[20:42:06.419] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:06.420] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:156:0) after 1m0s
[20:43:06.464] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:156:0)
[20:43:06.464] Timer tick, asking Buildbucket for the build status
[20:43:07.159] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:07.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:157:0) after 1m0s
[20:44:07.373] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:157:0)
[20:44:07.373] Timer tick, asking Buildbucket for the build status
[20:44:08.536] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:08.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:158:0) after 1m0s
[20:45:08.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:158:0)
[20:45:08.642] Timer tick, asking Buildbucket for the build status
[20:45:08.836] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:08.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:159:0) after 1m0s
[20:46:08.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:159:0)
[20:46:08.943] Timer tick, asking Buildbucket for the build status
[20:46:09.694] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:09.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:160:0) after 1m0s
[20:47:09.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:160:0)
[20:47:09.719] Timer tick, asking Buildbucket for the build status
[20:47:09.921] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:09.921] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:161:0) after 1m0s
[20:48:10.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:161:0)
[20:48:10.004] Timer tick, asking Buildbucket for the build status
[20:48:10.448] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:10.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:162:0) after 1m0s
[20:49:10.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:162:0)
[20:49:10.504] Timer tick, asking Buildbucket for the build status
[20:49:10.871] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:10.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:163:0) after 1m0s
[20:50:10.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:163:0)
[20:50:10.901] Timer tick, asking Buildbucket for the build status
[20:50:11.305] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:11.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:164:0) after 1m0s
[20:51:11.360] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:164:0)
[20:51:11.360] Timer tick, asking Buildbucket for the build status
[20:51:12.343] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:12.343] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:165:0) after 1m0s
[20:52:12.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:165:0)
[20:52:12.403] Timer tick, asking Buildbucket for the build status
[20:52:15.822] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:15.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:166:0) after 1m0s
[20:53:17.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:166:0)
[20:53:17.571] Timer tick, asking Buildbucket for the build status
[20:53:18.322] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:18.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:167:0) after 1m0s
[20:54:18.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:167:0)
[20:54:18.354] Timer tick, asking Buildbucket for the build status
[20:54:21.331] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:21.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:168:0) after 1m0s
[20:55:21.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:168:0)
[20:55:21.629] Timer tick, asking Buildbucket for the build status
[20:55:22.137] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:22.137] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:169:0) after 1m0s
[20:56:22.338] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:169:0)
[20:56:22.338] Timer tick, asking Buildbucket for the build status
[20:56:23.394] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:23.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:170:0) after 1m0s
[20:57:23.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:170:0)
[20:57:23.532] Timer tick, asking Buildbucket for the build status
[20:57:24.541] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:24.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:171:0) after 1m0s
[20:58:24.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:171:0)
[20:58:24.541] Timer tick, asking Buildbucket for the build status
[20:58:25.153] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:25.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:172:0) after 1m0s
[20:59:25.215] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:172:0)
[20:59:25.215] Timer tick, asking Buildbucket for the build status
[20:59:25.768] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:25.768] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:173:0) after 1m0s
[21:00:25.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:173:0)
[21:00:25.841] Timer tick, asking Buildbucket for the build status
[21:00:26.430] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:26.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:174:0) after 1m0s
[21:01:26.441] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:174:0)
[21:01:26.441] Timer tick, asking Buildbucket for the build status
[21:01:27.300] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:27.300] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:175:0) after 1m0s
[21:02:27.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:175:0)
[21:02:27.325] Timer tick, asking Buildbucket for the build status
[21:02:27.467] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:27.468] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:176:0) after 1m0s
[21:03:27.509] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:176:0)
[21:03:27.509] Timer tick, asking Buildbucket for the build status
[21:03:27.661] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:27.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:177:0) after 1m0s
[21:04:27.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:177:0)
[21:04:27.726] Timer tick, asking Buildbucket for the build status
[21:04:28.255] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:28.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:178:0) after 1m0s
[21:05:28.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:178:0)
[21:05:28.313] Timer tick, asking Buildbucket for the build status
[21:05:28.508] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:28.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:179:0) after 1m0s
[21:06:28.577] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:179:0)
[21:06:28.577] Timer tick, asking Buildbucket for the build status
[21:06:29.238] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:29.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:180:0) after 1m0s
[21:07:29.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:180:0)
[21:07:29.301] Timer tick, asking Buildbucket for the build status
[21:07:29.459] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:29.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:181:0) after 1m0s
[21:08:29.544] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:181:0)
[21:08:29.544] Timer tick, asking Buildbucket for the build status
[21:08:29.970] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:29.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:182:0) after 1m0s
[21:09:30.050] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:182:0)
[21:09:30.050] Timer tick, asking Buildbucket for the build status
[21:09:30.195] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:30.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:183:0) after 1m0s
[21:10:30.217] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:183:0)
[21:10:30.217] Timer tick, asking Buildbucket for the build status
[21:10:31.211] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:31.211] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:184:0) after 1m0s
[21:11:31.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:184:0)
[21:11:31.296] Timer tick, asking Buildbucket for the build status
[21:11:31.813] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:31.813] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:185:0) after 1m0s
[21:12:31.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:185:0)
[21:12:31.872] Timer tick, asking Buildbucket for the build status
[21:12:32.328] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:32.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:186:0) after 1m0s
[21:13:32.412] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:186:0)
[21:13:32.412] Timer tick, asking Buildbucket for the build status
[21:13:32.726] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:32.726] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:187:0) after 1m0s
[21:14:33.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:187:0)
[21:14:33.003] Timer tick, asking Buildbucket for the build status
[21:14:33.622] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:33.622] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:188:0) after 1m0s
[21:15:33.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:188:0)
[21:15:33.717] Timer tick, asking Buildbucket for the build status
[21:15:36.653] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:36.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:189:0) after 1m0s
[21:16:36.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:189:0)
[21:16:36.944] Timer tick, asking Buildbucket for the build status
[21:16:37.607] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:37.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:190:0) after 1m0s
[21:17:37.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:190:0)
[21:17:37.785] Timer tick, asking Buildbucket for the build status
[21:17:38.491] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:38.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:191:0) after 1m0s
[21:18:38.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:191:0)
[21:18:38.648] Timer tick, asking Buildbucket for the build status
[21:18:39.050] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:39.050] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:192:0) after 1m0s
[21:19:39.078] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:192:0)
[21:19:39.078] Timer tick, asking Buildbucket for the build status
[21:19:39.661] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:39.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:193:0) after 1m0s
[21:20:39.733] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:193:0)
[21:20:39.733] Timer tick, asking Buildbucket for the build status
[21:20:40.955] Build 8909385155463052000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:40.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074815218017324256:194:0) after 1m0s
[21:21:25.091] Received PubSub notification, asking Buildbucket for the build status
[21:21:25.402] Build 8909385155463052000: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:21:25.402] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1561756881701598",
    "created_by": "project:chromium",
    "created_ts": "1561745224471386",
    "id": "8909385155463052000",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d49590e37364cbef099acaf820b9ea9eafef0b51\"}}",
    "project": "chromium",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"windows-deterministic-0-4mnd\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 13963, \"got_angle_revision\": \"d4d43ac073820d7662774189ae058488abd363b2\", \"got_dawn_revision\": \"eee3e41c554257a0ece66e70b2b4e1390ffa6ab0\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"d49590e37364cbef099acaf820b9ea9eafef0b51\", \"got_revision_cp\": \"refs/heads/master@{#673408}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"b8c9b1717dfbfc02e2b33f9e893cd2729eccca90\", \"got_v8_revision_cp\": \"refs/heads/7.7.165@{#1}\", \"got_webrtc_revision\": \"a47ba4119f27fa84831f16b2f7764a5439145a0d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28413}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d49590e37364cbef099acaf820b9ea9eafef0b51\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Windows deterministic\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-4mnd\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4351-b85b41c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1561745373060343",
    "status": "COMPLETED",
    "status_changed_ts": "1561756882864474",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/13963",
      "builder:Windows deterministic",
      "buildset:commit/git/d49590e37364cbef099acaf820b9ea9eafef0b51",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d49590e37364cbef099acaf820b9ea9eafef0b51",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9074815218017324256",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8909385155463052000/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:os:Windows",
      "swarming_tag:recipe_name:swarming/deterministic_build",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:45b8167ed0774d10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1561756882904605",
    "url": "https://ci.chromium.org/b/8909385155463052000",
    "utcnow_ts": "1561756885392357"
  }
}
[21:21:25.402] Invocation finished in 3h14m22.749465322s with status SUCCEEDED