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

• 680b71dd244450173ae5ed438c52d21d80b20741 (5 years ago)
• 6e0d80982b496ed3f5495371fab9dcd306a7ebc4 (5 years ago)
• d7a4e30e867a23a245bd6c70d77782c1555a4d35 (5 years ago)
• a9b4cca988427c74330d7b248161220b1847023b (5 years ago)
• 99ac0e33b641424f584649e3b316e7e30397672c (5 years ago)
• 4d5cafc7deff1f70e4f8abc2411d320744b9e7d9 (5 years ago)
• c9ad67223cf0190b85df0e2ae89dfff83fc2614f (5 years ago)
• 9b0e63f98a449d96f3bc28f2062a7e6188fc4e0e (5 years ago)
• 49b81f91559748b2313ae42e566f2ae78d855165 (5 years ago)
• ae477eb16d25a2cc4d86ea601014882b220f05c6 (5 years ago)
• 8e9c65f3c1d6eb6b1d41c75551c03d8020d49434 (5 years ago)
• 4aeb0799c6402b81aabf2ed388ca503695f460df (5 years ago)
• c5b054fe78046b4ec485e9040bb0ceb169c5ff49 (5 years ago)

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

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

[11:59:50.269] New invocation is queued and will start shortly
[11:59:51.347] Starting the invocation (attempt 1)
[11:59:51.409] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:59:51.409] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:59:51.409] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9022745064982441488",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c5b054fe78046b4ec485e9040bb0ceb169c5ff49\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9022745064982441488",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/c5b054fe78046b4ec485e9040bb0ceb169c5ff49",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c5b054fe78046b4ec485e9040bb0ceb169c5ff49",
    "gitiles_ref:refs/heads/master"
  ]
}
[11:59:52.273] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1611403191567935",
    "id": "8857315002957633904",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c5b054fe78046b4ec485e9040bb0ceb169c5ff49\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1611403192103153",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1444",
      "builder:win-official",
      "buildset:commit/git/c5b054fe78046b4ec485e9040bb0ceb169c5ff49",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c5b054fe78046b4ec485e9040bb0ceb169c5ff49",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9022745064982441488",
      "scheduler_job_id:chromium/win-official",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857315002957633904/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:recipe_name:chromium",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1611403192103300",
    "url": "https://ci.chromium.org/b/8857315002957633904",
    "utcnow_ts": "1611403192258433"
  }
}
[11:59:52.273] Task URL: https://ci.chromium.org/b/8857315002957633904
[11:59:52.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:2:0) after 1m0s
[12:00:41.891] Received PubSub notification, asking Buildbucket for the build status
[12:00:42.074] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:52.318] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:2:0)
[12:00:52.318] Timer tick, asking Buildbucket for the build status
[12:00:52.439] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:52.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:4:0) after 1m0s
[12:01:52.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:4:0)
[12:01:52.457] Timer tick, asking Buildbucket for the build status
[12:01:52.679] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:52.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:5:0) after 1m0s
[12:02:52.842] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:5:0)
[12:02:52.842] Timer tick, asking Buildbucket for the build status
[12:02:52.909] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:52.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:6:0) after 1m0s
[12:03:53.183] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:6:0)
[12:03:53.183] Timer tick, asking Buildbucket for the build status
[12:03:53.264] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:53.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:7:0) after 1m0s
[12:04:53.413] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:7:0)
[12:04:53.413] Timer tick, asking Buildbucket for the build status
[12:04:53.480] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:53.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:8:0) after 1m0s
[12:05:53.645] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:8:0)
[12:05:53.645] Timer tick, asking Buildbucket for the build status
[12:05:53.785] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:53.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:9:0) after 1m0s
[12:06:53.869] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:9:0)
[12:06:53.869] Timer tick, asking Buildbucket for the build status
[12:06:53.944] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:53.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:10:0) after 1m0s
[12:07:53.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:10:0)
[12:07:53.997] Timer tick, asking Buildbucket for the build status
[12:07:54.084] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:54.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:11:0) after 1m0s
[12:08:54.091] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:11:0)
[12:08:54.091] Timer tick, asking Buildbucket for the build status
[12:08:54.192] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:54.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:12:0) after 1m0s
[12:09:54.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:12:0)
[12:09:54.252] Timer tick, asking Buildbucket for the build status
[12:09:54.431] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:54.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:13:0) after 1m0s
[12:10:54.465] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:13:0)
[12:10:54.465] Timer tick, asking Buildbucket for the build status
[12:10:54.564] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:54.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:14:0) after 1m0s
[12:11:54.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:14:0)
[12:11:54.658] Timer tick, asking Buildbucket for the build status
[12:11:55.023] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:55.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:15:0) after 1m0s
[12:12:55.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:15:0)
[12:12:55.133] Timer tick, asking Buildbucket for the build status
[12:12:55.217] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:55.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:16:0) after 1m0s
[12:13:55.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:16:0)
[12:13:55.331] Timer tick, asking Buildbucket for the build status
[12:13:55.657] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:55.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:17:0) after 1m0s
[12:14:55.695] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:17:0)
[12:14:55.695] Timer tick, asking Buildbucket for the build status
[12:14:55.835] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:55.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:18:0) after 1m0s
[12:15:55.859] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:18:0)
[12:15:55.859] Timer tick, asking Buildbucket for the build status
[12:15:56.140] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:56.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:19:0) after 1m0s
[12:16:56.201] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:19:0)
[12:16:56.201] Timer tick, asking Buildbucket for the build status
[12:16:56.297] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:56.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:20:0) after 1m0s
[12:17:56.383] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:20:0)
[12:17:56.383] Timer tick, asking Buildbucket for the build status
[12:17:56.472] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:56.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:21:0) after 1m0s
[12:18:56.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:21:0)
[12:18:56.633] Timer tick, asking Buildbucket for the build status
[12:18:56.694] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:56.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:22:0) after 1m0s
[12:19:56.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:22:0)
[12:19:56.866] Timer tick, asking Buildbucket for the build status
[12:19:56.954] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:56.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:23:0) after 1m0s
[12:20:56.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:23:0)
[12:20:56.965] Timer tick, asking Buildbucket for the build status
[12:20:57.303] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:57.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:24:0) after 1m0s
[12:21:57.321] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:24:0)
[12:21:57.321] Timer tick, asking Buildbucket for the build status
[12:21:57.464] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:57.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:25:0) after 1m0s
[12:22:57.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:25:0)
[12:22:57.494] Timer tick, asking Buildbucket for the build status
[12:22:57.589] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:57.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:26:0) after 1m0s
[12:23:57.644] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:26:0)
[12:23:57.644] Timer tick, asking Buildbucket for the build status
[12:23:57.747] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:57.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:27:0) after 1m0s
[12:24:57.800] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:27:0)
[12:24:57.800] Timer tick, asking Buildbucket for the build status
[12:24:58.025] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:58.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:28:0) after 1m0s
[12:25:58.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:28:0)
[12:25:58.044] Timer tick, asking Buildbucket for the build status
[12:25:58.516] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:58.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:29:0) after 1m0s
[12:26:58.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:29:0)
[12:26:58.542] Timer tick, asking Buildbucket for the build status
[12:26:58.630] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:58.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:30:0) after 1m0s
[12:27:58.663] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:30:0)
[12:27:58.663] Timer tick, asking Buildbucket for the build status
[12:27:58.751] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:58.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:31:0) after 1m0s
[12:28:58.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:31:0)
[12:28:58.784] Timer tick, asking Buildbucket for the build status
[12:28:58.985] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:58.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:32:0) after 1m0s
[12:29:59.011] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:32:0)
[12:29:59.011] Timer tick, asking Buildbucket for the build status
[12:29:59.513] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:59.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:33:0) after 1m0s
[12:30:59.571] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:33:0)
[12:30:59.571] Timer tick, asking Buildbucket for the build status
[12:30:59.674] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:59.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:34:0) after 1m0s
[12:31:59.703] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:34:0)
[12:31:59.703] Timer tick, asking Buildbucket for the build status
[12:31:59.769] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:59.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:35:0) after 1m0s
[12:32:59.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:35:0)
[12:32:59.807] Timer tick, asking Buildbucket for the build status
[12:32:59.865] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:59.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:36:0) after 1m0s
[12:33:59.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:36:0)
[12:33:59.974] Timer tick, asking Buildbucket for the build status
[12:34:00.205] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:00.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:37:0) after 1m0s
[12:35:00.462] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:37:0)
[12:35:00.462] Timer tick, asking Buildbucket for the build status
[12:35:00.532] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:00.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:38:0) after 1m0s
[12:36:00.521] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:38:0)
[12:36:00.521] Timer tick, asking Buildbucket for the build status
[12:36:00.743] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:00.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:39:0) after 1m0s
[12:37:00.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:39:0)
[12:37:00.970] Timer tick, asking Buildbucket for the build status
[12:37:01.058] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:01.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:40:0) after 1m0s
[12:38:01.262] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:40:0)
[12:38:01.262] Timer tick, asking Buildbucket for the build status
[12:38:01.440] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:01.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:41:0) after 1m0s
[12:39:01.543] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:41:0)
[12:39:01.543] Timer tick, asking Buildbucket for the build status
[12:39:01.662] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:01.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:42:0) after 1m0s
[12:40:01.708] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:42:0)
[12:40:01.708] Timer tick, asking Buildbucket for the build status
[12:40:01.994] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:01.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:43:0) after 1m0s
[12:41:02.028] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:43:0)
[12:41:02.028] Timer tick, asking Buildbucket for the build status
[12:41:02.136] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:02.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:44:0) after 1m0s
[12:42:02.156] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:44:0)
[12:42:02.156] Timer tick, asking Buildbucket for the build status
[12:42:02.218] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:02.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:45:0) after 1m0s
[12:43:02.269] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:45:0)
[12:43:02.270] Timer tick, asking Buildbucket for the build status
[12:43:02.344] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:02.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:46:0) after 1m0s
[12:44:02.432] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:46:0)
[12:44:02.433] Timer tick, asking Buildbucket for the build status
[12:44:02.546] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:02.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:47:0) after 1m0s
[12:45:02.614] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:47:0)
[12:45:02.614] Timer tick, asking Buildbucket for the build status
[12:45:02.690] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:02.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:48:0) after 1m0s
[12:46:02.705] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:48:0)
[12:46:02.705] Timer tick, asking Buildbucket for the build status
[12:46:02.830] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:02.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:49:0) after 1m0s
[12:47:02.848] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:49:0)
[12:47:02.848] Timer tick, asking Buildbucket for the build status
[12:47:02.962] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:02.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:50:0) after 1m0s
[12:48:02.993] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:50:0)
[12:48:02.993] Timer tick, asking Buildbucket for the build status
[12:48:03.051] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:03.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:51:0) after 1m0s
[12:49:03.269] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:51:0)
[12:49:03.269] Timer tick, asking Buildbucket for the build status
[12:49:03.516] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:03.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:52:0) after 1m0s
[12:50:03.564] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:52:0)
[12:50:03.564] Timer tick, asking Buildbucket for the build status
[12:50:03.891] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:03.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:53:0) after 1m0s
[12:51:04.029] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:53:0)
[12:51:04.029] Timer tick, asking Buildbucket for the build status
[12:51:04.136] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:04.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:54:0) after 1m0s
[12:52:04.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:54:0)
[12:52:04.234] Timer tick, asking Buildbucket for the build status
[12:52:04.286] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:04.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:55:0) after 1m0s
[12:53:04.383] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:55:0)
[12:53:04.383] Timer tick, asking Buildbucket for the build status
[12:53:04.438] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:04.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:56:0) after 1m0s
[12:54:04.562] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:56:0)
[12:54:04.562] Timer tick, asking Buildbucket for the build status
[12:54:04.689] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:04.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:57:0) after 1m0s
[12:55:04.783] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:57:0)
[12:55:04.783] Timer tick, asking Buildbucket for the build status
[12:55:05.050] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:05.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:58:0) after 1m0s
[12:56:05.126] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:58:0)
[12:56:05.126] Timer tick, asking Buildbucket for the build status
[12:56:05.204] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:05.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:59:0) after 1m0s
[12:57:05.339] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:59:0)
[12:57:05.339] Timer tick, asking Buildbucket for the build status
[12:57:05.438] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:05.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:60:0) after 1m0s
[12:58:05.523] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:60:0)
[12:58:05.523] Timer tick, asking Buildbucket for the build status
[12:58:05.583] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:05.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:61:0) after 1m0s
[12:59:05.706] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:61:0)
[12:59:05.706] Timer tick, asking Buildbucket for the build status
[12:59:05.770] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:05.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:62:0) after 1m0s
[13:00:06.009] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:62:0)
[13:00:06.009] Timer tick, asking Buildbucket for the build status
[13:00:06.141] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:06.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:63:0) after 1m0s
[13:01:06.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:63:0)
[13:01:06.777] Timer tick, asking Buildbucket for the build status
[13:01:06.881] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:06.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:64:0) after 1m0s
[13:02:06.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:64:0)
[13:02:06.965] Timer tick, asking Buildbucket for the build status
[13:02:07.065] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:07.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:65:0) after 1m0s
[13:03:07.107] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:65:0)
[13:03:07.107] Timer tick, asking Buildbucket for the build status
[13:03:07.390] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:07.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:66:0) after 1m0s
[13:04:07.503] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:66:0)
[13:04:07.503] Timer tick, asking Buildbucket for the build status
[13:04:07.721] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:07.721] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:67:0) after 1m0s
[13:05:07.774] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:67:0)
[13:05:07.774] Timer tick, asking Buildbucket for the build status
[13:05:08.162] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:08.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:68:0) after 1m0s
[13:06:08.290] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:68:0)
[13:06:08.290] Timer tick, asking Buildbucket for the build status
[13:06:08.374] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:08.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:69:0) after 1m0s
[13:07:08.419] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:69:0)
[13:07:08.419] Timer tick, asking Buildbucket for the build status
[13:07:08.486] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:08.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:70:0) after 1m0s
[13:08:08.572] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:70:0)
[13:08:08.572] Timer tick, asking Buildbucket for the build status
[13:08:08.645] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:08.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:71:0) after 1m0s
[13:09:08.686] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:71:0)
[13:09:08.686] Timer tick, asking Buildbucket for the build status
[13:09:09.001] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:09.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:72:0) after 1m0s
[13:10:09.075] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:72:0)
[13:10:09.075] Timer tick, asking Buildbucket for the build status
[13:10:09.441] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:09.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:73:0) after 1m0s
[13:11:09.564] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:73:0)
[13:11:09.564] Timer tick, asking Buildbucket for the build status
[13:11:09.823] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:09.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:74:0) after 1m0s
[13:12:09.859] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:74:0)
[13:12:09.859] Timer tick, asking Buildbucket for the build status
[13:12:09.922] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:09.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:75:0) after 1m0s
[13:13:09.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:75:0)
[13:13:09.970] Timer tick, asking Buildbucket for the build status
[13:13:10.021] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:10.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:76:0) after 1m0s
[13:14:10.043] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:76:0)
[13:14:10.043] Timer tick, asking Buildbucket for the build status
[13:14:10.117] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:10.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:77:0) after 1m0s
[13:15:10.191] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:77:0)
[13:15:10.191] Timer tick, asking Buildbucket for the build status
[13:15:10.360] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:10.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:78:0) after 1m0s
[13:16:10.416] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:78:0)
[13:16:10.416] Timer tick, asking Buildbucket for the build status
[13:16:10.501] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:10.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:79:0) after 1m0s
[13:17:10.521] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:79:0)
[13:17:10.521] Timer tick, asking Buildbucket for the build status
[13:17:10.580] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:10.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:80:0) after 1m0s
[13:18:10.605] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:80:0)
[13:18:10.605] Timer tick, asking Buildbucket for the build status
[13:18:10.906] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:10.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:81:0) after 1m0s
[13:19:10.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:81:0)
[13:19:10.935] Timer tick, asking Buildbucket for the build status
[13:19:10.990] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:10.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:82:0) after 1m0s
[13:20:11.033] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:82:0)
[13:20:11.033] Timer tick, asking Buildbucket for the build status
[13:20:11.592] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:11.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:83:0) after 1m0s
[13:21:11.637] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:83:0)
[13:21:11.637] Timer tick, asking Buildbucket for the build status
[13:21:11.704] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:11.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:84:0) after 1m0s
[13:22:11.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:84:0)
[13:22:11.793] Timer tick, asking Buildbucket for the build status
[13:22:11.862] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:11.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:85:0) after 1m0s
[13:23:11.957] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:85:0)
[13:23:11.957] Timer tick, asking Buildbucket for the build status
[13:23:12.048] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:12.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:86:0) after 1m0s
[13:24:12.131] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:86:0)
[13:24:12.131] Timer tick, asking Buildbucket for the build status
[13:24:12.197] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:12.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:87:0) after 1m0s
[13:25:12.228] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:87:0)
[13:25:12.228] Timer tick, asking Buildbucket for the build status
[13:25:12.632] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:12.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:88:0) after 1m0s
[13:26:12.646] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:88:0)
[13:26:12.646] Timer tick, asking Buildbucket for the build status
[13:26:12.739] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:12.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:89:0) after 1m0s
[13:27:12.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:89:0)
[13:27:12.746] Timer tick, asking Buildbucket for the build status
[13:27:12.810] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:12.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:90:0) after 1m0s
[13:28:12.864] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:90:0)
[13:28:12.864] Timer tick, asking Buildbucket for the build status
[13:28:12.947] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:12.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:91:0) after 1m0s
[13:29:12.994] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:91:0)
[13:29:12.994] Timer tick, asking Buildbucket for the build status
[13:29:13.124] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:13.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:92:0) after 1m0s
[13:30:13.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:92:0)
[13:30:13.162] Timer tick, asking Buildbucket for the build status
[13:30:13.269] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:13.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:93:0) after 1m0s
[13:31:13.307] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:93:0)
[13:31:13.307] Timer tick, asking Buildbucket for the build status
[13:31:13.367] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:13.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:94:0) after 1m0s
[13:32:13.390] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:94:0)
[13:32:13.390] Timer tick, asking Buildbucket for the build status
[13:32:13.568] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:13.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:95:0) after 1m0s
[13:33:13.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:95:0)
[13:33:13.731] Timer tick, asking Buildbucket for the build status
[13:33:13.900] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:13.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:96:0) after 1m0s
[13:34:13.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:96:0)
[13:34:13.935] Timer tick, asking Buildbucket for the build status
[13:34:14.000] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:14.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:97:0) after 1m0s
[13:35:14.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:97:0)
[13:35:14.099] Timer tick, asking Buildbucket for the build status
[13:35:14.222] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:14.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:98:0) after 1m0s
[13:36:14.351] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:98:0)
[13:36:14.351] Timer tick, asking Buildbucket for the build status
[13:36:14.408] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:14.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:99:0) after 1m0s
[13:37:14.503] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:99:0)
[13:37:14.503] Timer tick, asking Buildbucket for the build status
[13:37:14.553] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:14.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:100:0) after 1m0s
[13:38:14.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:100:0)
[13:38:14.633] Timer tick, asking Buildbucket for the build status
[13:38:14.792] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:14.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:101:0) after 1m0s
[13:39:14.841] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:101:0)
[13:39:14.841] Timer tick, asking Buildbucket for the build status
[13:39:14.893] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:14.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:102:0) after 1m0s
[13:40:15.021] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:102:0)
[13:40:15.021] Timer tick, asking Buildbucket for the build status
[13:40:15.148] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:15.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:103:0) after 1m0s
[13:41:15.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:103:0)
[13:41:15.234] Timer tick, asking Buildbucket for the build status
[13:41:15.308] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:15.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:104:0) after 1m0s
[13:42:15.360] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:104:0)
[13:42:15.360] Timer tick, asking Buildbucket for the build status
[13:42:15.511] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:15.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:105:0) after 1m0s
[13:43:15.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:105:0)
[13:43:15.536] Timer tick, asking Buildbucket for the build status
[13:43:15.771] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:15.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:106:0) after 1m0s
[13:44:15.843] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:106:0)
[13:44:15.843] Timer tick, asking Buildbucket for the build status
[13:44:15.897] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:15.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:107:0) after 1m0s
[13:45:15.943] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:107:0)
[13:45:15.943] Timer tick, asking Buildbucket for the build status
[13:45:16.597] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:16.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:108:0) after 1m0s
[13:46:16.673] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:108:0)
[13:46:16.673] Timer tick, asking Buildbucket for the build status
[13:46:16.762] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:16.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:109:0) after 1m0s
[13:47:16.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:109:0)
[13:47:16.916] Timer tick, asking Buildbucket for the build status
[13:47:17.124] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:17.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:110:0) after 1m0s
[13:48:18.266] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:110:0)
[13:48:18.266] Timer tick, asking Buildbucket for the build status
[13:48:18.506] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:18.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:111:0) after 1m0s
[13:49:18.523] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:111:0)
[13:49:18.523] Timer tick, asking Buildbucket for the build status
[13:49:18.581] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:18.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:112:0) after 1m0s
[13:50:18.911] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:112:0)
[13:50:18.911] Timer tick, asking Buildbucket for the build status
[13:50:19.205] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:19.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:113:0) after 1m0s
[13:51:19.288] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:113:0)
[13:51:19.288] Timer tick, asking Buildbucket for the build status
[13:51:19.488] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:19.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:114:0) after 1m0s
[13:52:19.624] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:114:0)
[13:52:19.624] Timer tick, asking Buildbucket for the build status
[13:52:19.716] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:19.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:115:0) after 1m0s
[13:53:19.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:115:0)
[13:53:19.794] Timer tick, asking Buildbucket for the build status
[13:53:19.881] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:19.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:116:0) after 1m0s
[13:54:19.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:116:0)
[13:54:19.933] Timer tick, asking Buildbucket for the build status
[13:54:20.133] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:20.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:117:0) after 1m0s
[13:55:20.154] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:117:0)
[13:55:20.154] Timer tick, asking Buildbucket for the build status
[13:55:20.332] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:20.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:118:0) after 1m0s
[13:56:20.411] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:118:0)
[13:56:20.411] Timer tick, asking Buildbucket for the build status
[13:56:20.507] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:20.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:119:0) after 1m0s
[13:57:20.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:119:0)
[13:57:20.563] Timer tick, asking Buildbucket for the build status
[13:57:20.677] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:20.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:120:0) after 1m0s
[13:58:21.138] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:120:0)
[13:58:21.138] Timer tick, asking Buildbucket for the build status
[13:58:21.187] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:21.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:121:0) after 1m0s
[13:59:21.349] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:121:0)
[13:59:21.349] Timer tick, asking Buildbucket for the build status
[13:59:21.489] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:21.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:122:0) after 1m0s
[14:00:21.644] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:122:0)
[14:00:21.644] Timer tick, asking Buildbucket for the build status
[14:00:21.760] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:21.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:123:0) after 1m0s
[14:01:21.908] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:123:0)
[14:01:21.908] Timer tick, asking Buildbucket for the build status
[14:01:21.991] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:21.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:124:0) after 1m0s
[14:02:22.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:124:0)
[14:02:22.064] Timer tick, asking Buildbucket for the build status
[14:02:22.230] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:22.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:125:0) after 1m0s
[14:03:22.298] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:125:0)
[14:03:22.298] Timer tick, asking Buildbucket for the build status
[14:03:22.367] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:22.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:126:0) after 1m0s
[14:04:22.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:126:0)
[14:04:22.618] Timer tick, asking Buildbucket for the build status
[14:04:22.700] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:22.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:127:0) after 1m0s
[14:05:22.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:127:0)
[14:05:22.831] Timer tick, asking Buildbucket for the build status
[14:05:22.938] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:22.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:128:0) after 1m0s
[14:06:23.106] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:128:0)
[14:06:23.106] Timer tick, asking Buildbucket for the build status
[14:06:23.182] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:23.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:129:0) after 1m0s
[14:07:23.576] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:129:0)
[14:07:23.576] Timer tick, asking Buildbucket for the build status
[14:07:23.646] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:23.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:130:0) after 1m0s
[14:08:23.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:130:0)
[14:08:23.717] Timer tick, asking Buildbucket for the build status
[14:08:23.800] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:23.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:131:0) after 1m0s
[14:09:23.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:131:0)
[14:09:23.873] Timer tick, asking Buildbucket for the build status
[14:09:24.306] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:24.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:132:0) after 1m0s
[14:10:24.360] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:132:0)
[14:10:24.360] Timer tick, asking Buildbucket for the build status
[14:10:25.035] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:25.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:133:0) after 1m0s
[14:11:25.060] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:133:0)
[14:11:25.060] Timer tick, asking Buildbucket for the build status
[14:11:25.129] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:25.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:134:0) after 1m0s
[14:12:25.192] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:134:0)
[14:12:25.192] Timer tick, asking Buildbucket for the build status
[14:12:25.253] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:25.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:135:0) after 1m0s
[14:13:25.273] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:135:0)
[14:13:25.274] Timer tick, asking Buildbucket for the build status
[14:13:25.340] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:25.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:136:0) after 1m0s
[14:14:25.364] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:136:0)
[14:14:25.364] Timer tick, asking Buildbucket for the build status
[14:14:25.486] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:25.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:137:0) after 1m0s
[14:15:25.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:137:0)
[14:15:25.542] Timer tick, asking Buildbucket for the build status
[14:15:25.678] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:25.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:138:0) after 1m0s
[14:16:25.693] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:138:0)
[14:16:25.693] Timer tick, asking Buildbucket for the build status
[14:16:25.775] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:25.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:139:0) after 1m0s
[14:17:25.860] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:139:0)
[14:17:25.860] Timer tick, asking Buildbucket for the build status
[14:17:25.924] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:25.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:140:0) after 1m0s
[14:18:25.917] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:140:0)
[14:18:25.917] Timer tick, asking Buildbucket for the build status
[14:18:26.027] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:26.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:141:0) after 1m0s
[14:19:26.129] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:141:0)
[14:19:26.129] Timer tick, asking Buildbucket for the build status
[14:19:26.291] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:26.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:142:0) after 1m0s
[14:20:26.352] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:142:0)
[14:20:26.352] Timer tick, asking Buildbucket for the build status
[14:20:26.527] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:26.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:143:0) after 1m0s
[14:21:26.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:143:0)
[14:21:26.586] Timer tick, asking Buildbucket for the build status
[14:21:26.795] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:26.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:144:0) after 1m0s
[14:22:26.902] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:144:0)
[14:22:26.902] Timer tick, asking Buildbucket for the build status
[14:22:27.029] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:27.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:145:0) after 1m0s
[14:23:27.065] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:145:0)
[14:23:27.065] Timer tick, asking Buildbucket for the build status
[14:23:27.136] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:27.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:146:0) after 1m0s
[14:24:27.163] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:146:0)
[14:24:27.163] Timer tick, asking Buildbucket for the build status
[14:24:27.279] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:27.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:147:0) after 1m0s
[14:25:27.325] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:147:0)
[14:25:27.325] Timer tick, asking Buildbucket for the build status
[14:25:27.603] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:27.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:148:0) after 1m0s
[14:26:27.643] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:148:0)
[14:26:27.643] Timer tick, asking Buildbucket for the build status
[14:26:27.753] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:27.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:149:0) after 1m0s
[14:27:27.761] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:149:0)
[14:27:27.761] Timer tick, asking Buildbucket for the build status
[14:27:27.826] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:27.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:150:0) after 1m0s
[14:28:27.891] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:150:0)
[14:28:27.891] Timer tick, asking Buildbucket for the build status
[14:28:27.967] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:27.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:151:0) after 1m0s
[14:29:28.087] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:151:0)
[14:29:28.087] Timer tick, asking Buildbucket for the build status
[14:29:28.157] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:28.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:152:0) after 1m0s
[14:30:28.231] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:152:0)
[14:30:28.231] Timer tick, asking Buildbucket for the build status
[14:30:28.340] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:28.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:153:0) after 1m0s
[14:31:28.400] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:153:0)
[14:31:28.400] Timer tick, asking Buildbucket for the build status
[14:31:28.485] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:28.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:154:0) after 1m0s
[14:32:28.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:154:0)
[14:32:28.511] Timer tick, asking Buildbucket for the build status
[14:32:28.564] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:28.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:155:0) after 1m0s
[14:33:28.611] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:155:0)
[14:33:28.611] Timer tick, asking Buildbucket for the build status
[14:33:28.674] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:28.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:156:0) after 1m0s
[14:34:28.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:156:0)
[14:34:28.717] Timer tick, asking Buildbucket for the build status
[14:34:28.895] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:28.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:157:0) after 1m0s
[14:35:28.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:157:0)
[14:35:28.939] Timer tick, asking Buildbucket for the build status
[14:35:29.050] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:29.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:158:0) after 1m0s
[14:36:29.103] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:158:0)
[14:36:29.103] Timer tick, asking Buildbucket for the build status
[14:36:29.175] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:29.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:159:0) after 1m0s
[14:37:29.204] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:159:0)
[14:37:29.204] Timer tick, asking Buildbucket for the build status
[14:37:29.261] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:29.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:160:0) after 1m0s
[14:38:29.300] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:160:0)
[14:38:29.300] Timer tick, asking Buildbucket for the build status
[14:38:29.376] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:29.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:161:0) after 1m0s
[14:39:29.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:161:0)
[14:39:29.434] Timer tick, asking Buildbucket for the build status
[14:39:29.537] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:29.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:162:0) after 1m0s
[14:40:29.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:162:0)
[14:40:29.602] Timer tick, asking Buildbucket for the build status
[14:40:29.894] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:29.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:163:0) after 1m0s
[14:41:29.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:163:0)
[14:41:29.995] Timer tick, asking Buildbucket for the build status
[14:41:30.053] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:30.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:164:0) after 1m0s
[14:42:30.106] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:164:0)
[14:42:30.106] Timer tick, asking Buildbucket for the build status
[14:42:30.456] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:30.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:165:0) after 1m0s
[14:43:30.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:165:0)
[14:43:30.527] Timer tick, asking Buildbucket for the build status
[14:43:30.906] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:30.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:166:0) after 1m0s
[14:44:30.940] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:166:0)
[14:44:30.940] Timer tick, asking Buildbucket for the build status
[14:44:30.995] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:30.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:167:0) after 1m0s
[14:45:31.089] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:167:0)
[14:45:31.089] Timer tick, asking Buildbucket for the build status
[14:45:31.194] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:31.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:168:0) after 1m0s
[14:46:31.237] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:168:0)
[14:46:31.237] Timer tick, asking Buildbucket for the build status
[14:46:31.312] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:31.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:169:0) after 1m0s
[14:47:31.341] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:169:0)
[14:47:31.341] Timer tick, asking Buildbucket for the build status
[14:47:31.625] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:31.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:170:0) after 1m0s
[14:48:31.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:170:0)
[14:48:31.662] Timer tick, asking Buildbucket for the build status
[14:48:31.924] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:31.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:171:0) after 1m0s
[14:49:31.981] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:171:0)
[14:49:31.981] Timer tick, asking Buildbucket for the build status
[14:49:32.116] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:32.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:172:0) after 1m0s
[14:50:32.149] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:172:0)
[14:50:32.149] Timer tick, asking Buildbucket for the build status
[14:50:32.266] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:32.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:173:0) after 1m0s
[14:51:32.345] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:173:0)
[14:51:32.345] Timer tick, asking Buildbucket for the build status
[14:51:32.419] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:32.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:174:0) after 1m0s
[14:52:32.459] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:174:0)
[14:52:32.459] Timer tick, asking Buildbucket for the build status
[14:52:32.535] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:32.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:175:0) after 1m0s
[14:53:32.608] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:175:0)
[14:53:32.608] Timer tick, asking Buildbucket for the build status
[14:53:33.420] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:33.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:176:0) after 1m0s
[14:54:33.446] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:176:0)
[14:54:33.446] Timer tick, asking Buildbucket for the build status
[14:54:33.596] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:33.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:177:0) after 1m0s
[14:55:33.681] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:177:0)
[14:55:33.681] Timer tick, asking Buildbucket for the build status
[14:55:33.795] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:33.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:178:0) after 1m0s
[14:56:33.928] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:178:0)
[14:56:33.928] Timer tick, asking Buildbucket for the build status
[14:56:34.038] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:34.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:179:0) after 1m0s
[14:57:34.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:179:0)
[14:57:34.114] Timer tick, asking Buildbucket for the build status
[14:57:34.269] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:34.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:180:0) after 1m0s
[14:58:34.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:180:0)
[14:58:34.315] Timer tick, asking Buildbucket for the build status
[14:58:34.385] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:34.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:181:0) after 1m0s
[14:59:34.448] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:181:0)
[14:59:34.448] Timer tick, asking Buildbucket for the build status
[14:59:34.552] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:34.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:182:0) after 1m0s
[15:00:34.584] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:182:0)
[15:00:34.584] Timer tick, asking Buildbucket for the build status
[15:00:34.745] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:34.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:183:0) after 1m0s
[15:01:34.778] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:183:0)
[15:01:34.778] Timer tick, asking Buildbucket for the build status
[15:01:34.867] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:34.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:184:0) after 1m0s
[15:02:34.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:184:0)
[15:02:34.899] Timer tick, asking Buildbucket for the build status
[15:02:34.964] Build 8857315002957633904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:34.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022745064982441488:185:0) after 1m0s
[15:02:36.295] Received PubSub notification, asking Buildbucket for the build status
[15:02:36.371] Build 8857315002957633904: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:02:36.371] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1611414150995193",
    "created_by": "project:chromium",
    "created_ts": "1611403191567935",
    "id": "8857315002957633904",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c5b054fe78046b4ec485e9040bb0ceb169c5ff49\"}}",
    "project": "chromium",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"c5b054fe78046b4ec485e9040bb0ceb169c5ff49\", \"project\": \"chromium/src\"}], \"$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\": \"win-dbg-8-fqoc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1444, \"got_angle_revision\": \"3c3b82abcf0a5c18b4d97ae49726045ce6d3b832\", \"got_dawn_revision\": \"f1f8394de04ea9532de763dfb2f968fc9610683b\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"c5b054fe78046b4ec485e9040bb0ceb169c5ff49\", \"got_revision_cp\": \"refs/heads/master@{#846509}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"413f7cb17c77c95e4cc3ba141f3c0f049ac2ecb2\", \"got_v8_revision\": \"f2b2f28304b332e59226ee6c0688307ed9982884\", \"got_v8_revision_cp\": \"refs/heads/9.0.57@{#1}\", \"got_webrtc_revision\": \"8c007fffead0f29650d6e34c10c85605e4dd33df\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33061}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c5b054fe78046b4ec485e9040bb0ceb169c5ff49\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-8-fqoc\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1611403241018407",
    "status": "COMPLETED",
    "status_changed_ts": "1611414155177921",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1444",
      "builder:win-official",
      "buildset:commit/git/c5b054fe78046b4ec485e9040bb0ceb169c5ff49",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c5b054fe78046b4ec485e9040bb0ceb169c5ff49",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9022745064982441488",
      "scheduler_job_id:chromium/win-official",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857315002957633904/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:os:Windows",
      "swarming_tag:recipe_name:chromium",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:5147eefe745d9b10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1611414155372277",
    "url": "https://ci.chromium.org/b/8857315002957633904",
    "utcnow_ts": "1611414156361130"
  }
}
[15:02:36.371] Invocation finished in 3h2m46.118658078s with status SUCCEEDED