buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.chromium.ci"
  builder: "linux-chromeos-dbg"
>

• aa099c4bfd7b9b99dfadedc860816e66a50b790e (5 years ago)
• 10a485351ae77074ac9020f73f8ade75f4838756 (5 years ago)
• 68b984d3e0d1789a21433a314ec6202785c757f6 (5 years ago)
• 98390e75f87cbf8f051ea0b4c50b00abd69e0ed0 (5 years ago)
• b13bc8a093b253f530952d680282a7c3f1ffbe63 (5 years ago)
• 217b50326ca3cc6592d3aac719f197318b6a79f6 (5 years ago)
• a3a97d185750f883d4db9ce4f1a73756df4c9f9a (5 years ago)
• 2fe97c5ae5b05fcdef7946f966f65ba6e706c7be (5 years ago)

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

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

[03:51:07.015] New invocation is queued and will start shortly
[03:51:08.332] Starting the invocation (attempt 1)
[03:51:08.361] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:51:08.361] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:51:08.361] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9020148500615795648",
  "parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2fe97c5ae5b05fcdef7946f966f65ba6e706c7be\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux-chromeos-dbg",
    "scheduler_invocation_id:9020148500615795648",
    "scheduler_job_id:chromium/linux-chromeos-dbg",
    "user_agent:luci-scheduler",
    "buildset:commit/git/2fe97c5ae5b05fcdef7946f966f65ba6e706c7be",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2fe97c5ae5b05fcdef7946f966f65ba6e706c7be",
    "gitiles_ref:refs/heads/master"
  ]
}
[03:51:09.462] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary": true,
    "canary_preference": "CANARY",
    "created_by": "project:chromium",
    "created_ts": "1613879468441921",
    "id": "8854718438458537872",
    "parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2fe97c5ae5b05fcdef7946f966f65ba6e706c7be\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1613879468917246",
    "tags": [
      "build_address:luci.chromium.ci/linux-chromeos-dbg/22714",
      "builder:linux-chromeos-dbg",
      "buildset:commit/git/2fe97c5ae5b05fcdef7946f966f65ba6e706c7be",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2fe97c5ae5b05fcdef7946f966f65ba6e706c7be",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9020148500615795648",
      "scheduler_job_id:chromium/linux-chromeos-dbg",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854718438458537872/+/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": "1613879468917385",
    "url": "https://ci.chromium.org/b/8854718438458537872",
    "utcnow_ts": "1613879469450049"
  }
}
[03:51:09.462] Task URL: https://ci.chromium.org/b/8854718438458537872
[03:51:09.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:2:0) after 1m0s
[03:52:09.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:2:0)
[03:52:09.478] Timer tick, asking Buildbucket for the build status
[03:52:09.556] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:52:09.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:3:0) after 1m0s
[03:53:09.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:3:0)
[03:53:09.617] Timer tick, asking Buildbucket for the build status
[03:53:09.695] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:53:09.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:4:0) after 1m0s
[03:54:09.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:4:0)
[03:54:09.713] Timer tick, asking Buildbucket for the build status
[03:54:09.775] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:54:09.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:5:0) after 1m0s
[03:55:09.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:5:0)
[03:55:09.764] Timer tick, asking Buildbucket for the build status
[03:55:09.869] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:55:09.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:6:0) after 1m0s
[03:56:10.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:6:0)
[03:56:10.018] Timer tick, asking Buildbucket for the build status
[03:56:10.109] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:56:10.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:7:0) after 1m0s
[03:57:10.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:7:0)
[03:57:10.153] Timer tick, asking Buildbucket for the build status
[03:57:10.296] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:57:10.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:8:0) after 1m0s
[03:58:10.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:8:0)
[03:58:10.444] Timer tick, asking Buildbucket for the build status
[03:58:10.658] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:58:10.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:9:0) after 1m0s
[03:59:10.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:9:0)
[03:59:10.671] Timer tick, asking Buildbucket for the build status
[03:59:10.745] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:59:10.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:10:0) after 1m0s
[04:00:10.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:10:0)
[04:00:10.819] Timer tick, asking Buildbucket for the build status
[04:00:11.069] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:00:11.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:11:0) after 1m0s
[04:01:11.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:11:0)
[04:01:11.095] Timer tick, asking Buildbucket for the build status
[04:01:11.198] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:01:11.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:12:0) after 1m0s
[04:02:11.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:12:0)
[04:02:11.215] Timer tick, asking Buildbucket for the build status
[04:02:11.440] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:02:11.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:13:0) after 1m0s
[04:03:11.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:13:0)
[04:03:11.480] Timer tick, asking Buildbucket for the build status
[04:03:11.646] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:03:11.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:14:0) after 1m0s
[04:04:11.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:14:0)
[04:04:11.762] Timer tick, asking Buildbucket for the build status
[04:04:11.831] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:04:11.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:15:0) after 1m0s
[04:05:11.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:15:0)
[04:05:11.939] Timer tick, asking Buildbucket for the build status
[04:05:12.009] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:05:12.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:16:0) after 1m0s
[04:06:12.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:16:0)
[04:06:12.041] Timer tick, asking Buildbucket for the build status
[04:06:12.163] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:06:12.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:17:0) after 1m0s
[04:07:12.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:17:0)
[04:07:12.184] Timer tick, asking Buildbucket for the build status
[04:07:12.263] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:07:12.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:18:0) after 1m0s
[04:08:12.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:18:0)
[04:08:12.322] Timer tick, asking Buildbucket for the build status
[04:08:12.385] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:12.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:19:0) after 1m0s
[04:09:12.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:19:0)
[04:09:12.433] Timer tick, asking Buildbucket for the build status
[04:09:12.495] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:12.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:20:0) after 1m0s
[04:10:12.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:20:0)
[04:10:12.557] Timer tick, asking Buildbucket for the build status
[04:10:12.629] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:12.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:21:0) after 1m0s
[04:11:12.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:21:0)
[04:11:12.647] Timer tick, asking Buildbucket for the build status
[04:11:12.820] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:12.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:22:0) after 1m0s
[04:12:12.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:22:0)
[04:12:12.865] Timer tick, asking Buildbucket for the build status
[04:12:12.926] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:12.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:23:0) after 1m0s
[04:13:12.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:23:0)
[04:13:12.929] Timer tick, asking Buildbucket for the build status
[04:13:13.021] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:13.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:24:0) after 1m0s
[04:14:13.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:24:0)
[04:14:13.042] Timer tick, asking Buildbucket for the build status
[04:14:13.276] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:13.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:25:0) after 1m0s
[04:15:13.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:25:0)
[04:15:13.307] Timer tick, asking Buildbucket for the build status
[04:15:13.362] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:15:13.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:26:0) after 1m0s
[04:16:14.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:26:0)
[04:16:14.393] Timer tick, asking Buildbucket for the build status
[04:16:14.481] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:16:14.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:27:0) after 1m0s
[04:17:14.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:27:0)
[04:17:14.533] Timer tick, asking Buildbucket for the build status
[04:17:14.595] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:17:14.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:28:0) after 1m0s
[04:18:14.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:28:0)
[04:18:14.633] Timer tick, asking Buildbucket for the build status
[04:18:14.704] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:14.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:29:0) after 1m0s
[04:19:14.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:29:0)
[04:19:14.720] Timer tick, asking Buildbucket for the build status
[04:19:14.922] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:14.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:30:0) after 1m0s
[04:20:14.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:30:0)
[04:20:14.973] Timer tick, asking Buildbucket for the build status
[04:20:15.700] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:15.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:31:0) after 1m0s
[04:21:15.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:31:0)
[04:21:15.726] Timer tick, asking Buildbucket for the build status
[04:21:15.847] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:15.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:32:0) after 1m0s
[04:22:15.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:32:0)
[04:22:15.912] Timer tick, asking Buildbucket for the build status
[04:22:16.032] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:16.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:33:0) after 1m0s
[04:23:16.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:33:0)
[04:23:16.050] Timer tick, asking Buildbucket for the build status
[04:23:16.333] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:16.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:34:0) after 1m0s
[04:24:16.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:34:0)
[04:24:16.323] Timer tick, asking Buildbucket for the build status
[04:24:16.377] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:16.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:35:0) after 1m0s
[04:25:16.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:35:0)
[04:25:16.418] Timer tick, asking Buildbucket for the build status
[04:25:16.599] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:16.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:36:0) after 1m0s
[04:26:16.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:36:0)
[04:26:16.682] Timer tick, asking Buildbucket for the build status
[04:26:16.812] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:16.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:37:0) after 1m0s
[04:27:16.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:37:0)
[04:27:16.822] Timer tick, asking Buildbucket for the build status
[04:27:17.122] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:27:17.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:38:0) after 1m0s
[04:28:17.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:38:0)
[04:28:17.127] Timer tick, asking Buildbucket for the build status
[04:28:17.323] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:17.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:39:0) after 1m0s
[04:29:17.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:39:0)
[04:29:17.371] Timer tick, asking Buildbucket for the build status
[04:29:17.443] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:17.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:40:0) after 1m0s
[04:30:17.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:40:0)
[04:30:17.459] Timer tick, asking Buildbucket for the build status
[04:30:17.534] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:17.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:41:0) after 1m0s
[04:31:17.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:41:0)
[04:31:17.564] Timer tick, asking Buildbucket for the build status
[04:31:17.640] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:17.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:42:0) after 1m0s
[04:32:17.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:42:0)
[04:32:17.695] Timer tick, asking Buildbucket for the build status
[04:32:17.761] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:17.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:43:0) after 1m0s
[04:33:17.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:43:0)
[04:33:17.783] Timer tick, asking Buildbucket for the build status
[04:33:17.862] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:17.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:44:0) after 1m0s
[04:34:17.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:44:0)
[04:34:17.879] Timer tick, asking Buildbucket for the build status
[04:34:18.018] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:18.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:45:0) after 1m0s
[04:35:18.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:45:0)
[04:35:18.089] Timer tick, asking Buildbucket for the build status
[04:35:18.147] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:18.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:46:0) after 1m0s
[04:36:18.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:46:0)
[04:36:18.152] Timer tick, asking Buildbucket for the build status
[04:36:18.415] Build 8854718438458537872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:18.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:47:0) after 1m0s
[04:36:53.052] Received PubSub notification, asking Buildbucket for the build status
[04:36:53.118] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:18.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:47:0)
[04:37:18.444] Timer tick, asking Buildbucket for the build status
[04:37:18.570] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:18.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:49:0) after 1m0s
[04:38:18.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:49:0)
[04:38:18.577] Timer tick, asking Buildbucket for the build status
[04:38:18.641] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:18.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:50:0) after 1m0s
[04:39:18.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:50:0)
[04:39:18.741] Timer tick, asking Buildbucket for the build status
[04:39:18.815] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:18.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:51:0) after 1m0s
[04:40:18.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:51:0)
[04:40:18.896] Timer tick, asking Buildbucket for the build status
[04:40:18.981] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:18.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:52:0) after 1m0s
[04:41:19.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:52:0)
[04:41:19.098] Timer tick, asking Buildbucket for the build status
[04:41:19.172] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:19.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:53:0) after 1m0s
[04:42:19.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:53:0)
[04:42:19.257] Timer tick, asking Buildbucket for the build status
[04:42:19.335] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:19.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:54:0) after 1m0s
[04:43:19.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:54:0)
[04:43:19.333] Timer tick, asking Buildbucket for the build status
[04:43:19.416] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:19.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:55:0) after 1m0s
[04:44:19.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:55:0)
[04:44:19.492] Timer tick, asking Buildbucket for the build status
[04:44:19.557] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:19.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:56:0) after 1m0s
[04:45:19.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:56:0)
[04:45:19.566] Timer tick, asking Buildbucket for the build status
[04:45:19.647] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:19.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:57:0) after 1m0s
[04:46:19.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:57:0)
[04:46:19.682] Timer tick, asking Buildbucket for the build status
[04:46:20.054] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:20.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:58:0) after 1m0s
[04:47:20.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:58:0)
[04:47:20.062] Timer tick, asking Buildbucket for the build status
[04:47:20.129] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:20.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:59:0) after 1m0s
[04:48:20.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:59:0)
[04:48:20.173] Timer tick, asking Buildbucket for the build status
[04:48:20.383] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:20.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:60:0) after 1m0s
[04:49:20.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:60:0)
[04:49:20.496] Timer tick, asking Buildbucket for the build status
[04:49:21.119] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:21.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:61:0) after 1m0s
[04:50:21.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:61:0)
[04:50:21.204] Timer tick, asking Buildbucket for the build status
[04:50:21.360] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:21.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:62:0) after 1m0s
[04:51:21.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:62:0)
[04:51:21.427] Timer tick, asking Buildbucket for the build status
[04:51:21.538] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:21.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:63:0) after 1m0s
[04:52:21.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:63:0)
[04:52:21.701] Timer tick, asking Buildbucket for the build status
[04:52:21.762] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:21.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:64:0) after 1m0s
[04:53:21.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:64:0)
[04:53:21.795] Timer tick, asking Buildbucket for the build status
[04:53:21.885] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:21.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:65:0) after 1m0s
[04:54:21.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:65:0)
[04:54:21.904] Timer tick, asking Buildbucket for the build status
[04:54:21.988] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:21.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:66:0) after 1m0s
[04:55:22.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:66:0)
[04:55:22.007] Timer tick, asking Buildbucket for the build status
[04:55:22.176] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:22.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:67:0) after 1m0s
[04:56:22.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:67:0)
[04:56:22.247] Timer tick, asking Buildbucket for the build status
[04:56:22.354] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:22.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:68:0) after 1m0s
[04:57:22.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:68:0)
[04:57:22.383] Timer tick, asking Buildbucket for the build status
[04:57:22.468] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:22.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:69:0) after 1m0s
[04:58:22.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:69:0)
[04:58:22.628] Timer tick, asking Buildbucket for the build status
[04:58:22.717] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:22.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:70:0) after 1m0s
[04:59:22.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:70:0)
[04:59:22.846] Timer tick, asking Buildbucket for the build status
[04:59:22.916] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:22.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:71:0) after 1m0s
[05:00:22.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:71:0)
[05:00:22.958] Timer tick, asking Buildbucket for the build status
[05:00:23.095] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:23.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:72:0) after 1m0s
[05:01:23.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:72:0)
[05:01:23.167] Timer tick, asking Buildbucket for the build status
[05:01:23.419] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:23.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:73:0) after 1m0s
[05:02:23.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:73:0)
[05:02:23.447] Timer tick, asking Buildbucket for the build status
[05:02:23.526] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:23.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:74:0) after 1m0s
[05:03:23.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:74:0)
[05:03:23.603] Timer tick, asking Buildbucket for the build status
[05:03:23.675] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:23.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:75:0) after 1m0s
[05:04:23.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:75:0)
[05:04:23.749] Timer tick, asking Buildbucket for the build status
[05:04:23.833] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:23.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:76:0) after 1m0s
[05:05:23.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:76:0)
[05:05:23.864] Timer tick, asking Buildbucket for the build status
[05:05:23.949] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:23.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:77:0) after 1m0s
[05:06:23.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:77:0)
[05:06:23.983] Timer tick, asking Buildbucket for the build status
[05:06:24.099] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:24.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:78:0) after 1m0s
[05:07:24.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:78:0)
[05:07:24.109] Timer tick, asking Buildbucket for the build status
[05:07:24.403] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:24.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:79:0) after 1m0s
[05:08:24.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:79:0)
[05:08:24.432] Timer tick, asking Buildbucket for the build status
[05:08:24.511] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:24.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:80:0) after 1m0s
[05:09:24.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:80:0)
[05:09:24.534] Timer tick, asking Buildbucket for the build status
[05:09:24.641] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:24.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:81:0) after 1m0s
[05:10:24.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:81:0)
[05:10:24.655] Timer tick, asking Buildbucket for the build status
[05:10:24.743] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:24.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:82:0) after 1m0s
[05:11:24.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:82:0)
[05:11:24.762] Timer tick, asking Buildbucket for the build status
[05:11:24.899] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:24.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:83:0) after 1m0s
[05:12:24.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:83:0)
[05:12:24.926] Timer tick, asking Buildbucket for the build status
[05:12:25.285] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:25.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:84:0) after 1m0s
[05:13:25.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:84:0)
[05:13:25.422] Timer tick, asking Buildbucket for the build status
[05:13:25.495] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:25.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:85:0) after 1m0s
[05:14:25.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:85:0)
[05:14:25.544] Timer tick, asking Buildbucket for the build status
[05:14:25.656] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:25.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:86:0) after 1m0s
[05:15:25.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:86:0)
[05:15:25.728] Timer tick, asking Buildbucket for the build status
[05:15:25.831] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:25.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:87:0) after 1m0s
[05:16:25.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:87:0)
[05:16:25.960] Timer tick, asking Buildbucket for the build status
[05:16:26.051] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:26.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:88:0) after 1m0s
[05:17:26.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:88:0)
[05:17:26.098] Timer tick, asking Buildbucket for the build status
[05:17:26.174] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:26.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:89:0) after 1m0s
[05:18:26.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:89:0)
[05:18:26.249] Timer tick, asking Buildbucket for the build status
[05:18:26.693] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:26.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:90:0) after 1m0s
[05:19:26.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:90:0)
[05:19:26.724] Timer tick, asking Buildbucket for the build status
[05:19:26.957] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:26.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:91:0) after 1m0s
[05:20:26.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:91:0)
[05:20:26.955] Timer tick, asking Buildbucket for the build status
[05:20:27.216] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:27.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:92:0) after 1m0s
[05:21:27.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:92:0)
[05:21:27.243] Timer tick, asking Buildbucket for the build status
[05:21:27.497] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:27.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:93:0) after 1m0s
[05:22:27.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:93:0)
[05:22:27.580] Timer tick, asking Buildbucket for the build status
[05:22:27.739] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:27.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:94:0) after 1m0s
[05:23:27.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:94:0)
[05:23:27.968] Timer tick, asking Buildbucket for the build status
[05:23:28.032] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:28.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:95:0) after 1m0s
[05:24:28.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:95:0)
[05:24:28.149] Timer tick, asking Buildbucket for the build status
[05:24:28.220] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:28.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:96:0) after 1m0s
[05:25:28.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:96:0)
[05:25:28.303] Timer tick, asking Buildbucket for the build status
[05:25:28.372] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:28.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:97:0) after 1m0s
[05:26:28.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:97:0)
[05:26:28.538] Timer tick, asking Buildbucket for the build status
[05:26:28.785] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:28.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:98:0) after 1m0s
[05:27:28.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:98:0)
[05:27:28.810] Timer tick, asking Buildbucket for the build status
[05:27:28.879] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:28.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:99:0) after 1m0s
[05:28:28.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:99:0)
[05:28:28.979] Timer tick, asking Buildbucket for the build status
[05:28:29.055] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:29.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:100:0) after 1m0s
[05:29:29.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:100:0)
[05:29:29.079] Timer tick, asking Buildbucket for the build status
[05:29:29.167] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:29.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:101:0) after 1m0s
[05:30:29.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:101:0)
[05:30:29.219] Timer tick, asking Buildbucket for the build status
[05:30:29.450] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:29.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:102:0) after 1m0s
[05:31:29.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:102:0)
[05:31:29.460] Timer tick, asking Buildbucket for the build status
[05:31:29.552] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:29.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:103:0) after 1m0s
[05:32:29.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:103:0)
[05:32:29.573] Timer tick, asking Buildbucket for the build status
[05:32:29.650] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:29.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:104:0) after 1m0s
[05:33:29.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:104:0)
[05:33:29.708] Timer tick, asking Buildbucket for the build status
[05:33:29.789] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:29.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:105:0) after 1m0s
[05:34:29.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:105:0)
[05:34:29.865] Timer tick, asking Buildbucket for the build status
[05:34:30.028] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:30.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:106:0) after 1m0s
[05:35:30.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:106:0)
[05:35:30.141] Timer tick, asking Buildbucket for the build status
[05:35:30.395] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:30.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:107:0) after 1m0s
[05:36:30.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:107:0)
[05:36:30.515] Timer tick, asking Buildbucket for the build status
[05:36:30.893] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:30.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:108:0) after 1m0s
[05:37:30.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:108:0)
[05:37:30.920] Timer tick, asking Buildbucket for the build status
[05:37:31.017] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:31.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:109:0) after 1m0s
[05:38:31.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:109:0)
[05:38:31.096] Timer tick, asking Buildbucket for the build status
[05:38:31.308] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:31.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:110:0) after 1m0s
[05:39:31.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:110:0)
[05:39:31.341] Timer tick, asking Buildbucket for the build status
[05:39:31.500] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:31.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:111:0) after 1m0s
[05:40:31.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:111:0)
[05:40:31.519] Timer tick, asking Buildbucket for the build status
[05:40:31.594] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:31.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:112:0) after 1m0s
[05:41:31.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:112:0)
[05:41:31.615] Timer tick, asking Buildbucket for the build status
[05:41:31.932] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:31.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:113:0) after 1m0s
[05:42:31.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:113:0)
[05:42:31.959] Timer tick, asking Buildbucket for the build status
[05:42:32.031] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:32.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:114:0) after 1m0s
[05:43:32.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:114:0)
[05:43:32.063] Timer tick, asking Buildbucket for the build status
[05:43:32.430] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:32.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:115:0) after 1m0s
[05:44:32.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:115:0)
[05:44:32.485] Timer tick, asking Buildbucket for the build status
[05:44:32.563] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:32.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:116:0) after 1m0s
[05:45:32.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:116:0)
[05:45:32.583] Timer tick, asking Buildbucket for the build status
[05:45:33.000] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:33.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:117:0) after 1m0s
[05:46:33.020] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:117:0)
[05:46:33.020] Timer tick, asking Buildbucket for the build status
[05:46:33.122] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:33.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:118:0) after 1m0s
[05:47:33.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:118:0)
[05:47:33.143] Timer tick, asking Buildbucket for the build status
[05:47:33.236] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:33.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:119:0) after 1m0s
[05:48:33.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:119:0)
[05:48:33.258] Timer tick, asking Buildbucket for the build status
[05:48:33.361] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:33.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:120:0) after 1m0s
[05:49:33.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:120:0)
[05:49:33.395] Timer tick, asking Buildbucket for the build status
[05:49:33.719] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:33.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:121:0) after 1m0s
[05:50:33.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:121:0)
[05:50:33.792] Timer tick, asking Buildbucket for the build status
[05:50:33.879] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:33.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:122:0) after 1m0s
[05:51:33.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:122:0)
[05:51:33.905] Timer tick, asking Buildbucket for the build status
[05:51:34.424] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:34.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:123:0) after 1m0s
[05:52:34.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:123:0)
[05:52:34.437] Timer tick, asking Buildbucket for the build status
[05:52:34.709] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:34.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:124:0) after 1m0s
[05:53:34.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:124:0)
[05:53:34.791] Timer tick, asking Buildbucket for the build status
[05:53:35.046] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:35.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:125:0) after 1m0s
[05:54:35.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:125:0)
[05:54:35.070] Timer tick, asking Buildbucket for the build status
[05:54:35.370] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:35.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:126:0) after 1m0s
[05:55:35.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:126:0)
[05:55:35.454] Timer tick, asking Buildbucket for the build status
[05:55:35.541] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:35.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:127:0) after 1m0s
[05:56:35.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:127:0)
[05:56:35.573] Timer tick, asking Buildbucket for the build status
[05:56:35.664] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:35.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:128:0) after 1m0s
[05:57:35.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:128:0)
[05:57:35.694] Timer tick, asking Buildbucket for the build status
[05:57:35.772] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:35.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:129:0) after 1m0s
[05:58:35.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:129:0)
[05:58:35.845] Timer tick, asking Buildbucket for the build status
[05:58:35.948] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:35.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:130:0) after 1m0s
[05:59:36.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:130:0)
[05:59:36.011] Timer tick, asking Buildbucket for the build status
[05:59:36.311] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:36.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:131:0) after 1m0s
[06:00:36.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:131:0)
[06:00:36.394] Timer tick, asking Buildbucket for the build status
[06:00:36.490] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:36.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:132:0) after 1m0s
[06:01:38.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:132:0)
[06:01:38.546] Timer tick, asking Buildbucket for the build status
[06:01:38.647] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:38.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:133:0) after 1m0s
[06:02:38.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:133:0)
[06:02:38.784] Timer tick, asking Buildbucket for the build status
[06:02:39.139] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:39.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:134:0) after 1m0s
[06:03:39.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:134:0)
[06:03:39.194] Timer tick, asking Buildbucket for the build status
[06:03:39.289] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:39.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:135:0) after 1m0s
[06:04:39.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:135:0)
[06:04:39.469] Timer tick, asking Buildbucket for the build status
[06:04:39.826] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:39.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:136:0) after 1m0s
[06:05:39.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:136:0)
[06:05:39.957] Timer tick, asking Buildbucket for the build status
[06:05:40.046] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:40.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:137:0) after 1m0s
[06:06:40.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:137:0)
[06:06:40.094] Timer tick, asking Buildbucket for the build status
[06:06:40.188] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:40.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:138:0) after 1m0s
[06:07:40.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:138:0)
[06:07:40.183] Timer tick, asking Buildbucket for the build status
[06:07:40.541] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:40.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:139:0) after 1m0s
[06:08:41.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:139:0)
[06:08:41.873] Timer tick, asking Buildbucket for the build status
[06:08:41.983] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:41.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:140:0) after 1m0s
[06:09:42.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:140:0)
[06:09:42.892] Timer tick, asking Buildbucket for the build status
[06:09:43.018] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:43.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:141:0) after 1m0s
[06:10:43.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:141:0)
[06:10:43.090] Timer tick, asking Buildbucket for the build status
[06:10:43.417] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:43.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:142:0) after 1m0s
[06:11:43.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:142:0)
[06:11:43.460] Timer tick, asking Buildbucket for the build status
[06:11:43.813] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:43.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:143:0) after 1m0s
[06:12:43.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:143:0)
[06:12:43.920] Timer tick, asking Buildbucket for the build status
[06:12:44.010] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:44.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:144:0) after 1m0s
[06:13:44.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:144:0)
[06:13:44.114] Timer tick, asking Buildbucket for the build status
[06:13:44.188] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:44.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:145:0) after 1m0s
[06:14:44.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:145:0)
[06:14:44.236] Timer tick, asking Buildbucket for the build status
[06:14:44.498] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:44.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:146:0) after 1m0s
[06:15:44.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:146:0)
[06:15:44.584] Timer tick, asking Buildbucket for the build status
[06:15:44.662] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:44.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:147:0) after 1m0s
[06:16:44.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:147:0)
[06:16:44.736] Timer tick, asking Buildbucket for the build status
[06:16:44.838] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:44.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:148:0) after 1m0s
[06:17:45.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:148:0)
[06:17:45.007] Timer tick, asking Buildbucket for the build status
[06:17:45.085] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:45.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:149:0) after 1m0s
[06:18:45.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:149:0)
[06:18:45.206] Timer tick, asking Buildbucket for the build status
[06:18:45.404] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:45.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:150:0) after 1m0s
[06:19:45.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:150:0)
[06:19:45.468] Timer tick, asking Buildbucket for the build status
[06:19:45.564] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:45.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:151:0) after 1m0s
[06:20:45.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:151:0)
[06:20:45.734] Timer tick, asking Buildbucket for the build status
[06:20:46.322] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:46.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:152:0) after 1m0s
[06:21:47.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:152:0)
[06:21:47.418] Timer tick, asking Buildbucket for the build status
[06:21:47.531] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:47.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:153:0) after 1m0s
[06:22:47.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:153:0)
[06:22:47.728] Timer tick, asking Buildbucket for the build status
[06:22:47.908] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:47.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:154:0) after 1m0s
[06:23:47.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:154:0)
[06:23:47.976] Timer tick, asking Buildbucket for the build status
[06:23:48.310] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:48.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:155:0) after 1m0s
[06:24:48.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:155:0)
[06:24:48.393] Timer tick, asking Buildbucket for the build status
[06:24:48.470] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:48.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:156:0) after 1m0s
[06:25:48.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:156:0)
[06:25:48.589] Timer tick, asking Buildbucket for the build status
[06:25:48.728] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:48.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:157:0) after 1m0s
[06:26:48.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:157:0)
[06:26:48.781] Timer tick, asking Buildbucket for the build status
[06:26:49.120] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:49.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:158:0) after 1m0s
[06:27:49.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:158:0)
[06:27:49.158] Timer tick, asking Buildbucket for the build status
[06:27:49.437] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:49.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:159:0) after 1m0s
[06:28:49.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:159:0)
[06:28:49.459] Timer tick, asking Buildbucket for the build status
[06:28:49.546] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:49.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:160:0) after 1m0s
[06:29:49.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:160:0)
[06:29:49.586] Timer tick, asking Buildbucket for the build status
[06:29:49.685] Build 8854718438458537872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:49.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020148500615795648:161:0) after 1m0s
[06:30:37.865] Received PubSub notification, asking Buildbucket for the build status
[06:30:37.991] Build 8854718438458537872: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[06:30:37.991] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary": true,
    "canary_preference": "CANARY",
    "completed_ts": "1613889035805593",
    "created_by": "project:chromium",
    "created_ts": "1613879468441921",
    "failure_reason": "BUILD_FAILURE",
    "id": "8854718438458537872",
    "parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2fe97c5ae5b05fcdef7946f966f65ba6e706c7be\"}}",
    "project": "chromium",
    "result": "FAILURE",
    "result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- WebRtcSignalingMessengerTest.UnsuccessfulSendMessage_EmptyToken\"}, \"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\": \"2fe97c5ae5b05fcdef7946f966f65ba6e706c7be\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-56-xliu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22714, \"got_angle_revision\": \"c03a42358c05ceedd15f0fca50292b756c2fad57\", \"got_dawn_revision\": \"1258e245a978083cab0b707c84dea814eadb3fbb\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"2fe97c5ae5b05fcdef7946f966f65ba6e706c7be\", \"got_revision_cp\": \"refs/heads/master@{#856131}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"d85a7a27b27269741a779a72f33436b83d98687c\", \"got_v8_revision\": \"2430d8fffa7d4f8a0992bcb5eb3725e5367cd9ac\", \"got_v8_revision_cp\": \"refs/heads/9.0.229@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2fe97c5ae5b05fcdef7946f966f65ba6e706c7be\", \"swarm_hashes_refs/heads/master(at){#856131}_without_patch\": {\"absl_hardening_tests\": \"6d780892097b0a8b3d8e7088fd6a166f25a37196\", \"accessibility_unittests\": \"b132478e2e117d86d7fef14cade085ab14153de5\", \"angle_unittests\": \"0dec33fd4c2d874e733c6fa4253ff25fa7c246de\", \"app_list_unittests\": \"5a4c480638786430b198204cd1525ca244cc019e\", \"app_shell_unittests\": \"8c7a1ef6a6d1338d9361ea911acb551d8c758ca5\", \"ash_unittests\": \"69c8542299d689885cc9fa4ec07d574a482dea9d\", \"aura_unittests\": \"d35736c8fdb0ae82015e1a91d7dce87dd136ddb3\", \"base_unittests\": \"c1d32eb7d821f5b706cc8dbf6b5c13772c84dae6\", \"base_util_unittests\": \"d1cd169f6aab1216bcb2248a5d45b473ab3aaa70\", \"blink_common_unittests\": \"0290bbd2a456f321b877172ea6b5aa5268d7b0eb\", \"blink_fuzzer_unittests\": \"56d5ccee11677be669e8b42f37a8c4f3d2e8ad50\", \"blink_heap_unittests\": \"488dac976f27bdae8fb166f1f932506df4f6b59b\", \"blink_platform_unittests\": \"08167fde9e9bb659b5ee880817de5139ae0fda3e\", \"blink_unittests\": \"a35b4788f69372b3cb6d086e179fecf34e3b5c55\", \"boringssl_crypto_tests\": \"864d73ae1929e5d268c9b176aca6fcff14b5be78\", \"boringssl_ssl_tests\": \"65d26cec7dad054d40fae3cb71fd465f0e154fbc\", \"browser_tests\": \"45e8e8fce28cb4903312f9626695d020fe01e677\", \"capture_unittests\": \"544fba0d56119b3079b7fc183ee71f8d022a178b\", \"cast_unittests\": \"74c0c7bda99325dc128e074b60bf0fc6dcb95d1c\", \"cc_unittests\": \"153fa248487032a84dcff7470665091343f2d0dd\", \"chrome_app_unittests\": \"f79cb97b9b8982c6413e9dd3d63c778856a9b9dc\", \"chromedriver_unittests\": \"811626621efd377ca3535b38b53a4f0ed7408eab\", \"chromeos_components_unittests\": \"f77305e285fbf0146da93119bd8273c798f2bca3\", \"chromeos_unittests\": \"a40d53e9dbf21cb9eeace63caffbc7438c2921e6\", \"components_browsertests\": \"a337d288b2af266daeeff741d0456e7baee2cac1\", \"components_unittests\": \"32723fc71e99af41272127d9838f4bb9544f7e4c\", \"compositor_unittests\": \"5157fbb8683b19c91656e76b56db635bb2b5d6a9\", \"content_browsertests\": \"be62451aa5154dfbad2701880ea1ba143c157b9b\", \"content_unittests\": \"2de654d614befbeb095a115f5016da166985238e\", \"crashpad_tests\": \"a261fd766d05c991fcdd914b70c3525eacafd634\", \"crypto_unittests\": \"8838cceeb1ddffe9216e1c5464de76bf28e0b280\", \"dbus_unittests\": \"23f7c365e64f2d036622a1c45945e2a4f673144b\", \"device_unittests\": \"0ab42d605959560c60aa7ea55041894af150f5ca\", \"display_unittests\": \"e60b29d04869c054f80fc9cd763feddaf71a0223\", \"events_unittests\": \"2842fe4bf255aab30331050967155e6a255dea4b\", \"exo_unittests\": \"8190fc79e5847e3136322a727a3dd1bf4f024d20\", \"extensions_browsertests\": \"eebe91f9860c6492927768e6f6f01d8931873c88\", \"extensions_unittests\": \"177964bc59460adda781606b870651caa2254044\", \"filesystem_service_unittests\": \"1f7f1685f3fc9a381090a1bdc04021689bf7952b\", \"gcm_unit_tests\": \"12f59550c76b4b1d46c4a925dcbce441adca812b\", \"gfx_unittests\": \"eddf0cc625930887dc85881f8dd030e9fc0adc2c\", \"gin_unittests\": \"a8a0443c5a52424445239f93123094c788a7dcca\", \"gl_unittests_ozone\": \"de4951c0a5aea5274518d456b0985810ccfbab0d\", \"google_apis_unittests\": \"04927da3cb5d1e592dc46f2325a91986a89feb5c\", \"gpu_unittests\": \"df0016fffa3043265dca8b5777fd36b6b10518be\", \"gwp_asan_unittests\": \"b034a11b8e935a6acdf55ef8084b8cc7f26fb554\", \"interactive_ui_tests\": \"9590cd754b44954c21cd9a1dc3047139ac94e94b\", \"ipc_tests\": \"812316b267e9574d9d12a3404c95224ad3e43bf3\", \"jingle_unittests\": \"abcf60273f74304a74a42bd9df710a660fec9e3f\", \"keyboard_unittests\": \"f0004a0fb9610f6c87a99b2a777bacdb0fd13ede\", \"latency_unittests\": \"0fb75c669e0c41c1acb4f0c49727e84aa9349c1b\", \"libjingle_xmpp_unittests\": \"a69fff722d1d62770e55748d219ff67b7aaf6f55\", \"liburlpattern_unittests\": \"ffe5981e611ffbcf6bb9d8f3077b8e3a95fd46f5\", \"media_blink_unittests\": \"aced4b3f577afff8c32be7ae26a7f40284117c62\", \"media_unittests\": \"98e8b9453293cd44658436ba7dbc8c3a41672068\", \"message_center_unittests\": \"927416aba2eaf3927b365862bfc9a444531d1753\", \"midi_unittests\": \"8b522a1c11986ca1a83849cb72fd563c931fa388\", \"mojo_core_unittests\": \"f95e01d89210511d7eeba8f9a63243aa4b488f8c\", \"mojo_unittests\": \"8a4586375c17ef3f8c2e0f7f9855cb635ff171bd\", \"nacl_helper_nonsfi_unittests\": \"2c8c547eae5cddc77d5f0c6cdddc5939c1e3f9e4\", \"nacl_loader_unittests\": \"bfae5ae685156eb3a4eca18945833618627abd47\", \"native_theme_unittests\": \"180869a2d5249b60c2e9022123787f9fc42c3df3\", \"net_unittests\": \"d71a4d507e7521cbdc63eb66d9b7e451010fcf16\", \"ozone_gl_unittests\": \"998de06409694cd5690a27342452b5fea22d3714\", \"ozone_unittests\": \"8cf055aa73ad63642483bcb616c04de5985793ff\", \"ozone_x11_unittests\": \"f2cfe95722ab9eb019dd0136d6a0b3875d59accd\", \"pdf_unittests\": \"57035c9cff0488b6b15bb6e65b997d15b992658e\", \"perfetto_unittests\": \"b149e3bfc821dc2eaac480c73bc473a89e2932e4\", \"ppapi_unittests\": \"90aba5b5586525ed21432d04286abf2ee063042c\", \"printing_unittests\": \"f4c2f0b6ccba1fda03408ef29c5ab3d722801a6a\", \"remoting_unittests\": \"d2bb4c85595f3b333b5b7993dd78d2ed9a6dd4f6\", \"sandbox_linux_unittests\": \"a939e50da95a5b661c22809e8da8c2aadd442fa3\", \"service_manager_unittests\": \"7edd8a6eb17dd0dc6e7eec4fb601fda3dfad493e\", \"services_unittests\": \"88a3167dedc338c5209aff75c0a884c8a5a77d54\", \"shell_dialogs_unittests\": \"76a86b3d6cf7a1073ba0b7285161290cafe783a8\", \"shell_encryption_unittests\": \"dfb79ce48a16f05a759e1619725d287cbe9a83c2\", \"skia_unittests\": \"df4da8f5a5fa9e9fa1b992b5e39b974fd55289f7\", \"snapshot_unittests\": \"47c0eefad70d8751342f1e7613da6498869ce958\", \"sql_unittests\": \"bfc3fe2e3d00e9fba72faaa49b4de540adc8c0b3\", \"storage_unittests\": \"25fad2436a179a6612f7e740d03b995af271ab85\", \"sync_integration_tests\": \"4b1860e14705732b25d84fc6226d5b6aa95f77c9\", \"traffic_annotation_auditor_unittests\": \"21b5611b4f1da617614541ae1fc6a402d150342d\", \"ui_base_unittests\": \"855d851a8a4f91ad5460b5f2367649ec26bf2158\", \"ui_chromeos_unittests\": \"9f50b6c634917eb50dbe0b02ae8523b6b2403f18\", \"ui_touch_selection_unittests\": \"21db139fb363702b61a32449991cfdbf81c52d8c\", \"unit_tests\": \"10d74fc3b994722fcdbe39981c4129b6472c7715\", \"url_unittests\": \"63727c764cc4d2149ace2f300118e64af52a4df3\", \"usage_time_limit_unittests\": \"60ce9a130db9f3e82d94b415595171f6623f8a45\", \"views_unittests\": \"ad919f261c801209af99c9ce6271b1642595fc0a\", \"viz_unittests\": \"638a4e8962b211136bf05d955fa14951a83a4d0c\", \"wm_unittests\": \"ab7d334f50eb758df8ca2fdf29fe1e435e0efeaa\", \"wtf_unittests\": \"f4d9c2a50fd75057b76ba5cf19c88933ffda92aa\", \"zlib_unittests\": \"8e4cfb6c91034add6c3e362d3c21ca6e3c08c57d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_47c3ec4238d3b3d0448e41826f5b2c1435e77a4255b8c93aa27077a59a7a5a67_v2\", \"builder_544ce64b59aa2a62f93b2d1058d8c643105c17650fa0dc2da4c94ddccafb95f6_v2\", \"builder_8f7e40299f74ff9d94767563834f98f87bf45cac7401cd036aab5fd865cb3b58_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_a2d0deb167035deb42f2d46ec8df60bd17682f54960fd7d9f79bcb4fddee3411_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-56-xliu\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- WebRtcSignalingMessengerTest.UnsuccessfulSendMessage_EmptyToken\"}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1613882212208171",
    "status": "COMPLETED",
    "status_changed_ts": "1613882212788337",
    "tags": [
      "build_address:luci.chromium.ci/linux-chromeos-dbg/22714",
      "builder:linux-chromeos-dbg",
      "buildset:commit/git/2fe97c5ae5b05fcdef7946f966f65ba6e706c7be",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2fe97c5ae5b05fcdef7946f966f65ba6e706c7be",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9020148500615795648",
      "scheduler_job_id:chromium/linux-chromeos-dbg",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854718438458537872/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:os:Linux",
      "swarming_tag:recipe_name:chromium",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:51db87ee4a5c3010",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1613889036029984",
    "url": "https://ci.chromium.org/b/8854718438458537872",
    "utcnow_ts": "1613889037982108"
  }
}
[06:30:37.991] Invocation finished in 2h39m30.991051286s with status FAILED