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

• b03f591cab107e0d2cc6c11b94030784f1d7d0e6 (5 years ago)
• aff33dcce47e0920875b5ccb44d35aaacc0b94d7 (5 years ago)
• 7ba9440cee169ee2d1aef0a5a090e55cbb8be578 (5 years ago)
• 4bf38882f2794c7ae93a729ce5ccaeb71fa7c162 (5 years ago)

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

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

[02:35:40.275] New invocation is queued and will start shortly
[02:35:41.448] Starting the invocation (attempt 1)
[02:35:41.482] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:35:41.482] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:35:41.482] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9028397571189417392",
  "parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4bf38882f2794c7ae93a729ce5ccaeb71fa7c162\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win32-official",
    "scheduler_invocation_id:9028397571189417392",
    "scheduler_job_id:chromium/win32-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/4bf38882f2794c7ae93a729ce5ccaeb71fa7c162",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4bf38882f2794c7ae93a729ce5ccaeb71fa7c162",
    "gitiles_ref:refs/heads/master"
  ]
}
[02:35:42.106] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1606012541569216",
    "id": "8862967509170024240",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4bf38882f2794c7ae93a729ce5ccaeb71fa7c162\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1606012542003576",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/971",
      "builder:win32-official",
      "buildset:commit/git/4bf38882f2794c7ae93a729ce5ccaeb71fa7c162",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4bf38882f2794c7ae93a729ce5ccaeb71fa7c162",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9028397571189417392",
      "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/8862967509170024240/+/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": "1606012542003710",
    "url": "https://ci.chromium.org/b/8862967509170024240",
    "utcnow_ts": "1606012542098228"
  }
}
[02:35:42.106] Task URL: https://ci.chromium.org/b/8862967509170024240
[02:35:42.106] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:2:0) after 1m0s
[02:36:42.283] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:2:0)
[02:36:42.283] Timer tick, asking Buildbucket for the build status
[02:36:42.552] Build 8862967509170024240: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:42.552] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:3:0) after 1m0s
[02:37:18.003] Received PubSub notification, asking Buildbucket for the build status
[02:37:18.117] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:42.601] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:3:0)
[02:37:42.601] Timer tick, asking Buildbucket for the build status
[02:37:42.678] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:42.678] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:5:0) after 1m0s
[02:38:42.777] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:5:0)
[02:38:42.777] Timer tick, asking Buildbucket for the build status
[02:38:42.871] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:42.871] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:6:0) after 1m0s
[02:39:42.904] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:6:0)
[02:39:42.904] Timer tick, asking Buildbucket for the build status
[02:39:42.976] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:42.976] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:7:0) after 1m0s
[02:40:43.053] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:7:0)
[02:40:43.053] Timer tick, asking Buildbucket for the build status
[02:40:43.177] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:43.177] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:8:0) after 1m0s
[02:41:43.257] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:8:0)
[02:41:43.257] Timer tick, asking Buildbucket for the build status
[02:41:43.342] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:43.342] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:9:0) after 1m0s
[02:42:43.508] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:9:0)
[02:42:43.508] Timer tick, asking Buildbucket for the build status
[02:42:43.597] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:43.597] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:10:0) after 1m0s
[02:43:43.848] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:10:0)
[02:43:43.848] Timer tick, asking Buildbucket for the build status
[02:43:43.923] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:43.923] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:11:0) after 1m0s
[02:44:44.050] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:11:0)
[02:44:44.050] Timer tick, asking Buildbucket for the build status
[02:44:44.129] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:44.129] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:12:0) after 1m0s
[02:45:44.239] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:12:0)
[02:45:44.239] Timer tick, asking Buildbucket for the build status
[02:45:44.629] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:44.629] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:13:0) after 1m0s
[02:46:44.857] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:13:0)
[02:46:44.857] Timer tick, asking Buildbucket for the build status
[02:46:45.343] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:45.343] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:14:0) after 1m0s
[02:47:45.418] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:14:0)
[02:47:45.418] Timer tick, asking Buildbucket for the build status
[02:47:46.797] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:46.797] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:15:0) after 1m0s
[02:48:46.959] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:15:0)
[02:48:46.959] Timer tick, asking Buildbucket for the build status
[02:48:47.058] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:47.058] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:16:0) after 1m0s
[02:49:47.165] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:16:0)
[02:49:47.165] Timer tick, asking Buildbucket for the build status
[02:49:47.400] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:47.400] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:17:0) after 1m0s
[02:50:47.459] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:17:0)
[02:50:47.459] Timer tick, asking Buildbucket for the build status
[02:50:47.569] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:47.569] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:18:0) after 1m0s
[02:51:47.797] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:18:0)
[02:51:47.797] Timer tick, asking Buildbucket for the build status
[02:51:47.887] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:47.887] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:19:0) after 1m0s
[02:52:48.010] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:19:0)
[02:52:48.010] Timer tick, asking Buildbucket for the build status
[02:52:48.088] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:48.088] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:20:0) after 1m0s
[02:53:48.225] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:20:0)
[02:53:48.225] Timer tick, asking Buildbucket for the build status
[02:53:48.371] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:48.371] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:21:0) after 1m0s
[02:54:48.500] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:21:0)
[02:54:48.500] Timer tick, asking Buildbucket for the build status
[02:54:48.559] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:48.559] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:22:0) after 1m0s
[02:55:48.645] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:22:0)
[02:55:48.645] Timer tick, asking Buildbucket for the build status
[02:55:48.747] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:48.747] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:23:0) after 1m0s
[02:56:48.986] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:23:0)
[02:56:48.986] Timer tick, asking Buildbucket for the build status
[02:56:49.047] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:49.047] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:24:0) after 1m0s
[02:57:49.251] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:24:0)
[02:57:49.251] Timer tick, asking Buildbucket for the build status
[02:57:49.322] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:49.322] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:25:0) after 1m0s
[02:58:49.619] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:25:0)
[02:58:49.619] Timer tick, asking Buildbucket for the build status
[02:58:49.693] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:49.693] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:26:0) after 1m0s
[02:59:49.915] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:26:0)
[02:59:49.915] Timer tick, asking Buildbucket for the build status
[02:59:49.979] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:49.979] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:27:0) after 1m0s
[03:00:50.083] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:27:0)
[03:00:50.083] Timer tick, asking Buildbucket for the build status
[03:00:50.281] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:50.281] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:28:0) after 1m0s
[03:01:50.478] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:28:0)
[03:01:50.478] Timer tick, asking Buildbucket for the build status
[03:01:50.944] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:50.944] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:29:0) after 1m0s
[03:02:51.098] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:29:0)
[03:02:51.098] Timer tick, asking Buildbucket for the build status
[03:02:51.159] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:51.159] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:30:0) after 1m0s
[03:03:54.734] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:30:0)
[03:03:54.734] Timer tick, asking Buildbucket for the build status
[03:03:54.861] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:54.861] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:31:0) after 1m0s
[03:04:54.849] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:31:0)
[03:04:54.849] Timer tick, asking Buildbucket for the build status
[03:04:55.757] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:55.757] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:32:0) after 1m0s
[03:05:55.812] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:32:0)
[03:05:55.812] Timer tick, asking Buildbucket for the build status
[03:05:55.920] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:55.920] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:33:0) after 1m0s
[03:06:55.942] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:33:0)
[03:06:55.942] Timer tick, asking Buildbucket for the build status
[03:06:56.224] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:56.224] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:34:0) after 1m0s
[03:07:56.274] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:34:0)
[03:07:56.274] Timer tick, asking Buildbucket for the build status
[03:07:56.352] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:56.352] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:35:0) after 1m0s
[03:08:56.361] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:35:0)
[03:08:56.362] Timer tick, asking Buildbucket for the build status
[03:08:56.425] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:56.425] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:36:0) after 1m0s
[03:09:56.414] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:36:0)
[03:09:56.414] Timer tick, asking Buildbucket for the build status
[03:09:56.595] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:56.595] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:37:0) after 1m0s
[03:10:56.620] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:37:0)
[03:10:56.620] Timer tick, asking Buildbucket for the build status
[03:10:57.121] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:57.121] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:38:0) after 1m0s
[03:11:57.188] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:38:0)
[03:11:57.188] Timer tick, asking Buildbucket for the build status
[03:11:57.312] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:57.312] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:39:0) after 1m0s
[03:12:57.388] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:39:0)
[03:12:57.388] Timer tick, asking Buildbucket for the build status
[03:12:57.471] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:57.471] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:40:0) after 1m0s
[03:13:57.490] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:40:0)
[03:13:57.490] Timer tick, asking Buildbucket for the build status
[03:13:57.620] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:57.620] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:41:0) after 1m0s
[03:14:57.619] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:41:0)
[03:14:57.619] Timer tick, asking Buildbucket for the build status
[03:14:57.688] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:57.689] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:42:0) after 1m0s
[03:15:57.709] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:42:0)
[03:15:57.709] Timer tick, asking Buildbucket for the build status
[03:15:58.062] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:58.062] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:43:0) after 1m0s
[03:16:58.070] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:43:0)
[03:16:58.070] Timer tick, asking Buildbucket for the build status
[03:16:58.424] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:58.424] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:44:0) after 1m0s
[03:17:58.526] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:44:0)
[03:17:58.526] Timer tick, asking Buildbucket for the build status
[03:17:58.922] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:58.922] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:45:0) after 1m0s
[03:18:59.003] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:45:0)
[03:18:59.003] Timer tick, asking Buildbucket for the build status
[03:18:59.479] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:59.479] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:46:0) after 1m0s
[03:19:59.578] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:46:0)
[03:19:59.578] Timer tick, asking Buildbucket for the build status
[03:20:00.001] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:00.001] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:47:0) after 1m0s
[03:21:00.065] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:47:0)
[03:21:00.066] Timer tick, asking Buildbucket for the build status
[03:21:00.276] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:00.276] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:48:0) after 1m0s
[03:22:00.331] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:48:0)
[03:22:00.331] Timer tick, asking Buildbucket for the build status
[03:22:00.393] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:00.393] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:49:0) after 1m0s
[03:23:00.500] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:49:0)
[03:23:00.500] Timer tick, asking Buildbucket for the build status
[03:23:00.569] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:00.569] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:50:0) after 1m0s
[03:24:00.606] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:50:0)
[03:24:00.606] Timer tick, asking Buildbucket for the build status
[03:24:00.667] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:00.667] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:51:0) after 1m0s
[03:25:00.707] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:51:0)
[03:25:00.707] Timer tick, asking Buildbucket for the build status
[03:25:00.762] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:00.762] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:52:0) after 1m0s
[03:26:00.898] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:52:0)
[03:26:00.898] Timer tick, asking Buildbucket for the build status
[03:26:01.007] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:01.007] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:53:0) after 1m0s
[03:27:01.158] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:53:0)
[03:27:01.158] Timer tick, asking Buildbucket for the build status
[03:27:01.214] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:01.214] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:54:0) after 1m0s
[03:28:01.920] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:54:0)
[03:28:01.920] Timer tick, asking Buildbucket for the build status
[03:28:02.031] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:02.031] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:55:0) after 1m0s
[03:29:02.091] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:55:0)
[03:29:02.091] Timer tick, asking Buildbucket for the build status
[03:29:02.173] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:02.173] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:56:0) after 1m0s
[03:30:02.280] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:56:0)
[03:30:02.280] Timer tick, asking Buildbucket for the build status
[03:30:02.345] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:02.345] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:57:0) after 1m0s
[03:31:02.498] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:57:0)
[03:31:02.498] Timer tick, asking Buildbucket for the build status
[03:31:02.839] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:02.839] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:58:0) after 1m0s
[03:32:02.891] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:58:0)
[03:32:02.891] Timer tick, asking Buildbucket for the build status
[03:32:02.964] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:02.964] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:59:0) after 1m0s
[03:33:03.001] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:59:0)
[03:33:03.001] Timer tick, asking Buildbucket for the build status
[03:33:03.074] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:03.074] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:60:0) after 1m0s
[03:34:03.107] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:60:0)
[03:34:03.107] Timer tick, asking Buildbucket for the build status
[03:34:03.302] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:03.302] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:61:0) after 1m0s
[03:35:03.419] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:61:0)
[03:35:03.419] Timer tick, asking Buildbucket for the build status
[03:35:03.568] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:03.568] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:62:0) after 1m0s
[03:36:03.615] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:62:0)
[03:36:03.615] Timer tick, asking Buildbucket for the build status
[03:36:03.855] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:03.855] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:63:0) after 1m0s
[03:37:03.887] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:63:0)
[03:37:03.887] Timer tick, asking Buildbucket for the build status
[03:37:04.069] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:04.069] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:64:0) after 1m0s
[03:38:04.104] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:64:0)
[03:38:04.104] Timer tick, asking Buildbucket for the build status
[03:38:04.188] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:04.188] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:65:0) after 1m0s
[03:39:04.214] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:65:0)
[03:39:04.214] Timer tick, asking Buildbucket for the build status
[03:39:04.277] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:04.277] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:66:0) after 1m0s
[03:40:04.337] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:66:0)
[03:40:04.337] Timer tick, asking Buildbucket for the build status
[03:40:04.524] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:04.524] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:67:0) after 1m0s
[03:41:04.664] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:67:0)
[03:41:04.664] Timer tick, asking Buildbucket for the build status
[03:41:04.869] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:04.869] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:68:0) after 1m0s
[03:42:04.911] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:68:0)
[03:42:04.911] Timer tick, asking Buildbucket for the build status
[03:42:04.966] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:04.966] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:69:0) after 1m0s
[03:43:05.047] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:69:0)
[03:43:05.047] Timer tick, asking Buildbucket for the build status
[03:43:05.111] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:05.111] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:70:0) after 1m0s
[03:44:05.134] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:70:0)
[03:44:05.134] Timer tick, asking Buildbucket for the build status
[03:44:05.209] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:05.209] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:71:0) after 1m0s
[03:45:05.268] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:71:0)
[03:45:05.268] Timer tick, asking Buildbucket for the build status
[03:45:05.332] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:05.332] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:72:0) after 1m0s
[03:46:05.357] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:72:0)
[03:46:05.357] Timer tick, asking Buildbucket for the build status
[03:46:05.560] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:05.560] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:73:0) after 1m0s
[03:47:05.575] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:73:0)
[03:47:05.575] Timer tick, asking Buildbucket for the build status
[03:47:05.738] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:05.738] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:74:0) after 1m0s
[03:48:05.758] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:74:0)
[03:48:05.758] Timer tick, asking Buildbucket for the build status
[03:48:05.821] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:05.821] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:75:0) after 1m0s
[03:49:05.872] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:75:0)
[03:49:05.872] Timer tick, asking Buildbucket for the build status
[03:49:05.935] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:05.935] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:76:0) after 1m0s
[03:50:06.007] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:76:0)
[03:50:06.007] Timer tick, asking Buildbucket for the build status
[03:50:06.086] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:06.086] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:77:0) after 1m0s
[03:51:06.104] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:77:0)
[03:51:06.104] Timer tick, asking Buildbucket for the build status
[03:51:06.401] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:06.401] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:78:0) after 1m0s
[03:52:06.472] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:78:0)
[03:52:06.472] Timer tick, asking Buildbucket for the build status
[03:52:06.704] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:06.704] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:79:0) after 1m0s
[03:53:06.726] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:79:0)
[03:53:06.726] Timer tick, asking Buildbucket for the build status
[03:53:06.786] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:06.786] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:80:0) after 1m0s
[03:54:06.867] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:80:0)
[03:54:06.867] Timer tick, asking Buildbucket for the build status
[03:54:06.936] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:06.936] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:81:0) after 1m0s
[03:55:06.937] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:81:0)
[03:55:06.937] Timer tick, asking Buildbucket for the build status
[03:55:06.998] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:06.998] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:82:0) after 1m0s
[03:56:07.014] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:82:0)
[03:56:07.014] Timer tick, asking Buildbucket for the build status
[03:56:07.132] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:07.132] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:83:0) after 1m0s
[03:57:07.135] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:83:0)
[03:57:07.135] Timer tick, asking Buildbucket for the build status
[03:57:07.212] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:07.212] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:84:0) after 1m0s
[03:58:07.299] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:84:0)
[03:58:07.299] Timer tick, asking Buildbucket for the build status
[03:58:07.375] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:07.375] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:85:0) after 1m0s
[03:59:07.427] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:85:0)
[03:59:07.427] Timer tick, asking Buildbucket for the build status
[03:59:07.493] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:07.493] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:86:0) after 1m0s
[04:00:07.570] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:86:0)
[04:00:07.570] Timer tick, asking Buildbucket for the build status
[04:00:07.846] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:07.846] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:87:0) after 1m0s
[04:01:07.870] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:87:0)
[04:01:07.870] Timer tick, asking Buildbucket for the build status
[04:01:07.992] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:07.992] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:88:0) after 1m0s
[04:02:08.021] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:88:0)
[04:02:08.021] Timer tick, asking Buildbucket for the build status
[04:02:08.135] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:08.135] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:89:0) after 1m0s
[04:03:08.189] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:89:0)
[04:03:08.189] Timer tick, asking Buildbucket for the build status
[04:03:08.304] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:08.304] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:90:0) after 1m0s
[04:04:08.380] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:90:0)
[04:04:08.380] Timer tick, asking Buildbucket for the build status
[04:04:08.478] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:08.478] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:91:0) after 1m0s
[04:05:08.998] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:91:0)
[04:05:08.998] Timer tick, asking Buildbucket for the build status
[04:05:09.068] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:09.068] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:92:0) after 1m0s
[04:06:09.286] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:92:0)
[04:06:09.286] Timer tick, asking Buildbucket for the build status
[04:06:09.387] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:09.387] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:93:0) after 1m0s
[04:07:09.519] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:93:0)
[04:07:09.519] Timer tick, asking Buildbucket for the build status
[04:07:09.735] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:09.735] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:94:0) after 1m0s
[04:08:09.763] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:94:0)
[04:08:09.763] Timer tick, asking Buildbucket for the build status
[04:08:09.831] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:09.831] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:95:0) after 1m0s
[04:09:09.895] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:95:0)
[04:09:09.895] Timer tick, asking Buildbucket for the build status
[04:09:09.960] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:09.960] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:96:0) after 1m0s
[04:10:11.666] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:96:0)
[04:10:11.666] Timer tick, asking Buildbucket for the build status
[04:10:11.737] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:11.737] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:97:0) after 1m0s
[04:11:11.767] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:97:0)
[04:11:11.767] Timer tick, asking Buildbucket for the build status
[04:11:12.196] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:12.196] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:98:0) after 1m0s
[04:12:12.221] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:98:0)
[04:12:12.221] Timer tick, asking Buildbucket for the build status
[04:12:12.278] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:12.278] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:99:0) after 1m0s
[04:13:12.301] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:99:0)
[04:13:12.301] Timer tick, asking Buildbucket for the build status
[04:13:12.405] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:12.405] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:100:0) after 1m0s
[04:14:12.417] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:100:0)
[04:14:12.417] Timer tick, asking Buildbucket for the build status
[04:14:12.552] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:12.552] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:101:0) after 1m0s
[04:15:12.569] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:101:0)
[04:15:12.569] Timer tick, asking Buildbucket for the build status
[04:15:12.629] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:12.629] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:102:0) after 1m0s
[04:16:12.694] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:102:0)
[04:16:12.694] Timer tick, asking Buildbucket for the build status
[04:16:12.917] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:12.917] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:103:0) after 1m0s
[04:17:12.947] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:103:0)
[04:17:12.947] Timer tick, asking Buildbucket for the build status
[04:17:13.011] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:13.011] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:104:0) after 1m0s
[04:18:13.044] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:104:0)
[04:18:13.044] Timer tick, asking Buildbucket for the build status
[04:18:13.115] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:13.115] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:105:0) after 1m0s
[04:19:13.266] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:105:0)
[04:19:13.266] Timer tick, asking Buildbucket for the build status
[04:19:13.345] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:13.345] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:106:0) after 1m0s
[04:20:13.396] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:106:0)
[04:20:13.396] Timer tick, asking Buildbucket for the build status
[04:20:13.481] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:13.481] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:107:0) after 1m0s
[04:21:13.533] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:107:0)
[04:21:13.533] Timer tick, asking Buildbucket for the build status
[04:21:13.654] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:13.654] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:108:0) after 1m0s
[04:22:13.679] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:108:0)
[04:22:13.679] Timer tick, asking Buildbucket for the build status
[04:22:13.744] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:13.744] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:109:0) after 1m0s
[04:23:13.774] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:109:0)
[04:23:13.774] Timer tick, asking Buildbucket for the build status
[04:23:13.838] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:13.838] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:110:0) after 1m0s
[04:24:13.863] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:110:0)
[04:24:13.863] Timer tick, asking Buildbucket for the build status
[04:24:13.951] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:13.951] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:111:0) after 1m0s
[04:25:14.002] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:111:0)
[04:25:14.002] Timer tick, asking Buildbucket for the build status
[04:25:14.109] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:14.109] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:112:0) after 1m0s
[04:26:14.151] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:112:0)
[04:26:14.151] Timer tick, asking Buildbucket for the build status
[04:26:14.269] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:14.269] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:113:0) after 1m0s
[04:27:14.332] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:113:0)
[04:27:14.332] Timer tick, asking Buildbucket for the build status
[04:27:14.403] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:14.403] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:114:0) after 1m0s
[04:28:14.464] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:114:0)
[04:28:14.464] Timer tick, asking Buildbucket for the build status
[04:28:14.535] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:14.535] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:115:0) after 1m0s
[04:29:14.573] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:115:0)
[04:29:14.573] Timer tick, asking Buildbucket for the build status
[04:29:14.649] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:14.649] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:116:0) after 1m0s
[04:30:14.780] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:116:0)
[04:30:14.780] Timer tick, asking Buildbucket for the build status
[04:30:15.146] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:15.146] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:117:0) after 1m0s
[04:31:15.522] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:117:0)
[04:31:15.522] Timer tick, asking Buildbucket for the build status
[04:31:15.690] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:15.690] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:118:0) after 1m0s
[04:32:16.019] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:118:0)
[04:32:16.019] Timer tick, asking Buildbucket for the build status
[04:32:16.093] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:16.093] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:119:0) after 1m0s
[04:33:16.240] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:119:0)
[04:33:16.240] Timer tick, asking Buildbucket for the build status
[04:33:16.474] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:16.474] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:120:0) after 1m0s
[04:34:16.585] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:120:0)
[04:34:16.585] Timer tick, asking Buildbucket for the build status
[04:34:16.678] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:16.678] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:121:0) after 1m0s
[04:35:16.796] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:121:0)
[04:35:16.796] Timer tick, asking Buildbucket for the build status
[04:35:16.901] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:16.901] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:122:0) after 1m0s
[04:36:17.052] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:122:0)
[04:36:17.052] Timer tick, asking Buildbucket for the build status
[04:36:17.198] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:17.198] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:123:0) after 1m0s
[04:37:17.517] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:123:0)
[04:37:17.517] Timer tick, asking Buildbucket for the build status
[04:37:17.576] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:17.576] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:124:0) after 1m0s
[04:38:17.842] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:124:0)
[04:38:17.842] Timer tick, asking Buildbucket for the build status
[04:38:18.120] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:18.120] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:125:0) after 1m0s
[04:39:18.248] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:125:0)
[04:39:18.248] Timer tick, asking Buildbucket for the build status
[04:39:18.304] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:18.304] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:126:0) after 1m0s
[04:40:18.333] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:126:0)
[04:40:18.333] Timer tick, asking Buildbucket for the build status
[04:40:18.499] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:18.499] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:127:0) after 1m0s
[04:41:18.576] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:127:0)
[04:41:18.576] Timer tick, asking Buildbucket for the build status
[04:41:18.794] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:18.794] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:128:0) after 1m0s
[04:42:19.059] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:128:0)
[04:42:19.059] Timer tick, asking Buildbucket for the build status
[04:42:19.126] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:19.126] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:129:0) after 1m0s
[04:43:19.198] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:129:0)
[04:43:19.198] Timer tick, asking Buildbucket for the build status
[04:43:19.272] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:19.272] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:130:0) after 1m0s
[04:44:19.324] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:130:0)
[04:44:19.324] Timer tick, asking Buildbucket for the build status
[04:44:19.627] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:19.627] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:131:0) after 1m0s
[04:45:19.655] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:131:0)
[04:45:19.656] Timer tick, asking Buildbucket for the build status
[04:45:19.731] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:19.731] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:132:0) after 1m0s
[04:46:19.799] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:132:0)
[04:46:19.799] Timer tick, asking Buildbucket for the build status
[04:46:20.049] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:20.049] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:133:0) after 1m0s
[04:47:20.124] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:133:0)
[04:47:20.124] Timer tick, asking Buildbucket for the build status
[04:47:20.203] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:20.203] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:134:0) after 1m0s
[04:48:20.245] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:134:0)
[04:48:20.245] Timer tick, asking Buildbucket for the build status
[04:48:20.323] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:20.323] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:135:0) after 1m0s
[04:49:20.412] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:135:0)
[04:49:20.412] Timer tick, asking Buildbucket for the build status
[04:49:20.767] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:20.767] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:136:0) after 1m0s
[04:50:20.804] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:136:0)
[04:50:20.804] Timer tick, asking Buildbucket for the build status
[04:50:20.872] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:20.872] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:137:0) after 1m0s
[04:51:20.911] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:137:0)
[04:51:20.911] Timer tick, asking Buildbucket for the build status
[04:51:21.144] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:21.144] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:138:0) after 1m0s
[04:52:21.144] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:138:0)
[04:52:21.144] Timer tick, asking Buildbucket for the build status
[04:52:21.210] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:21.210] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:139:0) after 1m0s
[04:53:21.233] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:139:0)
[04:53:21.233] Timer tick, asking Buildbucket for the build status
[04:53:21.293] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:21.293] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:140:0) after 1m0s
[04:54:21.325] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:140:0)
[04:54:21.325] Timer tick, asking Buildbucket for the build status
[04:54:21.497] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:21.497] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:141:0) after 1m0s
[04:55:21.522] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:141:0)
[04:55:21.522] Timer tick, asking Buildbucket for the build status
[04:55:21.852] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:21.852] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:142:0) after 1m0s
[04:56:21.857] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:142:0)
[04:56:21.857] Timer tick, asking Buildbucket for the build status
[04:56:21.944] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:21.944] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:143:0) after 1m0s
[04:57:21.941] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:143:0)
[04:57:21.941] Timer tick, asking Buildbucket for the build status
[04:57:22.025] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:22.025] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:144:0) after 1m0s
[04:58:22.048] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:144:0)
[04:58:22.048] Timer tick, asking Buildbucket for the build status
[04:58:22.337] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:22.337] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:145:0) after 1m0s
[04:59:22.402] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:145:0)
[04:59:22.402] Timer tick, asking Buildbucket for the build status
[04:59:22.466] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:22.466] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:146:0) after 1m0s
[05:00:22.490] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:146:0)
[05:00:22.490] Timer tick, asking Buildbucket for the build status
[05:00:22.664] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:22.664] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:147:0) after 1m0s
[05:01:22.858] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:147:0)
[05:01:22.858] Timer tick, asking Buildbucket for the build status
[05:01:22.976] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:22.976] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:148:0) after 1m0s
[05:02:23.035] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:148:0)
[05:02:23.035] Timer tick, asking Buildbucket for the build status
[05:02:23.301] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:23.301] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:149:0) after 1m0s
[05:03:23.325] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:149:0)
[05:03:23.325] Timer tick, asking Buildbucket for the build status
[05:03:23.421] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:23.421] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:150:0) after 1m0s
[05:04:23.444] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:150:0)
[05:04:23.444] Timer tick, asking Buildbucket for the build status
[05:04:23.518] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:23.518] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:151:0) after 1m0s
[05:05:23.577] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:151:0)
[05:05:23.577] Timer tick, asking Buildbucket for the build status
[05:05:23.641] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:23.641] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:152:0) after 1m0s
[05:06:23.668] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:152:0)
[05:06:23.668] Timer tick, asking Buildbucket for the build status
[05:06:23.769] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:23.769] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:153:0) after 1m0s
[05:07:23.829] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:153:0)
[05:07:23.829] Timer tick, asking Buildbucket for the build status
[05:07:23.901] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:23.901] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:154:0) after 1m0s
[05:08:23.934] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:154:0)
[05:08:23.934] Timer tick, asking Buildbucket for the build status
[05:08:24.017] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:24.017] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:155:0) after 1m0s
[05:09:24.028] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:155:0)
[05:09:24.028] Timer tick, asking Buildbucket for the build status
[05:09:24.092] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:24.092] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:156:0) after 1m0s
[05:10:24.104] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:156:0)
[05:10:24.104] Timer tick, asking Buildbucket for the build status
[05:10:24.156] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:24.156] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:157:0) after 1m0s
[05:11:24.214] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:157:0)
[05:11:24.214] Timer tick, asking Buildbucket for the build status
[05:11:24.586] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:24.586] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:158:0) after 1m0s
[05:12:24.611] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:158:0)
[05:12:24.611] Timer tick, asking Buildbucket for the build status
[05:12:24.682] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:24.682] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:159:0) after 1m0s
[05:13:24.721] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:159:0)
[05:13:24.721] Timer tick, asking Buildbucket for the build status
[05:13:25.039] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:25.039] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:160:0) after 1m0s
[05:14:25.069] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:160:0)
[05:14:25.069] Timer tick, asking Buildbucket for the build status
[05:14:25.141] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:25.141] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:161:0) after 1m0s
[05:15:25.231] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:161:0)
[05:15:25.231] Timer tick, asking Buildbucket for the build status
[05:15:25.435] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:25.435] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:162:0) after 1m0s
[05:16:25.526] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:162:0)
[05:16:25.526] Timer tick, asking Buildbucket for the build status
[05:16:25.667] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:25.667] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:163:0) after 1m0s
[05:17:25.699] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:163:0)
[05:17:25.699] Timer tick, asking Buildbucket for the build status
[05:17:25.774] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:25.774] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:164:0) after 1m0s
[05:18:25.843] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:164:0)
[05:18:25.843] Timer tick, asking Buildbucket for the build status
[05:18:25.921] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:25.921] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:165:0) after 1m0s
[05:19:26.016] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:165:0)
[05:19:26.016] Timer tick, asking Buildbucket for the build status
[05:19:26.127] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:26.127] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:166:0) after 1m0s
[05:20:26.173] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:166:0)
[05:20:26.173] Timer tick, asking Buildbucket for the build status
[05:20:26.388] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:26.388] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:167:0) after 1m0s
[05:21:26.379] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:167:0)
[05:21:26.379] Timer tick, asking Buildbucket for the build status
[05:21:26.503] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:26.503] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:168:0) after 1m0s
[05:22:26.593] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:168:0)
[05:22:26.593] Timer tick, asking Buildbucket for the build status
[05:22:26.733] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:26.733] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:169:0) after 1m0s
[05:23:26.854] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:169:0)
[05:23:26.854] Timer tick, asking Buildbucket for the build status
[05:23:26.931] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:26.931] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:170:0) after 1m0s
[05:24:27.058] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:170:0)
[05:24:27.058] Timer tick, asking Buildbucket for the build status
[05:24:27.120] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:27.120] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:171:0) after 1m0s
[05:25:27.332] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:171:0)
[05:25:27.332] Timer tick, asking Buildbucket for the build status
[05:25:27.396] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:27.396] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:172:0) after 1m0s
[05:26:27.437] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:172:0)
[05:26:27.437] Timer tick, asking Buildbucket for the build status
[05:26:27.558] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:27.558] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:173:0) after 1m0s
[05:27:27.654] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:173:0)
[05:27:27.654] Timer tick, asking Buildbucket for the build status
[05:27:27.719] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:27.719] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:174:0) after 1m0s
[05:28:27.841] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:174:0)
[05:28:27.841] Timer tick, asking Buildbucket for the build status
[05:28:27.894] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:27.894] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:175:0) after 1m0s
[05:29:28.009] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:175:0)
[05:29:28.009] Timer tick, asking Buildbucket for the build status
[05:29:28.072] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:28.073] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:176:0) after 1m0s
[05:30:28.286] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:176:0)
[05:30:28.286] Timer tick, asking Buildbucket for the build status
[05:30:28.396] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:28.396] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:177:0) after 1m0s
[05:31:28.572] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:177:0)
[05:31:28.572] Timer tick, asking Buildbucket for the build status
[05:31:28.689] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:28.689] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:178:0) after 1m0s
[05:32:28.746] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:178:0)
[05:32:28.746] Timer tick, asking Buildbucket for the build status
[05:32:28.811] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:28.811] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:179:0) after 1m0s
[05:33:28.884] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:179:0)
[05:33:28.884] Timer tick, asking Buildbucket for the build status
[05:33:28.953] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:28.953] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:180:0) after 1m0s
[05:34:29.029] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:180:0)
[05:34:29.029] Timer tick, asking Buildbucket for the build status
[05:34:29.083] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:29.083] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:181:0) after 1m0s
[05:35:29.201] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:181:0)
[05:35:29.201] Timer tick, asking Buildbucket for the build status
[05:35:29.294] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:29.294] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:182:0) after 1m0s
[05:36:29.388] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:182:0)
[05:36:29.388] Timer tick, asking Buildbucket for the build status
[05:36:29.564] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:29.564] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:183:0) after 1m0s
[05:37:29.590] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:183:0)
[05:37:29.590] Timer tick, asking Buildbucket for the build status
[05:37:29.668] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:29.668] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:184:0) after 1m0s
[05:38:29.679] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:184:0)
[05:38:29.679] Timer tick, asking Buildbucket for the build status
[05:38:29.898] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:29.898] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:185:0) after 1m0s
[05:39:29.934] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:185:0)
[05:39:29.934] Timer tick, asking Buildbucket for the build status
[05:39:30.012] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:30.012] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:186:0) after 1m0s
[05:40:30.045] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:186:0)
[05:40:30.045] Timer tick, asking Buildbucket for the build status
[05:40:30.107] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:30.107] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:187:0) after 1m0s
[05:41:30.134] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:187:0)
[05:41:30.134] Timer tick, asking Buildbucket for the build status
[05:41:30.449] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:30.449] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:188:0) after 1m0s
[05:42:30.527] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:188:0)
[05:42:30.527] Timer tick, asking Buildbucket for the build status
[05:42:30.632] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:30.632] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:189:0) after 1m0s
[05:43:31.042] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:189:0)
[05:43:31.042] Timer tick, asking Buildbucket for the build status
[05:43:31.100] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:31.100] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:190:0) after 1m0s
[05:44:31.182] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:190:0)
[05:44:31.182] Timer tick, asking Buildbucket for the build status
[05:44:31.236] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:31.236] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:191:0) after 1m0s
[05:45:31.427] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:191:0)
[05:45:31.427] Timer tick, asking Buildbucket for the build status
[05:45:31.530] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:31.530] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:192:0) after 1m0s
[05:46:31.550] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:192:0)
[05:46:31.550] Timer tick, asking Buildbucket for the build status
[05:46:31.658] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:31.658] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:193:0) after 1m0s
[05:47:31.745] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:193:0)
[05:47:31.745] Timer tick, asking Buildbucket for the build status
[05:47:34.188] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:34.188] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:194:0) after 1m0s
[05:48:34.320] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:194:0)
[05:48:34.320] Timer tick, asking Buildbucket for the build status
[05:48:34.427] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:34.427] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:195:0) after 1m0s
[05:49:34.492] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:195:0)
[05:49:34.492] Timer tick, asking Buildbucket for the build status
[05:49:34.586] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:34.586] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:196:0) after 1m0s
[05:50:34.636] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:196:0)
[05:50:34.636] Timer tick, asking Buildbucket for the build status
[05:50:34.687] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:34.687] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:197:0) after 1m0s
[05:51:34.722] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:197:0)
[05:51:34.722] Timer tick, asking Buildbucket for the build status
[05:51:34.834] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:34.834] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:198:0) after 1m0s
[05:52:34.905] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:198:0)
[05:52:34.905] Timer tick, asking Buildbucket for the build status
[05:52:35.001] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:35.001] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:199:0) after 1m0s
[05:53:35.161] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:199:0)
[05:53:35.161] Timer tick, asking Buildbucket for the build status
[05:53:35.219] Build 8862967509170024240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:35.219] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9028397571189417392:200:0) after 1m0s
[05:54:28.592] Received PubSub notification, asking Buildbucket for the build status
[05:54:28.793] Build 8862967509170024240: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:54:28.793] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1606024467880038",
    "created_by": "project:chromium",
    "created_ts": "1606012541569216",
    "id": "8862967509170024240",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4bf38882f2794c7ae93a729ce5ccaeb71fa7c162\"}}",
    "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\": \"4bf38882f2794c7ae93a729ce5ccaeb71fa7c162\", \"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-k2j1\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 971, \"got_angle_revision\": \"e51c9068a84f14e42157c097eb764ec3009e0e54\", \"got_dawn_revision\": \"546a7c98c89718f2dadf1ae07088fa7cf2ccb53f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"4bf38882f2794c7ae93a729ce5ccaeb71fa7c162\", \"got_revision_cp\": \"refs/heads/master@{#830016}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"22f2e5ef66ed5c820532f27b141096d3ddb1966e\", \"got_v8_revision_cp\": \"refs/heads/8.9.31@{#1}\", \"got_webrtc_revision\": \"7d75f2ca782f38006bb65bc67533e582190454e8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32659}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4bf38882f2794c7ae93a729ce5ccaeb71fa7c162\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_f6b49936a2965b3cdad8f63ce13313d0c4b82119a9acfffbfe199e91c26d0c88_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-4-k2j1\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"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\": [\"5637-4d8b832\"], \"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": "1606012637061894",
    "status": "COMPLETED",
    "status_changed_ts": "1606024468249843",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/971",
      "builder:win32-official",
      "buildset:commit/git/4bf38882f2794c7ae93a729ce5ccaeb71fa7c162",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4bf38882f2794c7ae93a729ce5ccaeb71fa7c162",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9028397571189417392",
      "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/8862967509170024240/+/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:5006a0250b51db10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1606024468260949",
    "url": "https://ci.chromium.org/b/8862967509170024240",
    "utcnow_ts": "1606024468778902"
  }
}
[05:54:28.793] Invocation finished in 3h18m48.533057633s with status SUCCEEDED