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",
  "revision": "797d696d9e823a736f1cb97d38538c361b314f9c"
}

Incoming tags

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

Debug log (UTC)

[21:22:26.159] New invocation is queued and will start shortly
[21:22:27.241] Starting the invocation (attempt 1)
[21:22:27.279] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:22:27.282] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:22:27.282] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9041100853544459280",
  "parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"797d696d9e823a736f1cb97d38538c361b314f9c\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Windows deterministic",
    "scheduler_invocation_id:9041100853544459280",
    "scheduler_job_id:chromium/Windows deterministic",
    "user_agent:luci-scheduler",
    "buildset:commit/git/797d696d9e823a736f1cb97d38538c361b314f9c",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/797d696d9e823a736f1cb97d38538c361b314f9c",
    "gitiles_ref:refs/heads/master"
  ]
}
[21:22:28.160] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1593897747400216",
    "id": "8875670791580297456",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"797d696d9e823a736f1cb97d38538c361b314f9c\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1593897747876238",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/16777",
      "builder:Windows deterministic",
      "buildset:commit/git/797d696d9e823a736f1cb97d38538c361b314f9c",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/797d696d9e823a736f1cb97d38538c361b314f9c",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9041100853544459280",
      "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/8875670791580297456/+/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": "1593897747876366",
    "url": "https://ci.chromium.org/b/8875670791580297456",
    "utcnow_ts": "1593897748134641"
  }
}
[21:22:28.160] Task URL: https://ci.chromium.org/b/8875670791580297456
[21:22:28.160] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:2:0) after 1m0s
[21:23:28.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:2:0)
[21:23:28.186] Timer tick, asking Buildbucket for the build status
[21:23:28.388] Build 8875670791580297456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:23:28.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:3:0) after 1m0s
[21:24:28.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:3:0)
[21:24:28.453] Timer tick, asking Buildbucket for the build status
[21:24:28.567] Build 8875670791580297456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:24:28.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:4:0) after 1m0s
[21:25:28.589] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:4:0)
[21:25:28.589] Timer tick, asking Buildbucket for the build status
[21:25:28.715] Build 8875670791580297456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:25:28.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:5:0) after 1m0s
[21:26:28.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:5:0)
[21:26:28.810] Timer tick, asking Buildbucket for the build status
[21:26:28.946] Build 8875670791580297456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:26:28.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:6:0) after 1m0s
[21:27:28.982] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:6:0)
[21:27:28.982] Timer tick, asking Buildbucket for the build status
[21:27:29.105] Build 8875670791580297456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:27:29.105] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:7:0) after 1m0s
[21:27:39.832] Received PubSub notification, asking Buildbucket for the build status
[21:27:39.983] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:29.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:7:0)
[21:28:29.182] Timer tick, asking Buildbucket for the build status
[21:28:29.250] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:29.250] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:9:0) after 1m0s
[21:29:29.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:9:0)
[21:29:29.321] Timer tick, asking Buildbucket for the build status
[21:29:29.504] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:29.504] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:10:0) after 1m0s
[21:30:29.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:10:0)
[21:30:29.476] Timer tick, asking Buildbucket for the build status
[21:30:29.576] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:29.576] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:11:0) after 1m0s
[21:31:29.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:11:0)
[21:31:29.597] Timer tick, asking Buildbucket for the build status
[21:31:29.760] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:29.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:12:0) after 1m0s
[21:32:29.780] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:12:0)
[21:32:29.780] Timer tick, asking Buildbucket for the build status
[21:32:30.016] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:30.016] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:13:0) after 1m0s
[21:33:30.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:13:0)
[21:33:30.089] Timer tick, asking Buildbucket for the build status
[21:33:30.212] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:30.212] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:14:0) after 1m0s
[21:34:30.239] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:14:0)
[21:34:30.239] Timer tick, asking Buildbucket for the build status
[21:34:32.325] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:32.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:15:0) after 1m0s
[21:35:32.377] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:15:0)
[21:35:32.377] Timer tick, asking Buildbucket for the build status
[21:35:32.582] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:32.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:16:0) after 1m0s
[21:36:32.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:16:0)
[21:36:32.609] Timer tick, asking Buildbucket for the build status
[21:36:32.739] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:32.739] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:17:0) after 1m0s
[21:37:32.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:17:0)
[21:37:32.761] Timer tick, asking Buildbucket for the build status
[21:37:33.980] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:33.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:18:0) after 1m0s
[21:38:33.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:18:0)
[21:38:33.999] Timer tick, asking Buildbucket for the build status
[21:38:34.196] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:34.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:19:0) after 1m0s
[21:39:34.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:19:0)
[21:39:34.222] Timer tick, asking Buildbucket for the build status
[21:39:34.722] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:34.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:20:0) after 1m0s
[21:40:34.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:20:0)
[21:40:34.742] Timer tick, asking Buildbucket for the build status
[21:40:35.381] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:35.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:21:0) after 1m0s
[21:41:35.457] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:21:0)
[21:41:35.457] Timer tick, asking Buildbucket for the build status
[21:41:35.559] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:35.559] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:22:0) after 1m0s
[21:42:35.699] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:22:0)
[21:42:35.699] Timer tick, asking Buildbucket for the build status
[21:42:35.972] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:35.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:23:0) after 1m0s
[21:43:36.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:23:0)
[21:43:36.169] Timer tick, asking Buildbucket for the build status
[21:43:36.349] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:36.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:24:0) after 1m0s
[21:44:36.383] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:24:0)
[21:44:36.383] Timer tick, asking Buildbucket for the build status
[21:44:36.578] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:36.578] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:25:0) after 1m0s
[21:45:36.599] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:25:0)
[21:45:36.599] Timer tick, asking Buildbucket for the build status
[21:45:36.770] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:36.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:26:0) after 1m0s
[21:46:36.790] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:26:0)
[21:46:36.790] Timer tick, asking Buildbucket for the build status
[21:46:37.026] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:37.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:27:0) after 1m0s
[21:47:37.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:27:0)
[21:47:37.095] Timer tick, asking Buildbucket for the build status
[21:47:37.374] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:37.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:28:0) after 1m0s
[21:48:37.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:28:0)
[21:48:37.392] Timer tick, asking Buildbucket for the build status
[21:48:37.665] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:37.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:29:0) after 1m0s
[21:49:37.778] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:29:0)
[21:49:37.778] Timer tick, asking Buildbucket for the build status
[21:49:37.898] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:37.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:30:0) after 1m0s
[21:50:37.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:30:0)
[21:50:37.945] Timer tick, asking Buildbucket for the build status
[21:50:38.080] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:38.080] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:31:0) after 1m0s
[21:51:38.166] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:31:0)
[21:51:38.166] Timer tick, asking Buildbucket for the build status
[21:51:38.322] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:38.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:32:0) after 1m0s
[21:52:38.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:32:0)
[21:52:38.494] Timer tick, asking Buildbucket for the build status
[21:52:39.549] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:39.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:33:0) after 1m0s
[21:53:39.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:33:0)
[21:53:39.714] Timer tick, asking Buildbucket for the build status
[21:53:39.826] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:39.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:34:0) after 1m0s
[21:54:39.905] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:34:0)
[21:54:39.905] Timer tick, asking Buildbucket for the build status
[21:54:40.022] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:40.022] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:35:0) after 1m0s
[21:55:40.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:35:0)
[21:55:40.089] Timer tick, asking Buildbucket for the build status
[21:55:40.233] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:40.233] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:36:0) after 1m0s
[21:56:40.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:36:0)
[21:56:40.268] Timer tick, asking Buildbucket for the build status
[21:56:40.675] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:40.675] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:37:0) after 1m0s
[21:57:40.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:37:0)
[21:57:40.877] Timer tick, asking Buildbucket for the build status
[21:57:41.346] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:41.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:38:0) after 1m0s
[21:58:41.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:38:0)
[21:58:41.422] Timer tick, asking Buildbucket for the build status
[21:58:41.739] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:41.739] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:39:0) after 1m0s
[21:59:41.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:39:0)
[21:59:41.822] Timer tick, asking Buildbucket for the build status
[21:59:42.371] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:42.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:40:0) after 1m0s
[22:00:42.427] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:40:0)
[22:00:42.427] Timer tick, asking Buildbucket for the build status
[22:00:42.561] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:42.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:41:0) after 1m0s
[22:01:42.641] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:41:0)
[22:01:42.641] Timer tick, asking Buildbucket for the build status
[22:01:42.762] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:42.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:42:0) after 1m0s
[22:02:42.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:42:0)
[22:02:42.788] Timer tick, asking Buildbucket for the build status
[22:02:43.070] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:43.070] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:43:0) after 1m0s
[22:03:43.130] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:43:0)
[22:03:43.130] Timer tick, asking Buildbucket for the build status
[22:03:43.262] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:43.262] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:44:0) after 1m0s
[22:04:43.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:44:0)
[22:04:43.299] Timer tick, asking Buildbucket for the build status
[22:04:43.430] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:43.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:45:0) after 1m0s
[22:05:43.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:45:0)
[22:05:43.603] Timer tick, asking Buildbucket for the build status
[22:05:43.939] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:43.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:46:0) after 1m0s
[22:06:43.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:46:0)
[22:06:43.985] Timer tick, asking Buildbucket for the build status
[22:06:44.289] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:44.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:47:0) after 1m0s
[22:07:44.340] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:47:0)
[22:07:44.340] Timer tick, asking Buildbucket for the build status
[22:07:47.328] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:47.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:48:0) after 1m0s
[22:08:47.456] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:48:0)
[22:08:47.457] Timer tick, asking Buildbucket for the build status
[22:08:47.583] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:47.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:49:0) after 1m0s
[22:09:47.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:49:0)
[22:09:47.642] Timer tick, asking Buildbucket for the build status
[22:09:48.067] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:48.067] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:50:0) after 1m0s
[22:10:48.150] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:50:0)
[22:10:48.150] Timer tick, asking Buildbucket for the build status
[22:10:48.338] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:48.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:51:0) after 1m0s
[22:11:48.412] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:51:0)
[22:11:48.412] Timer tick, asking Buildbucket for the build status
[22:11:48.664] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:48.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:52:0) after 1m0s
[22:12:48.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:52:0)
[22:12:48.795] Timer tick, asking Buildbucket for the build status
[22:12:49.158] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:49.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:53:0) after 1m0s
[22:13:49.146] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:53:0)
[22:13:49.146] Timer tick, asking Buildbucket for the build status
[22:13:49.301] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:49.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:54:0) after 1m0s
[22:14:49.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:54:0)
[22:14:49.389] Timer tick, asking Buildbucket for the build status
[22:14:49.638] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:49.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:55:0) after 1m0s
[22:15:49.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:55:0)
[22:15:49.719] Timer tick, asking Buildbucket for the build status
[22:15:49.913] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:49.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:56:0) after 1m0s
[22:16:50.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:56:0)
[22:16:50.024] Timer tick, asking Buildbucket for the build status
[22:16:50.146] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:50.146] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:57:0) after 1m0s
[22:17:50.347] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:57:0)
[22:17:50.347] Timer tick, asking Buildbucket for the build status
[22:17:50.952] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:50.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:58:0) after 1m0s
[22:18:51.205] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:58:0)
[22:18:51.205] Timer tick, asking Buildbucket for the build status
[22:18:51.357] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:51.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:59:0) after 1m0s
[22:19:51.458] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:59:0)
[22:19:51.458] Timer tick, asking Buildbucket for the build status
[22:19:51.745] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:51.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:60:0) after 1m0s
[22:20:51.768] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:60:0)
[22:20:51.768] Timer tick, asking Buildbucket for the build status
[22:20:51.957] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:51.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:61:0) after 1m0s
[22:21:52.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:61:0)
[22:21:52.038] Timer tick, asking Buildbucket for the build status
[22:21:52.346] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:52.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:62:0) after 1m0s
[22:22:52.381] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:62:0)
[22:22:52.381] Timer tick, asking Buildbucket for the build status
[22:22:52.516] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:52.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:63:0) after 1m0s
[22:23:52.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:63:0)
[22:23:52.536] Timer tick, asking Buildbucket for the build status
[22:23:52.674] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:52.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:64:0) after 1m0s
[22:24:52.754] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:64:0)
[22:24:52.754] Timer tick, asking Buildbucket for the build status
[22:24:52.882] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:52.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:65:0) after 1m0s
[22:25:53.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:65:0)
[22:25:53.035] Timer tick, asking Buildbucket for the build status
[22:25:53.156] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:53.157] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:66:0) after 1m0s
[22:26:53.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:66:0)
[22:26:53.180] Timer tick, asking Buildbucket for the build status
[22:26:53.297] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:53.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:67:0) after 1m0s
[22:27:53.318] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:67:0)
[22:27:53.318] Timer tick, asking Buildbucket for the build status
[22:27:53.458] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:53.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:68:0) after 1m0s
[22:28:53.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:68:0)
[22:28:53.567] Timer tick, asking Buildbucket for the build status
[22:28:53.667] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:53.667] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:69:0) after 1m0s
[22:29:53.710] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:69:0)
[22:29:53.710] Timer tick, asking Buildbucket for the build status
[22:29:54.115] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:54.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:70:0) after 1m0s
[22:30:54.138] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:70:0)
[22:30:54.138] Timer tick, asking Buildbucket for the build status
[22:30:55.604] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:55.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:71:0) after 1m0s
[22:31:55.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:71:0)
[22:31:55.628] Timer tick, asking Buildbucket for the build status
[22:31:55.762] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:55.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:72:0) after 1m0s
[22:32:55.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:72:0)
[22:32:55.785] Timer tick, asking Buildbucket for the build status
[22:32:56.118] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:56.118] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:73:0) after 1m0s
[22:33:56.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:73:0)
[22:33:56.154] Timer tick, asking Buildbucket for the build status
[22:33:56.417] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:56.417] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:74:0) after 1m0s
[22:34:56.444] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:74:0)
[22:34:56.444] Timer tick, asking Buildbucket for the build status
[22:34:56.577] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:56.577] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:75:0) after 1m0s
[22:35:56.599] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:75:0)
[22:35:56.599] Timer tick, asking Buildbucket for the build status
[22:35:56.750] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:56.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:76:0) after 1m0s
[22:36:56.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:76:0)
[22:36:56.781] Timer tick, asking Buildbucket for the build status
[22:36:56.893] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:56.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:77:0) after 1m0s
[22:37:56.918] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:77:0)
[22:37:56.918] Timer tick, asking Buildbucket for the build status
[22:37:57.224] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:57.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:78:0) after 1m0s
[22:38:57.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:78:0)
[22:38:57.261] Timer tick, asking Buildbucket for the build status
[22:38:57.622] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:57.622] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:79:0) after 1m0s
[22:39:57.746] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:79:0)
[22:39:57.746] Timer tick, asking Buildbucket for the build status
[22:39:58.160] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:58.160] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:80:0) after 1m0s
[22:40:58.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:80:0)
[22:40:58.196] Timer tick, asking Buildbucket for the build status
[22:40:58.312] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:58.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:81:0) after 1m0s
[22:41:58.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:81:0)
[22:41:58.344] Timer tick, asking Buildbucket for the build status
[22:41:58.476] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:58.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:82:0) after 1m0s
[22:42:58.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:82:0)
[22:42:58.505] Timer tick, asking Buildbucket for the build status
[22:42:58.726] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:58.726] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:83:0) after 1m0s
[22:43:58.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:83:0)
[22:43:58.753] Timer tick, asking Buildbucket for the build status
[22:43:58.873] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:58.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:84:0) after 1m0s
[22:44:58.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:84:0)
[22:44:58.896] Timer tick, asking Buildbucket for the build status
[22:44:59.003] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:59.003] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:85:0) after 1m0s
[22:45:59.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:85:0)
[22:45:59.089] Timer tick, asking Buildbucket for the build status
[22:45:59.213] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:59.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:86:0) after 1m0s
[22:46:59.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:86:0)
[22:46:59.286] Timer tick, asking Buildbucket for the build status
[22:46:59.479] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:59.479] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:87:0) after 1m0s
[22:47:59.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:87:0)
[22:47:59.562] Timer tick, asking Buildbucket for the build status
[22:47:59.663] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:59.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:88:0) after 1m0s
[22:48:59.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:88:0)
[22:48:59.662] Timer tick, asking Buildbucket for the build status
[22:48:59.940] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:59.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:89:0) after 1m0s
[22:49:59.962] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:89:0)
[22:49:59.962] Timer tick, asking Buildbucket for the build status
[22:50:00.466] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:00.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:90:0) after 1m0s
[22:51:00.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:90:0)
[22:51:00.576] Timer tick, asking Buildbucket for the build status
[22:51:00.713] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:00.713] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:91:0) after 1m0s
[22:52:00.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:91:0)
[22:52:00.909] Timer tick, asking Buildbucket for the build status
[22:52:01.385] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:01.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:92:0) after 1m0s
[22:53:01.445] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:92:0)
[22:53:01.445] Timer tick, asking Buildbucket for the build status
[22:53:01.590] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:01.590] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:93:0) after 1m0s
[22:54:01.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:93:0)
[22:54:01.813] Timer tick, asking Buildbucket for the build status
[22:54:01.928] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:01.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:94:0) after 1m0s
[22:55:01.993] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:94:0)
[22:55:01.993] Timer tick, asking Buildbucket for the build status
[22:55:02.115] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:02.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:95:0) after 1m0s
[22:56:02.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:95:0)
[22:56:02.144] Timer tick, asking Buildbucket for the build status
[22:56:02.315] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:02.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:96:0) after 1m0s
[22:57:02.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:96:0)
[22:57:02.419] Timer tick, asking Buildbucket for the build status
[22:57:02.553] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:02.553] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:97:0) after 1m0s
[22:58:02.802] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:97:0)
[22:58:02.802] Timer tick, asking Buildbucket for the build status
[22:58:03.024] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:03.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:98:0) after 1m0s
[22:59:03.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:98:0)
[22:59:03.390] Timer tick, asking Buildbucket for the build status
[22:59:03.683] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:03.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:99:0) after 1m0s
[23:00:03.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:99:0)
[23:00:03.813] Timer tick, asking Buildbucket for the build status
[23:00:04.115] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:04.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:100:0) after 1m0s
[23:01:04.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:100:0)
[23:01:04.219] Timer tick, asking Buildbucket for the build status
[23:01:04.474] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:04.474] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:101:0) after 1m0s
[23:02:04.778] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:101:0)
[23:02:04.781] Timer tick, asking Buildbucket for the build status
[23:02:04.955] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:04.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:102:0) after 1m0s
[23:03:05.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:102:0)
[23:03:05.028] Timer tick, asking Buildbucket for the build status
[23:03:05.250] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:05.250] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:103:0) after 1m0s
[23:04:05.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:103:0)
[23:04:05.406] Timer tick, asking Buildbucket for the build status
[23:04:05.539] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:05.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:104:0) after 1m0s
[23:05:05.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:104:0)
[23:05:05.597] Timer tick, asking Buildbucket for the build status
[23:05:05.892] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:05.892] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:105:0) after 1m0s
[23:06:06.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:105:0)
[23:06:06.025] Timer tick, asking Buildbucket for the build status
[23:06:06.164] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:06.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:106:0) after 1m0s
[23:07:06.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:106:0)
[23:07:06.311] Timer tick, asking Buildbucket for the build status
[23:07:06.474] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:06.474] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:107:0) after 1m0s
[23:08:06.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:107:0)
[23:08:06.617] Timer tick, asking Buildbucket for the build status
[23:08:06.968] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:06.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:108:0) after 1m0s
[23:09:07.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:108:0)
[23:09:07.188] Timer tick, asking Buildbucket for the build status
[23:09:07.554] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:07.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:109:0) after 1m0s
[23:10:07.645] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:109:0)
[23:10:07.645] Timer tick, asking Buildbucket for the build status
[23:10:07.980] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:07.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:110:0) after 1m0s
[23:11:08.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:110:0)
[23:11:08.004] Timer tick, asking Buildbucket for the build status
[23:11:08.130] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:08.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:111:0) after 1m0s
[23:12:08.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:111:0)
[23:12:08.173] Timer tick, asking Buildbucket for the build status
[23:12:08.452] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:08.452] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:112:0) after 1m0s
[23:13:08.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:112:0)
[23:13:08.567] Timer tick, asking Buildbucket for the build status
[23:13:08.694] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:08.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:113:0) after 1m0s
[23:14:08.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:113:0)
[23:14:08.717] Timer tick, asking Buildbucket for the build status
[23:14:08.864] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:08.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:114:0) after 1m0s
[23:15:08.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:114:0)
[23:15:08.893] Timer tick, asking Buildbucket for the build status
[23:15:09.093] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:09.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:115:0) after 1m0s
[23:16:09.146] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:115:0)
[23:16:09.146] Timer tick, asking Buildbucket for the build status
[23:16:09.262] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:09.262] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:116:0) after 1m0s
[23:17:09.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:116:0)
[23:17:09.285] Timer tick, asking Buildbucket for the build status
[23:17:09.565] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:09.565] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:117:0) after 1m0s
[23:18:09.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:117:0)
[23:18:09.592] Timer tick, asking Buildbucket for the build status
[23:18:09.970] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:09.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:118:0) after 1m0s
[23:19:10.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:118:0)
[23:19:10.007] Timer tick, asking Buildbucket for the build status
[23:19:11.797] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:11.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:119:0) after 1m0s
[23:20:11.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:119:0)
[23:20:11.853] Timer tick, asking Buildbucket for the build status
[23:20:11.998] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:11.998] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:120:0) after 1m0s
[23:21:12.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:120:0)
[23:21:12.032] Timer tick, asking Buildbucket for the build status
[23:21:12.192] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:12.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:121:0) after 1m0s
[23:22:12.217] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:121:0)
[23:22:12.217] Timer tick, asking Buildbucket for the build status
[23:22:12.350] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:12.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:122:0) after 1m0s
[23:23:12.360] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:122:0)
[23:23:12.360] Timer tick, asking Buildbucket for the build status
[23:23:12.531] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:12.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:123:0) after 1m0s
[23:24:12.556] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:123:0)
[23:24:12.556] Timer tick, asking Buildbucket for the build status
[23:24:12.712] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:12.712] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:124:0) after 1m0s
[23:25:12.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:124:0)
[23:25:12.794] Timer tick, asking Buildbucket for the build status
[23:25:12.900] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:12.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:125:0) after 1m0s
[23:26:12.925] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:125:0)
[23:26:12.925] Timer tick, asking Buildbucket for the build status
[23:26:13.052] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:13.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:126:0) after 1m0s
[23:27:13.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:126:0)
[23:27:13.251] Timer tick, asking Buildbucket for the build status
[23:27:13.360] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:13.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:127:0) after 1m0s
[23:28:13.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:127:0)
[23:28:13.608] Timer tick, asking Buildbucket for the build status
[23:28:13.760] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:13.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:128:0) after 1m0s
[23:29:13.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:128:0)
[23:29:13.880] Timer tick, asking Buildbucket for the build status
[23:29:13.987] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:13.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:129:0) after 1m0s
[23:30:14.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:129:0)
[23:30:14.016] Timer tick, asking Buildbucket for the build status
[23:30:14.184] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:14.184] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:130:0) after 1m0s
[23:31:14.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:130:0)
[23:31:14.290] Timer tick, asking Buildbucket for the build status
[23:31:14.499] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:14.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:131:0) after 1m0s
[23:32:14.661] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:131:0)
[23:32:14.661] Timer tick, asking Buildbucket for the build status
[23:32:14.807] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:14.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:132:0) after 1m0s
[23:33:14.890] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:132:0)
[23:33:14.890] Timer tick, asking Buildbucket for the build status
[23:33:15.462] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:15.463] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:133:0) after 1m0s
[23:34:15.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:133:0)
[23:34:15.449] Timer tick, asking Buildbucket for the build status
[23:34:15.574] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:15.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:134:0) after 1m0s
[23:35:15.599] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:134:0)
[23:35:15.599] Timer tick, asking Buildbucket for the build status
[23:35:15.734] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:15.734] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:135:0) after 1m0s
[23:36:15.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:135:0)
[23:36:15.758] Timer tick, asking Buildbucket for the build status
[23:36:15.929] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:15.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:136:0) after 1m0s
[23:37:15.953] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:136:0)
[23:37:15.953] Timer tick, asking Buildbucket for the build status
[23:37:16.295] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:16.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:137:0) after 1m0s
[23:38:16.302] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:137:0)
[23:38:16.302] Timer tick, asking Buildbucket for the build status
[23:38:16.484] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:16.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:138:0) after 1m0s
[23:39:16.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:138:0)
[23:39:16.567] Timer tick, asking Buildbucket for the build status
[23:39:17.128] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:17.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:139:0) after 1m0s
[23:40:17.161] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:139:0)
[23:40:17.161] Timer tick, asking Buildbucket for the build status
[23:40:17.299] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:17.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:140:0) after 1m0s
[23:41:17.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:140:0)
[23:41:17.310] Timer tick, asking Buildbucket for the build status
[23:41:17.426] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:17.426] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:141:0) after 1m0s
[23:42:17.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:141:0)
[23:42:17.613] Timer tick, asking Buildbucket for the build status
[23:42:17.821] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:17.821] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:142:0) after 1m0s
[23:43:18.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:142:0)
[23:43:18.027] Timer tick, asking Buildbucket for the build status
[23:43:18.205] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:18.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:143:0) after 1m0s
[23:44:18.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:143:0)
[23:44:18.194] Timer tick, asking Buildbucket for the build status
[23:44:18.471] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:18.471] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:144:0) after 1m0s
[23:45:18.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:144:0)
[23:45:18.454] Timer tick, asking Buildbucket for the build status
[23:45:18.647] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:18.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:145:0) after 1m0s
[23:46:18.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:145:0)
[23:46:18.691] Timer tick, asking Buildbucket for the build status
[23:46:18.813] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:18.813] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:146:0) after 1m0s
[23:47:18.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:146:0)
[23:47:18.858] Timer tick, asking Buildbucket for the build status
[23:47:18.992] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:18.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:147:0) after 1m0s
[23:48:19.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:147:0)
[23:48:19.032] Timer tick, asking Buildbucket for the build status
[23:48:19.523] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:19.523] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:148:0) after 1m0s
[23:49:19.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:148:0)
[23:49:19.519] Timer tick, asking Buildbucket for the build status
[23:49:19.648] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:19.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:149:0) after 1m0s
[23:50:19.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:149:0)
[23:50:19.675] Timer tick, asking Buildbucket for the build status
[23:50:19.820] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:19.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:150:0) after 1m0s
[23:51:19.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:150:0)
[23:51:19.892] Timer tick, asking Buildbucket for the build status
[23:51:19.993] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:19.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:151:0) after 1m0s
[23:52:20.057] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:151:0)
[23:52:20.057] Timer tick, asking Buildbucket for the build status
[23:52:20.325] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:20.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:152:0) after 1m0s
[23:53:20.373] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:152:0)
[23:53:20.373] Timer tick, asking Buildbucket for the build status
[23:53:20.920] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:20.920] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:153:0) after 1m0s
[23:54:21.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:153:0)
[23:54:21.109] Timer tick, asking Buildbucket for the build status
[23:54:21.401] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:21.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:154:0) after 1m0s
[23:55:21.427] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:154:0)
[23:55:21.427] Timer tick, asking Buildbucket for the build status
[23:55:21.634] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:21.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:155:0) after 1m0s
[23:56:21.673] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:155:0)
[23:56:21.673] Timer tick, asking Buildbucket for the build status
[23:56:21.808] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:21.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:156:0) after 1m0s
[23:57:21.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:156:0)
[23:57:21.894] Timer tick, asking Buildbucket for the build status
[23:57:22.033] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:22.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:157:0) after 1m0s
[23:58:22.066] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:157:0)
[23:58:22.066] Timer tick, asking Buildbucket for the build status
[23:58:22.196] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:22.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:158:0) after 1m0s
[23:59:22.199] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:158:0)
[23:59:22.199] Timer tick, asking Buildbucket for the build status
[23:59:22.422] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:22.422] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:159:0) after 1m0s
[00:00:22.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:159:0)
[00:00:22.453] Timer tick, asking Buildbucket for the build status
[00:00:22.902] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:22.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:160:0) after 1m0s
[00:01:22.963] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:160:0)
[00:01:22.963] Timer tick, asking Buildbucket for the build status
[00:01:23.270] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:23.270] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:161:0) after 1m0s
[00:02:23.267] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:161:0)
[00:02:23.267] Timer tick, asking Buildbucket for the build status
[00:02:23.453] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:23.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:162:0) after 1m0s
[00:03:23.543] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:162:0)
[00:03:23.543] Timer tick, asking Buildbucket for the build status
[00:03:23.720] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:23.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:163:0) after 1m0s
[00:04:23.756] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:163:0)
[00:04:23.756] Timer tick, asking Buildbucket for the build status
[00:04:23.952] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:23.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:164:0) after 1m0s
[00:05:23.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:164:0)
[00:05:23.986] Timer tick, asking Buildbucket for the build status
[00:05:24.148] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:24.148] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:165:0) after 1m0s
[00:06:24.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:165:0)
[00:06:24.246] Timer tick, asking Buildbucket for the build status
[00:06:24.441] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:24.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:166:0) after 1m0s
[00:07:24.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:166:0)
[00:07:24.539] Timer tick, asking Buildbucket for the build status
[00:07:24.931] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:24.931] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:167:0) after 1m0s
[00:08:25.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:167:0)
[00:08:25.009] Timer tick, asking Buildbucket for the build status
[00:08:25.305] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:25.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:168:0) after 1m0s
[00:09:25.509] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:168:0)
[00:09:25.509] Timer tick, asking Buildbucket for the build status
[00:09:25.641] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:25.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:169:0) after 1m0s
[00:10:25.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:169:0)
[00:10:25.758] Timer tick, asking Buildbucket for the build status
[00:10:25.984] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:25.984] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:170:0) after 1m0s
[00:11:26.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:170:0)
[00:11:26.087] Timer tick, asking Buildbucket for the build status
[00:11:26.200] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:26.200] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:171:0) after 1m0s
[00:12:26.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:171:0)
[00:12:26.211] Timer tick, asking Buildbucket for the build status
[00:12:26.351] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:26.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:172:0) after 1m0s
[00:13:26.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:172:0)
[00:13:26.385] Timer tick, asking Buildbucket for the build status
[00:13:26.683] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:26.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:173:0) after 1m0s
[00:14:26.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:173:0)
[00:14:26.772] Timer tick, asking Buildbucket for the build status
[00:14:27.174] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:27.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:174:0) after 1m0s
[00:15:27.212] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:174:0)
[00:15:27.212] Timer tick, asking Buildbucket for the build status
[00:15:27.387] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:27.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:175:0) after 1m0s
[00:16:27.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:175:0)
[00:16:27.411] Timer tick, asking Buildbucket for the build status
[00:16:27.516] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:27.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:176:0) after 1m0s
[00:17:27.569] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:176:0)
[00:17:27.569] Timer tick, asking Buildbucket for the build status
[00:17:27.736] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:27.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:177:0) after 1m0s
[00:18:27.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:177:0)
[00:18:27.804] Timer tick, asking Buildbucket for the build status
[00:18:27.927] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:27.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:178:0) after 1m0s
[00:19:27.915] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:178:0)
[00:19:27.915] Timer tick, asking Buildbucket for the build status
[00:19:28.124] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:28.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:179:0) after 1m0s
[00:20:28.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:179:0)
[00:20:28.264] Timer tick, asking Buildbucket for the build status
[00:20:28.630] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:28.630] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:180:0) after 1m0s
[00:21:28.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:180:0)
[00:21:28.852] Timer tick, asking Buildbucket for the build status
[00:21:28.981] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:28.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:181:0) after 1m0s
[00:22:29.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:181:0)
[00:22:29.155] Timer tick, asking Buildbucket for the build status
[00:22:29.601] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:29.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:182:0) after 1m0s
[00:23:29.776] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:182:0)
[00:23:29.776] Timer tick, asking Buildbucket for the build status
[00:23:29.884] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:29.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:183:0) after 1m0s
[00:24:30.013] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:183:0)
[00:24:30.013] Timer tick, asking Buildbucket for the build status
[00:24:30.308] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:30.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:184:0) after 1m0s
[00:25:30.420] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:184:0)
[00:25:30.420] Timer tick, asking Buildbucket for the build status
[00:25:30.948] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:30.949] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:185:0) after 1m0s
[00:26:31.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:185:0)
[00:26:31.028] Timer tick, asking Buildbucket for the build status
[00:26:31.410] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:31.410] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:186:0) after 1m0s
[00:27:31.746] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:186:0)
[00:27:31.746] Timer tick, asking Buildbucket for the build status
[00:27:33.568] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:33.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:187:0) after 1m0s
[00:28:33.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:187:0)
[00:28:33.637] Timer tick, asking Buildbucket for the build status
[00:28:33.752] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:33.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:188:0) after 1m0s
[00:29:33.838] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:188:0)
[00:29:33.838] Timer tick, asking Buildbucket for the build status
[00:29:33.968] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:33.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:189:0) after 1m0s
[00:30:34.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:189:0)
[00:30:34.035] Timer tick, asking Buildbucket for the build status
[00:30:34.447] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:34.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:190:0) after 1m0s
[00:31:34.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:190:0)
[00:31:34.603] Timer tick, asking Buildbucket for the build status
[00:31:35.192] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:35.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:191:0) after 1m0s
[00:32:35.272] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:191:0)
[00:32:35.272] Timer tick, asking Buildbucket for the build status
[00:32:35.563] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:35.563] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:192:0) after 1m0s
[00:33:35.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:192:0)
[00:33:35.675] Timer tick, asking Buildbucket for the build status
[00:33:35.820] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:35.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:193:0) after 1m0s
[00:34:35.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:193:0)
[00:34:35.945] Timer tick, asking Buildbucket for the build status
[00:34:36.048] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:36.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:194:0) after 1m0s
[00:35:36.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:194:0)
[00:35:36.260] Timer tick, asking Buildbucket for the build status
[00:35:36.495] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:36.495] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:195:0) after 1m0s
[00:36:36.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:195:0)
[00:36:36.578] Timer tick, asking Buildbucket for the build status
[00:36:37.033] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:37.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:196:0) after 1m0s
[00:37:37.181] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:196:0)
[00:37:37.181] Timer tick, asking Buildbucket for the build status
[00:37:39.981] Build 8875670791580297456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:39.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9041100853544459280:197:0) after 1m0s
[00:38:20.429] Received PubSub notification, asking Buildbucket for the build status
[00:38:20.488] Build 8875670791580297456: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:38:20.488] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1593909497690052",
    "created_by": "project:chromium",
    "created_ts": "1593897747400216",
    "id": "8875670791580297456",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"797d696d9e823a736f1cb97d38538c361b314f9c\"}}",
    "project": "chromium",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-rjvv\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 16777, \"got_angle_revision\": \"07193df66c664ecb79b1ec8897018d6db99b7541\", \"got_dawn_revision\": \"59ccb1f6de17ac15a45374acd4cef997e190e8f8\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"797d696d9e823a736f1cb97d38538c361b314f9c\", \"got_revision_cp\": \"refs/heads/master@{#785193}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"3121585acce20f5cc2074088563e3c1a076b8e48\", \"got_v8_revision\": \"6889ecb5b8e7f63eea1ef6f7e79d64f0ef3d175c\", \"got_v8_revision_cp\": \"refs/heads/8.6.57@{#1}\", \"got_webrtc_revision\": \"62032d45924e9faeb27568009c83cc49ad068bd3\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31628}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"797d696d9e823a736f1cb97d38538c361b314f9c\"}, \"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\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-rjvv\"], \"image\": [\"chrome-win10-1703-20052900-58250aa4257\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5320-752003c\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1593898059196763",
    "status": "COMPLETED",
    "status_changed_ts": "1593909498229168",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/16777",
      "builder:Windows deterministic",
      "buildset:commit/git/797d696d9e823a736f1cb97d38538c361b314f9c",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/797d696d9e823a736f1cb97d38538c361b314f9c",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9041100853544459280",
      "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/8875670791580297456/+/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:4d34870f630ebe10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1593909498242570",
    "url": "https://ci.chromium.org/b/8875670791580297456",
    "utcnow_ts": "1593909500479399"
  }
}
[00:38:20.488] Invocation finished in 3h15m54.344262711s with status SUCCEEDED