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

• 83d4c857c2950f853cf6c34020e0682a91c42c43 (5 years ago)
• e3ea16502f108859ff6aa8ea8377e9a64c3b3d42 (5 years ago)
• 68c9202d8713bb5178274f7eb493c6c52e371d89 (5 years ago)
• 567dff5711e0edcf4bdeb6a3a2daf67cdef3d38b (5 years ago)
• 9a59079d0c66717ab523c60bfdaa83c58a2b2f57 (5 years ago)
• fb52be2f4cc0bcd14a661f15bbe19ffda15be374 (5 years ago)
• 294903a70f492a8164515f22a51889d27615bc52 (5 years ago)

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

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

[09:33:36.997] New invocation is queued and will start shortly
[09:33:38.140] Starting the invocation (attempt 1)
[09:33:38.171] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:33:38.173] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:33:38.173] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9021395309930234368",
  "parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"294903a70f492a8164515f22a51889d27615bc52\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win32-official",
    "scheduler_invocation_id:9021395309930234368",
    "scheduler_job_id:chromium/win32-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/294903a70f492a8164515f22a51889d27615bc52",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/294903a70f492a8164515f22a51889d27615bc52",
    "gitiles_ref:refs/heads/master"
  ]
}
[09:33:39.850] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1612690418805691",
    "id": "8855965247369074928",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"294903a70f492a8164515f22a51889d27615bc52\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1612690419629406",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/1506",
      "builder:win32-official",
      "buildset:commit/git/294903a70f492a8164515f22a51889d27615bc52",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/294903a70f492a8164515f22a51889d27615bc52",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021395309930234368",
      "scheduler_job_id:chromium/win32-official",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855965247369074928/+/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": "1612690419629575",
    "url": "https://ci.chromium.org/b/8855965247369074928",
    "utcnow_ts": "1612690419843794"
  }
}
[09:33:39.850] Task URL: https://ci.chromium.org/b/8855965247369074928
[09:33:39.850] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:2:0) after 1m0s
[09:34:20.154] Received PubSub notification, asking Buildbucket for the build status
[09:34:20.381] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:39.894] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:2:0)
[09:34:39.895] Timer tick, asking Buildbucket for the build status
[09:34:40.044] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:40.044] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:4:0) after 1m0s
[09:35:40.059] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:4:0)
[09:35:40.059] Timer tick, asking Buildbucket for the build status
[09:35:40.153] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:40.153] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:5:0) after 1m0s
[09:36:40.236] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:5:0)
[09:36:40.236] Timer tick, asking Buildbucket for the build status
[09:36:40.397] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:40.397] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:6:0) after 1m0s
[09:37:40.375] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:6:0)
[09:37:40.375] Timer tick, asking Buildbucket for the build status
[09:37:40.460] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:40.460] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:7:0) after 1m0s
[09:38:40.517] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:7:0)
[09:38:40.517] Timer tick, asking Buildbucket for the build status
[09:38:40.734] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:40.734] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:8:0) after 1m0s
[09:39:40.724] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:8:0)
[09:39:40.724] Timer tick, asking Buildbucket for the build status
[09:39:40.954] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:40.954] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:9:0) after 1m0s
[09:40:41.014] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:9:0)
[09:40:41.014] Timer tick, asking Buildbucket for the build status
[09:40:41.127] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:41.127] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:10:0) after 1m0s
[09:41:41.159] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:10:0)
[09:41:41.159] Timer tick, asking Buildbucket for the build status
[09:41:41.388] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:41.388] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:11:0) after 1m0s
[09:42:41.456] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:11:0)
[09:42:41.456] Timer tick, asking Buildbucket for the build status
[09:42:41.722] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:41.722] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:12:0) after 1m0s
[09:43:41.703] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:12:0)
[09:43:41.703] Timer tick, asking Buildbucket for the build status
[09:43:42.122] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:42.122] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:13:0) after 1m0s
[09:44:42.138] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:13:0)
[09:44:42.138] Timer tick, asking Buildbucket for the build status
[09:44:42.399] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:42.399] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:14:0) after 1m0s
[09:45:42.385] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:14:0)
[09:45:42.385] Timer tick, asking Buildbucket for the build status
[09:45:42.476] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:42.476] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:15:0) after 1m0s
[09:46:42.533] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:15:0)
[09:46:42.533] Timer tick, asking Buildbucket for the build status
[09:46:42.626] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:42.626] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:16:0) after 1m0s
[09:47:42.741] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:16:0)
[09:47:42.741] Timer tick, asking Buildbucket for the build status
[09:47:42.954] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:42.954] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:17:0) after 1m0s
[09:48:42.970] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:17:0)
[09:48:42.970] Timer tick, asking Buildbucket for the build status
[09:48:43.092] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:43.092] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:18:0) after 1m0s
[09:49:43.113] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:18:0)
[09:49:43.113] Timer tick, asking Buildbucket for the build status
[09:49:43.176] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:43.176] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:19:0) after 1m0s
[09:50:43.195] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:19:0)
[09:50:43.195] Timer tick, asking Buildbucket for the build status
[09:50:43.315] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:43.315] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:20:0) after 1m0s
[09:51:43.439] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:20:0)
[09:51:43.439] Timer tick, asking Buildbucket for the build status
[09:51:43.510] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:43.510] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:21:0) after 1m0s
[09:52:43.572] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:21:0)
[09:52:43.572] Timer tick, asking Buildbucket for the build status
[09:52:43.678] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:43.678] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:22:0) after 1m0s
[09:53:43.697] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:22:0)
[09:53:43.697] Timer tick, asking Buildbucket for the build status
[09:53:43.819] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:43.819] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:23:0) after 1m0s
[09:54:43.836] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:23:0)
[09:54:43.836] Timer tick, asking Buildbucket for the build status
[09:54:44.121] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:44.121] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:24:0) after 1m0s
[09:55:44.122] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:24:0)
[09:55:44.122] Timer tick, asking Buildbucket for the build status
[09:55:44.185] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:44.185] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:25:0) after 1m0s
[09:56:44.203] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:25:0)
[09:56:44.203] Timer tick, asking Buildbucket for the build status
[09:56:44.273] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:44.273] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:26:0) after 1m0s
[09:57:44.263] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:26:0)
[09:57:44.263] Timer tick, asking Buildbucket for the build status
[09:57:44.306] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:44.306] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:27:0) after 1m0s
[09:58:44.392] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:27:0)
[09:58:44.392] Timer tick, asking Buildbucket for the build status
[09:58:44.592] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:44.592] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:28:0) after 1m0s
[09:59:44.712] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:28:0)
[09:59:44.712] Timer tick, asking Buildbucket for the build status
[09:59:45.101] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:45.101] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:29:0) after 1m0s
[10:00:45.125] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:29:0)
[10:00:45.125] Timer tick, asking Buildbucket for the build status
[10:00:45.582] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:45.582] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:30:0) after 1m0s
[10:01:45.612] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:30:0)
[10:01:45.612] Timer tick, asking Buildbucket for the build status
[10:01:45.697] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:45.697] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:31:0) after 1m0s
[10:02:45.780] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:31:0)
[10:02:45.780] Timer tick, asking Buildbucket for the build status
[10:02:45.912] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:45.912] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:32:0) after 1m0s
[10:03:45.946] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:32:0)
[10:03:45.946] Timer tick, asking Buildbucket for the build status
[10:03:46.458] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:46.458] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:33:0) after 1m0s
[10:04:46.499] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:33:0)
[10:04:46.499] Timer tick, asking Buildbucket for the build status
[10:04:46.722] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:46.722] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:34:0) after 1m0s
[10:05:46.781] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:34:0)
[10:05:46.781] Timer tick, asking Buildbucket for the build status
[10:05:46.953] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:46.953] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:35:0) after 1m0s
[10:06:47.007] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:35:0)
[10:06:47.007] Timer tick, asking Buildbucket for the build status
[10:06:47.120] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:47.120] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:36:0) after 1m0s
[10:07:47.186] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:36:0)
[10:07:47.186] Timer tick, asking Buildbucket for the build status
[10:07:47.423] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:47.423] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:37:0) after 1m0s
[10:08:47.631] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:37:0)
[10:08:47.631] Timer tick, asking Buildbucket for the build status
[10:08:47.777] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:47.777] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:38:0) after 1m0s
[10:09:47.893] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:38:0)
[10:09:47.893] Timer tick, asking Buildbucket for the build status
[10:09:47.976] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:47.976] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:39:0) after 1m0s
[10:10:48.035] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:39:0)
[10:10:48.035] Timer tick, asking Buildbucket for the build status
[10:10:48.153] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:48.153] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:40:0) after 1m0s
[10:11:48.181] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:40:0)
[10:11:48.181] Timer tick, asking Buildbucket for the build status
[10:11:48.246] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:48.246] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:41:0) after 1m0s
[10:12:48.363] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:41:0)
[10:12:48.363] Timer tick, asking Buildbucket for the build status
[10:12:48.430] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:48.430] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:42:0) after 1m0s
[10:13:48.464] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:42:0)
[10:13:48.464] Timer tick, asking Buildbucket for the build status
[10:13:48.847] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:48.847] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:43:0) after 1m0s
[10:14:49.031] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:43:0)
[10:14:49.031] Timer tick, asking Buildbucket for the build status
[10:14:49.112] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:49.112] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:44:0) after 1m0s
[10:15:49.189] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:44:0)
[10:15:49.189] Timer tick, asking Buildbucket for the build status
[10:15:49.264] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:49.264] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:45:0) after 1m0s
[10:16:49.351] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:45:0)
[10:16:49.351] Timer tick, asking Buildbucket for the build status
[10:16:49.515] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:49.515] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:46:0) after 1m0s
[10:17:49.591] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:46:0)
[10:17:49.591] Timer tick, asking Buildbucket for the build status
[10:17:49.837] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:49.837] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:47:0) after 1m0s
[10:18:49.868] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:47:0)
[10:18:49.868] Timer tick, asking Buildbucket for the build status
[10:18:50.525] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:50.525] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:48:0) after 1m0s
[10:19:50.583] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:48:0)
[10:19:50.583] Timer tick, asking Buildbucket for the build status
[10:19:50.640] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:50.640] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:49:0) after 1m0s
[10:20:50.631] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:49:0)
[10:20:50.631] Timer tick, asking Buildbucket for the build status
[10:20:50.801] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:50.801] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:50:0) after 1m0s
[10:21:50.925] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:50:0)
[10:21:50.925] Timer tick, asking Buildbucket for the build status
[10:21:50.995] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:50.995] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:51:0) after 1m0s
[10:22:51.015] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:51:0)
[10:22:51.015] Timer tick, asking Buildbucket for the build status
[10:22:51.115] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:51.115] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:52:0) after 1m0s
[10:23:51.137] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:52:0)
[10:23:51.137] Timer tick, asking Buildbucket for the build status
[10:23:51.247] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:51.247] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:53:0) after 1m0s
[10:24:51.275] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:53:0)
[10:24:51.275] Timer tick, asking Buildbucket for the build status
[10:24:51.368] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:51.368] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:54:0) after 1m0s
[10:25:51.481] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:54:0)
[10:25:51.481] Timer tick, asking Buildbucket for the build status
[10:25:51.947] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:51.947] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:55:0) after 1m0s
[10:26:51.945] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:55:0)
[10:26:51.945] Timer tick, asking Buildbucket for the build status
[10:26:52.285] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:52.285] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:56:0) after 1m0s
[10:27:52.305] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:56:0)
[10:27:52.305] Timer tick, asking Buildbucket for the build status
[10:27:52.447] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:52.447] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:57:0) after 1m0s
[10:28:52.517] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:57:0)
[10:28:52.517] Timer tick, asking Buildbucket for the build status
[10:28:52.606] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:52.606] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:58:0) after 1m0s
[10:29:52.635] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:58:0)
[10:29:52.635] Timer tick, asking Buildbucket for the build status
[10:29:52.693] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:52.693] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:59:0) after 1m0s
[10:30:52.710] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:59:0)
[10:30:52.710] Timer tick, asking Buildbucket for the build status
[10:30:52.767] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:52.767] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:60:0) after 1m0s
[10:31:52.791] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:60:0)
[10:31:52.791] Timer tick, asking Buildbucket for the build status
[10:31:52.858] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:52.858] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:61:0) after 1m0s
[10:32:52.936] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:61:0)
[10:32:52.936] Timer tick, asking Buildbucket for the build status
[10:32:53.000] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:53.000] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:62:0) after 1m0s
[10:33:53.021] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:62:0)
[10:33:53.021] Timer tick, asking Buildbucket for the build status
[10:33:53.166] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:53.166] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:63:0) after 1m0s
[10:34:53.278] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:63:0)
[10:34:53.278] Timer tick, asking Buildbucket for the build status
[10:34:53.367] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:53.367] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:64:0) after 1m0s
[10:35:53.430] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:64:0)
[10:35:53.430] Timer tick, asking Buildbucket for the build status
[10:35:53.609] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:53.609] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:65:0) after 1m0s
[10:36:53.646] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:65:0)
[10:36:53.646] Timer tick, asking Buildbucket for the build status
[10:36:54.133] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:54.133] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:66:0) after 1m0s
[10:37:54.156] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:66:0)
[10:37:54.156] Timer tick, asking Buildbucket for the build status
[10:37:54.210] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:54.210] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:67:0) after 1m0s
[10:38:54.194] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:67:0)
[10:38:54.194] Timer tick, asking Buildbucket for the build status
[10:38:54.293] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:54.293] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:68:0) after 1m0s
[10:39:54.316] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:68:0)
[10:39:54.316] Timer tick, asking Buildbucket for the build status
[10:39:54.508] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:54.508] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:69:0) after 1m0s
[10:40:54.529] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:69:0)
[10:40:54.529] Timer tick, asking Buildbucket for the build status
[10:40:54.611] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:54.611] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:70:0) after 1m0s
[10:41:54.630] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:70:0)
[10:41:54.630] Timer tick, asking Buildbucket for the build status
[10:41:54.832] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:54.832] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:71:0) after 1m0s
[10:42:54.908] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:71:0)
[10:42:54.908] Timer tick, asking Buildbucket for the build status
[10:42:55.209] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:55.209] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:72:0) after 1m0s
[10:43:55.284] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:72:0)
[10:43:55.284] Timer tick, asking Buildbucket for the build status
[10:43:55.423] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:55.423] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:73:0) after 1m0s
[10:44:55.443] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:73:0)
[10:44:55.443] Timer tick, asking Buildbucket for the build status
[10:44:55.504] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:55.504] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:74:0) after 1m0s
[10:45:55.555] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:74:0)
[10:45:55.555] Timer tick, asking Buildbucket for the build status
[10:45:55.650] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:55.650] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:75:0) after 1m0s
[10:46:55.720] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:75:0)
[10:46:55.721] Timer tick, asking Buildbucket for the build status
[10:46:56.028] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:56.028] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:76:0) after 1m0s
[10:47:56.087] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:76:0)
[10:47:56.087] Timer tick, asking Buildbucket for the build status
[10:47:56.313] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:56.313] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:77:0) after 1m0s
[10:48:56.346] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:77:0)
[10:48:56.346] Timer tick, asking Buildbucket for the build status
[10:48:56.620] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:56.620] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:78:0) after 1m0s
[10:49:56.673] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:78:0)
[10:49:56.673] Timer tick, asking Buildbucket for the build status
[10:49:56.764] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:56.764] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:79:0) after 1m0s
[10:50:56.885] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:79:0)
[10:50:56.885] Timer tick, asking Buildbucket for the build status
[10:50:56.978] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:56.978] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:80:0) after 1m0s
[10:51:56.972] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:80:0)
[10:51:56.972] Timer tick, asking Buildbucket for the build status
[10:51:57.109] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:57.109] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:81:0) after 1m0s
[10:52:57.141] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:81:0)
[10:52:57.141] Timer tick, asking Buildbucket for the build status
[10:52:57.260] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:57.260] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:82:0) after 1m0s
[10:53:57.349] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:82:0)
[10:53:57.349] Timer tick, asking Buildbucket for the build status
[10:53:57.683] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:57.683] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:83:0) after 1m0s
[10:54:57.762] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:83:0)
[10:54:57.762] Timer tick, asking Buildbucket for the build status
[10:54:57.816] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:57.816] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:84:0) after 1m0s
[10:55:57.840] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:84:0)
[10:55:57.840] Timer tick, asking Buildbucket for the build status
[10:55:58.004] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:58.004] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:85:0) after 1m0s
[10:56:58.128] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:85:0)
[10:56:58.128] Timer tick, asking Buildbucket for the build status
[10:56:58.193] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:58.193] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:86:0) after 1m0s
[10:57:58.202] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:86:0)
[10:57:58.202] Timer tick, asking Buildbucket for the build status
[10:57:58.323] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:58.323] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:87:0) after 1m0s
[10:58:58.393] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:87:0)
[10:58:58.393] Timer tick, asking Buildbucket for the build status
[10:58:58.971] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:58.971] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:88:0) after 1m0s
[10:59:59.045] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:88:0)
[10:59:59.045] Timer tick, asking Buildbucket for the build status
[10:59:59.108] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:59.108] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:89:0) after 1m0s
[11:00:59.193] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:89:0)
[11:00:59.193] Timer tick, asking Buildbucket for the build status
[11:00:59.303] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:59.303] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:90:0) after 1m0s
[11:01:59.329] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:90:0)
[11:01:59.329] Timer tick, asking Buildbucket for the build status
[11:01:59.411] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:59.411] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:91:0) after 1m0s
[11:02:59.505] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:91:0)
[11:02:59.505] Timer tick, asking Buildbucket for the build status
[11:02:59.731] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:59.731] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:92:0) after 1m0s
[11:03:59.754] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:92:0)
[11:03:59.754] Timer tick, asking Buildbucket for the build status
[11:04:00.078] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:00.078] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:93:0) after 1m0s
[11:05:00.190] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:93:0)
[11:05:00.190] Timer tick, asking Buildbucket for the build status
[11:05:00.833] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:00.833] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:94:0) after 1m0s
[11:06:01.234] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:94:0)
[11:06:01.234] Timer tick, asking Buildbucket for the build status
[11:06:01.474] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:01.474] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:95:0) after 1m0s
[11:07:01.497] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:95:0)
[11:07:01.497] Timer tick, asking Buildbucket for the build status
[11:07:01.622] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:01.622] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:96:0) after 1m0s
[11:08:01.697] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:96:0)
[11:08:01.697] Timer tick, asking Buildbucket for the build status
[11:08:01.775] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:01.775] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:97:0) after 1m0s
[11:09:01.799] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:97:0)
[11:09:01.799] Timer tick, asking Buildbucket for the build status
[11:09:01.883] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:01.883] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:98:0) after 1m0s
[11:10:01.869] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:98:0)
[11:10:01.869] Timer tick, asking Buildbucket for the build status
[11:10:02.157] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:02.157] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:99:0) after 1m0s
[11:11:02.256] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:99:0)
[11:11:02.256] Timer tick, asking Buildbucket for the build status
[11:11:02.326] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:02.326] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:100:0) after 1m0s
[11:12:02.378] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:100:0)
[11:12:02.378] Timer tick, asking Buildbucket for the build status
[11:12:02.450] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:02.450] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:101:0) after 1m0s
[11:13:02.581] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:101:0)
[11:13:02.581] Timer tick, asking Buildbucket for the build status
[11:13:03.847] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:03.847] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:102:0) after 1m0s
[11:14:03.900] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:102:0)
[11:14:03.900] Timer tick, asking Buildbucket for the build status
[11:14:04.170] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:04.170] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:103:0) after 1m0s
[11:15:04.192] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:103:0)
[11:15:04.192] Timer tick, asking Buildbucket for the build status
[11:15:04.884] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:04.884] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:104:0) after 1m0s
[11:16:04.926] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:104:0)
[11:16:04.926] Timer tick, asking Buildbucket for the build status
[11:16:05.031] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:05.031] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:105:0) after 1m0s
[11:17:05.107] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:105:0)
[11:17:05.108] Timer tick, asking Buildbucket for the build status
[11:17:05.167] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:05.167] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:106:0) after 1m0s
[11:18:05.344] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:106:0)
[11:18:05.344] Timer tick, asking Buildbucket for the build status
[11:18:05.611] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:05.611] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:107:0) after 1m0s
[11:19:05.816] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:107:0)
[11:19:05.816] Timer tick, asking Buildbucket for the build status
[11:19:05.933] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:05.933] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:108:0) after 1m0s
[11:20:06.199] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:108:0)
[11:20:06.199] Timer tick, asking Buildbucket for the build status
[11:20:06.600] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:06.600] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:109:0) after 1m0s
[11:21:07.064] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:109:0)
[11:21:07.064] Timer tick, asking Buildbucket for the build status
[11:21:07.144] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:07.144] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:110:0) after 1m0s
[11:22:07.243] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:110:0)
[11:22:07.243] Timer tick, asking Buildbucket for the build status
[11:22:07.581] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:07.581] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:111:0) after 1m0s
[11:23:07.681] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:111:0)
[11:23:07.681] Timer tick, asking Buildbucket for the build status
[11:23:07.818] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:07.818] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:112:0) after 1m0s
[11:24:07.927] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:112:0)
[11:24:07.927] Timer tick, asking Buildbucket for the build status
[11:24:08.042] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:08.042] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:113:0) after 1m0s
[11:25:08.314] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:113:0)
[11:25:08.314] Timer tick, asking Buildbucket for the build status
[11:25:08.653] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:08.653] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:114:0) after 1m0s
[11:26:08.732] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:114:0)
[11:26:08.732] Timer tick, asking Buildbucket for the build status
[11:26:08.952] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:08.952] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:115:0) after 1m0s
[11:27:08.946] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:115:0)
[11:27:08.946] Timer tick, asking Buildbucket for the build status
[11:27:09.117] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:09.117] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:116:0) after 1m0s
[11:28:09.244] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:116:0)
[11:28:09.244] Timer tick, asking Buildbucket for the build status
[11:28:09.366] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:09.366] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:117:0) after 1m0s
[11:29:09.394] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:117:0)
[11:29:09.394] Timer tick, asking Buildbucket for the build status
[11:29:09.515] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:09.515] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:118:0) after 1m0s
[11:30:09.550] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:118:0)
[11:30:09.550] Timer tick, asking Buildbucket for the build status
[11:30:09.905] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:09.905] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:119:0) after 1m0s
[11:31:09.925] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:119:0)
[11:31:09.926] Timer tick, asking Buildbucket for the build status
[11:31:10.226] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:10.226] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:120:0) after 1m0s
[11:32:10.252] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:120:0)
[11:32:10.252] Timer tick, asking Buildbucket for the build status
[11:32:10.353] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:10.353] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:121:0) after 1m0s
[11:33:10.477] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:121:0)
[11:33:10.477] Timer tick, asking Buildbucket for the build status
[11:33:10.545] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:10.545] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:122:0) after 1m0s
[11:34:10.790] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:122:0)
[11:34:10.790] Timer tick, asking Buildbucket for the build status
[11:34:11.112] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:11.112] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:123:0) after 1m0s
[11:35:11.288] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:123:0)
[11:35:11.288] Timer tick, asking Buildbucket for the build status
[11:35:11.403] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:11.403] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:124:0) after 1m0s
[11:36:12.111] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:124:0)
[11:36:12.111] Timer tick, asking Buildbucket for the build status
[11:36:12.232] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:12.232] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:125:0) after 1m0s
[11:37:12.313] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:125:0)
[11:37:12.313] Timer tick, asking Buildbucket for the build status
[11:37:12.381] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:12.381] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:126:0) after 1m0s
[11:38:12.403] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:126:0)
[11:38:12.403] Timer tick, asking Buildbucket for the build status
[11:38:12.488] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:12.488] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:127:0) after 1m0s
[11:39:12.588] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:127:0)
[11:39:12.588] Timer tick, asking Buildbucket for the build status
[11:39:12.769] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:12.769] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:128:0) after 1m0s
[11:40:12.831] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:128:0)
[11:40:12.831] Timer tick, asking Buildbucket for the build status
[11:40:12.949] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:12.949] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:129:0) after 1m0s
[11:41:12.979] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:129:0)
[11:41:12.979] Timer tick, asking Buildbucket for the build status
[11:41:13.134] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:13.134] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:130:0) after 1m0s
[11:42:13.132] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:130:0)
[11:42:13.132] Timer tick, asking Buildbucket for the build status
[11:42:13.190] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:13.190] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:131:0) after 1m0s
[11:43:13.214] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:131:0)
[11:43:13.214] Timer tick, asking Buildbucket for the build status
[11:43:13.405] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:13.405] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:132:0) after 1m0s
[11:44:13.581] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:132:0)
[11:44:13.581] Timer tick, asking Buildbucket for the build status
[11:44:13.716] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:13.716] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:133:0) after 1m0s
[11:45:13.841] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:133:0)
[11:45:13.841] Timer tick, asking Buildbucket for the build status
[11:45:13.993] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:13.993] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:134:0) after 1m0s
[11:46:13.994] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:134:0)
[11:46:13.994] Timer tick, asking Buildbucket for the build status
[11:46:14.053] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:14.053] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:135:0) after 1m0s
[11:47:14.471] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:135:0)
[11:47:14.471] Timer tick, asking Buildbucket for the build status
[11:47:14.603] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:14.603] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:136:0) after 1m0s
[11:48:14.724] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:136:0)
[11:48:14.724] Timer tick, asking Buildbucket for the build status
[11:48:14.832] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:14.832] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:137:0) after 1m0s
[11:49:15.039] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:137:0)
[11:49:15.039] Timer tick, asking Buildbucket for the build status
[11:49:15.425] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:15.425] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:138:0) after 1m0s
[11:50:15.490] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:138:0)
[11:50:15.490] Timer tick, asking Buildbucket for the build status
[11:50:15.545] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:15.545] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:139:0) after 1m0s
[11:51:15.634] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:139:0)
[11:51:15.635] Timer tick, asking Buildbucket for the build status
[11:51:15.691] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:15.691] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:140:0) after 1m0s
[11:52:15.825] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:140:0)
[11:52:15.825] Timer tick, asking Buildbucket for the build status
[11:52:15.881] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:15.881] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:141:0) after 1m0s
[11:53:16.130] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:141:0)
[11:53:16.130] Timer tick, asking Buildbucket for the build status
[11:53:16.427] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:16.427] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:142:0) after 1m0s
[11:54:16.695] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:142:0)
[11:54:16.695] Timer tick, asking Buildbucket for the build status
[11:54:16.805] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:16.805] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:143:0) after 1m0s
[11:55:16.901] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:143:0)
[11:55:16.901] Timer tick, asking Buildbucket for the build status
[11:55:16.967] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:16.967] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:144:0) after 1m0s
[11:56:17.087] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:144:0)
[11:56:17.087] Timer tick, asking Buildbucket for the build status
[11:56:17.159] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:17.159] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:145:0) after 1m0s
[11:57:17.233] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:145:0)
[11:57:17.233] Timer tick, asking Buildbucket for the build status
[11:57:17.325] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:17.325] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:146:0) after 1m0s
[11:58:17.361] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:146:0)
[11:58:17.361] Timer tick, asking Buildbucket for the build status
[11:58:17.437] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:17.437] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:147:0) after 1m0s
[11:59:17.462] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:147:0)
[11:59:17.462] Timer tick, asking Buildbucket for the build status
[11:59:17.707] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:17.707] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:148:0) after 1m0s
[12:00:17.785] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:148:0)
[12:00:17.785] Timer tick, asking Buildbucket for the build status
[12:00:18.139] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:18.139] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:149:0) after 1m0s
[12:01:18.167] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:149:0)
[12:01:18.167] Timer tick, asking Buildbucket for the build status
[12:01:18.591] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:18.591] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:150:0) after 1m0s
[12:02:18.665] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:150:0)
[12:02:18.665] Timer tick, asking Buildbucket for the build status
[12:02:18.757] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:18.757] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:151:0) after 1m0s
[12:03:18.784] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:151:0)
[12:03:18.784] Timer tick, asking Buildbucket for the build status
[12:03:18.854] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:18.854] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:152:0) after 1m0s
[12:04:18.971] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:152:0)
[12:04:18.971] Timer tick, asking Buildbucket for the build status
[12:04:19.056] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:19.056] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:153:0) after 1m0s
[12:05:19.396] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:153:0)
[12:05:19.396] Timer tick, asking Buildbucket for the build status
[12:05:19.455] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:19.455] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:154:0) after 1m0s
[12:06:19.708] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:154:0)
[12:06:19.708] Timer tick, asking Buildbucket for the build status
[12:06:19.790] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:19.790] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:155:0) after 1m0s
[12:07:20.018] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:155:0)
[12:07:20.018] Timer tick, asking Buildbucket for the build status
[12:07:20.299] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:20.299] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:156:0) after 1m0s
[12:08:20.516] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:156:0)
[12:08:20.516] Timer tick, asking Buildbucket for the build status
[12:08:20.643] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:20.643] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:157:0) after 1m0s
[12:09:20.710] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:157:0)
[12:09:20.710] Timer tick, asking Buildbucket for the build status
[12:09:22.260] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:22.260] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:158:0) after 1m0s
[12:10:22.566] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:158:0)
[12:10:22.566] Timer tick, asking Buildbucket for the build status
[12:10:22.661] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:22.661] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:159:0) after 1m0s
[12:11:22.808] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:159:0)
[12:11:22.808] Timer tick, asking Buildbucket for the build status
[12:11:22.934] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:22.934] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:160:0) after 1m0s
[12:12:23.196] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:160:0)
[12:12:23.196] Timer tick, asking Buildbucket for the build status
[12:12:23.517] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:23.517] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:161:0) after 1m0s
[12:13:23.966] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:161:0)
[12:13:23.966] Timer tick, asking Buildbucket for the build status
[12:13:24.072] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:24.072] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:162:0) after 1m0s
[12:14:24.112] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:162:0)
[12:14:24.112] Timer tick, asking Buildbucket for the build status
[12:14:24.229] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:24.229] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:163:0) after 1m0s
[12:15:24.373] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:163:0)
[12:15:24.373] Timer tick, asking Buildbucket for the build status
[12:15:24.644] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:24.644] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:164:0) after 1m0s
[12:16:24.700] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:164:0)
[12:16:24.700] Timer tick, asking Buildbucket for the build status
[12:16:24.764] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:24.764] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:165:0) after 1m0s
[12:17:24.825] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:165:0)
[12:17:24.825] Timer tick, asking Buildbucket for the build status
[12:17:25.227] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:25.227] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:166:0) after 1m0s
[12:18:25.386] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:166:0)
[12:18:25.386] Timer tick, asking Buildbucket for the build status
[12:18:25.501] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:25.501] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:167:0) after 1m0s
[12:19:25.652] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:167:0)
[12:19:25.652] Timer tick, asking Buildbucket for the build status
[12:19:25.946] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:25.946] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:168:0) after 1m0s
[12:20:26.130] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:168:0)
[12:20:26.130] Timer tick, asking Buildbucket for the build status
[12:20:26.188] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:26.189] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:169:0) after 1m0s
[12:21:26.201] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:169:0)
[12:21:26.201] Timer tick, asking Buildbucket for the build status
[12:21:26.624] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:26.624] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:170:0) after 1m0s
[12:22:26.856] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:170:0)
[12:22:26.856] Timer tick, asking Buildbucket for the build status
[12:22:27.016] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:27.016] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:171:0) after 1m0s
[12:23:27.194] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:171:0)
[12:23:27.194] Timer tick, asking Buildbucket for the build status
[12:23:27.290] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:27.290] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:172:0) after 1m0s
[12:24:27.374] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:172:0)
[12:24:27.374] Timer tick, asking Buildbucket for the build status
[12:24:27.531] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:27.531] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:173:0) after 1m0s
[12:25:27.606] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:173:0)
[12:25:27.606] Timer tick, asking Buildbucket for the build status
[12:25:27.918] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:27.918] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:174:0) after 1m0s
[12:26:28.370] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:174:0)
[12:26:28.370] Timer tick, asking Buildbucket for the build status
[12:26:28.421] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:28.421] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:175:0) after 1m0s
[12:27:28.496] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:175:0)
[12:27:28.496] Timer tick, asking Buildbucket for the build status
[12:27:28.556] Build 8855965247369074928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:28.556] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021395309930234368:176:0) after 1m0s
[12:27:44.997] Received PubSub notification, asking Buildbucket for the build status
[12:27:45.414] Build 8855965247369074928: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:27:45.414] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1612700864322030",
    "created_by": "project:chromium",
    "created_ts": "1612690418805691",
    "id": "8855965247369074928",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"294903a70f492a8164515f22a51889d27615bc52\"}}",
    "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\": \"294903a70f492a8164515f22a51889d27615bc52\", \"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-4-lrbu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1506, \"got_angle_revision\": \"580961fbb01984d2d9b2f382609f9fc0c44e6b82\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"294903a70f492a8164515f22a51889d27615bc52\", \"got_revision_cp\": \"refs/heads/master@{#851527}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"266614a36dbd5328a9079ea6bbef9026c7bbe3d7\", \"got_v8_revision\": \"462378addab907ab7452d38baccb27fe2ef7289a\", \"got_v8_revision_cp\": \"refs/heads/9.0.138@{#1}\", \"got_webrtc_revision\": \"d42413a4b4636422ba5ea66ba40e7d24fb64f9b1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33183}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"294903a70f492a8164515f22a51889d27615bc52\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-4-lrbu\"], \"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\": [\"5676-c76598c\"], \"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": "1612690459096148",
    "status": "COMPLETED",
    "status_changed_ts": "1612700864609730",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/1506",
      "builder:win32-official",
      "buildset:commit/git/294903a70f492a8164515f22a51889d27615bc52",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/294903a70f492a8164515f22a51889d27615bc52",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021395309930234368",
      "scheduler_job_id:chromium/win32-official",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855965247369074928/+/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:5194a87b0cdcab10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1612700864651239",
    "url": "https://ci.chromium.org/b/8855965247369074928",
    "utcnow_ts": "1612700865393067"
  }
}
[12:27:45.414] Invocation finished in 2h54m8.434610526s with status SUCCEEDED