[17:43:12.346] New invocation is queued and will start shortly
[17:43:13.472] Starting the invocation (attempt 1)
[17:43:13.506] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:43:13.506] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:43:13.506] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028159280125697456",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"679696cfbf5fce8fca4a513208cf44d4e99596c1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9028159280125697456",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/679696cfbf5fce8fca4a513208cf44d4e99596c1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/679696cfbf5fce8fca4a513208cf44d4e99596c1",
"gitiles_ref:refs/heads/master"
]
}
[17:43:14.025] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606239793587192",
"id": "8862729218157744480",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"679696cfbf5fce8fca4a513208cf44d4e99596c1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606239793919623",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21453",
"builder:linux-chromeos-dbg",
"buildset:commit/git/679696cfbf5fce8fca4a513208cf44d4e99596c1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/679696cfbf5fce8fca4a513208cf44d4e99596c1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028159280125697456",
"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/8862729218157744480/+/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": "1606239793919731",
"url": "https://ci.chromium.org/b/8862729218157744480",
"utcnow_ts": "1606239794016642"
}
}
[17:43:14.025] Task URL: https://ci.chromium.org/b/8862729218157744480
[17:43:14.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:2:0) after 1m0s
[17:43:28.383] Received PubSub notification, asking Buildbucket for the build status
[17:43:28.718] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:14.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:2:0)
[17:44:14.083] Timer tick, asking Buildbucket for the build status
[17:44:14.188] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:14.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:4:0) after 1m0s
[17:45:14.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:4:0)
[17:45:14.221] Timer tick, asking Buildbucket for the build status
[17:45:14.374] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:14.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:5:0) after 1m0s
[17:46:14.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:5:0)
[17:46:14.419] Timer tick, asking Buildbucket for the build status
[17:46:14.477] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:14.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:6:0) after 1m0s
[17:47:14.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:6:0)
[17:47:14.545] Timer tick, asking Buildbucket for the build status
[17:47:14.682] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:14.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:7:0) after 1m0s
[17:48:14.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:7:0)
[17:48:14.834] Timer tick, asking Buildbucket for the build status
[17:48:15.203] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:15.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:8:0) after 1m0s
[17:49:15.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:8:0)
[17:49:15.391] Timer tick, asking Buildbucket for the build status
[17:49:15.499] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:15.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:9:0) after 1m0s
[17:50:16.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:9:0)
[17:50:16.010] Timer tick, asking Buildbucket for the build status
[17:50:16.191] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:16.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:10:0) after 1m0s
[17:51:16.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:10:0)
[17:51:16.322] Timer tick, asking Buildbucket for the build status
[17:51:16.721] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:16.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:11:0) after 1m0s
[17:52:16.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:11:0)
[17:52:16.876] Timer tick, asking Buildbucket for the build status
[17:52:16.930] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:16.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:12:0) after 1m0s
[17:53:17.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:12:0)
[17:53:17.006] Timer tick, asking Buildbucket for the build status
[17:53:17.150] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:17.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:13:0) after 1m0s
[17:54:17.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:13:0)
[17:54:17.284] Timer tick, asking Buildbucket for the build status
[17:54:17.371] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:17.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:14:0) after 1m0s
[17:55:17.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:14:0)
[17:55:17.539] Timer tick, asking Buildbucket for the build status
[17:55:17.856] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:17.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:15:0) after 1m0s
[17:56:17.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:15:0)
[17:56:17.969] Timer tick, asking Buildbucket for the build status
[17:56:18.058] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:18.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:16:0) after 1m0s
[17:57:18.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:16:0)
[17:57:18.166] Timer tick, asking Buildbucket for the build status
[17:57:18.259] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:18.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:17:0) after 1m0s
[17:58:18.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:17:0)
[17:58:18.333] Timer tick, asking Buildbucket for the build status
[17:58:18.634] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:18.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:18:0) after 1m0s
[17:59:18.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:18:0)
[17:59:18.893] Timer tick, asking Buildbucket for the build status
[17:59:18.983] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:18.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:19:0) after 1m0s
[18:00:19.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:19:0)
[18:00:19.196] Timer tick, asking Buildbucket for the build status
[18:00:19.342] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:19.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:20:0) after 1m0s
[18:01:19.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:20:0)
[18:01:19.411] Timer tick, asking Buildbucket for the build status
[18:01:19.500] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:19.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:21:0) after 1m0s
[18:02:19.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:21:0)
[18:02:19.573] Timer tick, asking Buildbucket for the build status
[18:02:19.925] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:19.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:22:0) after 1m0s
[18:03:20.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:22:0)
[18:03:20.039] Timer tick, asking Buildbucket for the build status
[18:03:20.185] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:20.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:23:0) after 1m0s
[18:04:20.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:23:0)
[18:04:20.273] Timer tick, asking Buildbucket for the build status
[18:04:20.355] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:20.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:24:0) after 1m0s
[18:05:20.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:24:0)
[18:05:20.421] Timer tick, asking Buildbucket for the build status
[18:05:20.614] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:20.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:25:0) after 1m0s
[18:06:20.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:25:0)
[18:06:20.731] Timer tick, asking Buildbucket for the build status
[18:06:20.826] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:20.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:26:0) after 1m0s
[18:07:20.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:26:0)
[18:07:20.890] Timer tick, asking Buildbucket for the build status
[18:07:20.998] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:20.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:27:0) after 1m0s
[18:08:21.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:27:0)
[18:08:21.038] Timer tick, asking Buildbucket for the build status
[18:08:21.196] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:21.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:28:0) after 1m0s
[18:09:21.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:28:0)
[18:09:21.268] Timer tick, asking Buildbucket for the build status
[18:09:21.392] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:21.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:29:0) after 1m0s
[18:10:21.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:29:0)
[18:10:21.436] Timer tick, asking Buildbucket for the build status
[18:10:21.529] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:21.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:30:0) after 1m0s
[18:11:21.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:30:0)
[18:11:21.546] Timer tick, asking Buildbucket for the build status
[18:11:21.697] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:21.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:31:0) after 1m0s
[18:12:21.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:31:0)
[18:12:21.754] Timer tick, asking Buildbucket for the build status
[18:12:21.849] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:21.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:32:0) after 1m0s
[18:13:21.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:32:0)
[18:13:21.903] Timer tick, asking Buildbucket for the build status
[18:13:22.039] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:22.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:33:0) after 1m0s
[18:14:22.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:33:0)
[18:14:22.093] Timer tick, asking Buildbucket for the build status
[18:14:22.238] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:22.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:34:0) after 1m0s
[18:15:22.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:34:0)
[18:15:22.410] Timer tick, asking Buildbucket for the build status
[18:15:22.507] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:22.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:35:0) after 1m0s
[18:16:22.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:35:0)
[18:16:22.606] Timer tick, asking Buildbucket for the build status
[18:16:22.696] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:22.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:36:0) after 1m0s
[18:17:22.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:36:0)
[18:17:22.778] Timer tick, asking Buildbucket for the build status
[18:17:22.878] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:22.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:37:0) after 1m0s
[18:18:23.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:37:0)
[18:18:23.052] Timer tick, asking Buildbucket for the build status
[18:18:23.196] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:23.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:38:0) after 1m0s
[18:19:23.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:38:0)
[18:19:23.335] Timer tick, asking Buildbucket for the build status
[18:19:23.439] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:23.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:39:0) after 1m0s
[18:20:23.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:39:0)
[18:20:23.475] Timer tick, asking Buildbucket for the build status
[18:20:24.075] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:24.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:40:0) after 1m0s
[18:21:24.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:40:0)
[18:21:24.232] Timer tick, asking Buildbucket for the build status
[18:21:24.450] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:24.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:41:0) after 1m0s
[18:22:24.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:41:0)
[18:22:24.590] Timer tick, asking Buildbucket for the build status
[18:22:24.688] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:24.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:42:0) after 1m0s
[18:23:24.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:42:0)
[18:23:24.837] Timer tick, asking Buildbucket for the build status
[18:23:24.939] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:24.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:43:0) after 1m0s
[18:24:25.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:43:0)
[18:24:25.034] Timer tick, asking Buildbucket for the build status
[18:24:25.355] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:25.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:44:0) after 1m0s
[18:25:25.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:44:0)
[18:25:25.378] Timer tick, asking Buildbucket for the build status
[18:25:25.460] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:25.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:45:0) after 1m0s
[18:26:25.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:45:0)
[18:26:25.534] Timer tick, asking Buildbucket for the build status
[18:26:25.616] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:25.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:46:0) after 1m0s
[18:27:25.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:46:0)
[18:27:25.689] Timer tick, asking Buildbucket for the build status
[18:27:26.028] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:26.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:47:0) after 1m0s
[18:28:26.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:47:0)
[18:28:26.015] Timer tick, asking Buildbucket for the build status
[18:28:26.153] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:26.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:48:0) after 1m0s
[18:29:26.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:48:0)
[18:29:26.185] Timer tick, asking Buildbucket for the build status
[18:29:26.307] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:26.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:49:0) after 1m0s
[18:30:26.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:49:0)
[18:30:26.373] Timer tick, asking Buildbucket for the build status
[18:30:26.511] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:26.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:50:0) after 1m0s
[18:31:26.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:50:0)
[18:31:26.538] Timer tick, asking Buildbucket for the build status
[18:31:26.660] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:26.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:51:0) after 1m0s
[18:32:26.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:51:0)
[18:32:26.721] Timer tick, asking Buildbucket for the build status
[18:32:26.844] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:26.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:52:0) after 1m0s
[18:33:26.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:52:0)
[18:33:26.915] Timer tick, asking Buildbucket for the build status
[18:33:27.076] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:27.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:53:0) after 1m0s
[18:34:27.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:53:0)
[18:34:27.067] Timer tick, asking Buildbucket for the build status
[18:34:27.458] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:27.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:54:0) after 1m0s
[18:35:27.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:54:0)
[18:35:27.511] Timer tick, asking Buildbucket for the build status
[18:35:27.949] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:27.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:55:0) after 1m0s
[18:36:27.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:55:0)
[18:36:27.976] Timer tick, asking Buildbucket for the build status
[18:36:28.148] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:28.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:56:0) after 1m0s
[18:37:28.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:56:0)
[18:37:28.236] Timer tick, asking Buildbucket for the build status
[18:37:28.398] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:28.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:57:0) after 1m0s
[18:38:28.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:57:0)
[18:38:28.429] Timer tick, asking Buildbucket for the build status
[18:38:28.611] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:28.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:58:0) after 1m0s
[18:39:28.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:58:0)
[18:39:28.676] Timer tick, asking Buildbucket for the build status
[18:39:28.743] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:28.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:59:0) after 1m0s
[18:40:28.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:59:0)
[18:40:28.851] Timer tick, asking Buildbucket for the build status
[18:40:29.145] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:29.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:60:0) after 1m0s
[18:41:29.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:60:0)
[18:41:29.199] Timer tick, asking Buildbucket for the build status
[18:41:29.323] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:29.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:61:0) after 1m0s
[18:42:29.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:61:0)
[18:42:29.455] Timer tick, asking Buildbucket for the build status
[18:42:29.579] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:29.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:62:0) after 1m0s
[18:43:29.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:62:0)
[18:43:29.607] Timer tick, asking Buildbucket for the build status
[18:43:29.720] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:29.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:63:0) after 1m0s
[18:44:29.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:63:0)
[18:44:29.758] Timer tick, asking Buildbucket for the build status
[18:44:29.848] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:29.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:64:0) after 1m0s
[18:45:29.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:64:0)
[18:45:29.902] Timer tick, asking Buildbucket for the build status
[18:45:30.693] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:30.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:65:0) after 1m0s
[18:46:30.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:65:0)
[18:46:30.721] Timer tick, asking Buildbucket for the build status
[18:46:32.794] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:32.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:66:0) after 1m0s
[18:47:32.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:66:0)
[18:47:32.929] Timer tick, asking Buildbucket for the build status
[18:47:33.069] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:33.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:67:0) after 1m0s
[18:48:33.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:67:0)
[18:48:33.155] Timer tick, asking Buildbucket for the build status
[18:48:33.286] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:33.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:68:0) after 1m0s
[18:49:33.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:68:0)
[18:49:33.353] Timer tick, asking Buildbucket for the build status
[18:49:34.006] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:34.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:69:0) after 1m0s
[18:50:34.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:69:0)
[18:50:34.066] Timer tick, asking Buildbucket for the build status
[18:50:34.814] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:34.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:70:0) after 1m0s
[18:51:34.991] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:70:0)
[18:51:34.991] Timer tick, asking Buildbucket for the build status
[18:51:35.085] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:35.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:71:0) after 1m0s
[18:52:35.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:71:0)
[18:52:35.168] Timer tick, asking Buildbucket for the build status
[18:52:35.281] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:35.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:72:0) after 1m0s
[18:53:35.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:72:0)
[18:53:35.329] Timer tick, asking Buildbucket for the build status
[18:53:37.624] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:37.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:73:0) after 1m0s
[18:54:37.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:73:0)
[18:54:37.667] Timer tick, asking Buildbucket for the build status
[18:54:37.919] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:37.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:74:0) after 1m0s
[18:55:37.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:74:0)
[18:55:37.934] Timer tick, asking Buildbucket for the build status
[18:55:38.007] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:38.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:75:0) after 1m0s
[18:56:38.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:75:0)
[18:56:38.032] Timer tick, asking Buildbucket for the build status
[18:56:38.113] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:38.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:76:0) after 1m0s
[18:57:38.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:76:0)
[18:57:38.205] Timer tick, asking Buildbucket for the build status
[18:57:38.528] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:38.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:77:0) after 1m0s
[18:58:38.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:77:0)
[18:58:38.614] Timer tick, asking Buildbucket for the build status
[18:58:38.736] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:38.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:78:0) after 1m0s
[18:59:38.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:78:0)
[18:59:38.770] Timer tick, asking Buildbucket for the build status
[18:59:38.850] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:38.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:79:0) after 1m0s
[19:00:38.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:79:0)
[19:00:38.980] Timer tick, asking Buildbucket for the build status
[19:00:39.141] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:39.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:80:0) after 1m0s
[19:01:39.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:80:0)
[19:01:39.216] Timer tick, asking Buildbucket for the build status
[19:01:40.279] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:40.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:81:0) after 1m0s
[19:02:40.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:81:0)
[19:02:40.377] Timer tick, asking Buildbucket for the build status
[19:02:40.496] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:40.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:82:0) after 1m0s
[19:03:40.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:82:0)
[19:03:40.567] Timer tick, asking Buildbucket for the build status
[19:03:40.705] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:40.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:83:0) after 1m0s
[19:04:40.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:83:0)
[19:04:40.766] Timer tick, asking Buildbucket for the build status
[19:04:40.867] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:40.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:84:0) after 1m0s
[19:05:40.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:84:0)
[19:05:40.864] Timer tick, asking Buildbucket for the build status
[19:05:41.030] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:41.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:85:0) after 1m0s
[19:06:41.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:85:0)
[19:06:41.128] Timer tick, asking Buildbucket for the build status
[19:06:41.653] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:41.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:86:0) after 1m0s
[19:07:41.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:86:0)
[19:07:41.765] Timer tick, asking Buildbucket for the build status
[19:07:41.836] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:41.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:87:0) after 1m0s
[19:08:41.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:87:0)
[19:08:41.855] Timer tick, asking Buildbucket for the build status
[19:08:42.407] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:42.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:88:0) after 1m0s
[19:09:42.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:88:0)
[19:09:42.598] Timer tick, asking Buildbucket for the build status
[19:09:42.825] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:42.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:89:0) after 1m0s
[19:10:42.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:89:0)
[19:10:42.885] Timer tick, asking Buildbucket for the build status
[19:10:42.979] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:42.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:90:0) after 1m0s
[19:11:42.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:90:0)
[19:11:42.999] Timer tick, asking Buildbucket for the build status
[19:11:43.300] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:43.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:91:0) after 1m0s
[19:12:43.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:91:0)
[19:12:43.342] Timer tick, asking Buildbucket for the build status
[19:12:43.439] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:43.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:92:0) after 1m0s
[19:13:43.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:92:0)
[19:13:43.469] Timer tick, asking Buildbucket for the build status
[19:13:43.616] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:43.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:93:0) after 1m0s
[19:14:43.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:93:0)
[19:14:43.681] Timer tick, asking Buildbucket for the build status
[19:14:43.922] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:43.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:94:0) after 1m0s
[19:15:43.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:94:0)
[19:15:43.968] Timer tick, asking Buildbucket for the build status
[19:15:44.086] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:44.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:95:0) after 1m0s
[19:16:44.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:95:0)
[19:16:44.119] Timer tick, asking Buildbucket for the build status
[19:16:45.655] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:45.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:96:0) after 1m0s
[19:17:45.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:96:0)
[19:17:45.732] Timer tick, asking Buildbucket for the build status
[19:17:45.855] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:45.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:97:0) after 1m0s
[19:18:45.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:97:0)
[19:18:45.926] Timer tick, asking Buildbucket for the build status
[19:18:46.145] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:46.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:98:0) after 1m0s
[19:19:46.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:98:0)
[19:19:46.181] Timer tick, asking Buildbucket for the build status
[19:19:46.283] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:46.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:99:0) after 1m0s
[19:20:46.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:99:0)
[19:20:46.410] Timer tick, asking Buildbucket for the build status
[19:20:46.514] Build 8862729218157744480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:46.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028159280125697456:100:0) after 1m0s
[19:21:32.344] Received PubSub notification, asking Buildbucket for the build status
[19:21:32.596] Build 8862729218157744480: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:21:32.597] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606245690907846",
"created_by": "project:chromium",
"created_ts": "1606239793587192",
"id": "8862729218157744480",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"679696cfbf5fce8fca4a513208cf44d4e99596c1\"}}",
"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\": \"679696cfbf5fce8fca4a513208cf44d4e99596c1\", \"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-131-omak\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21453, \"got_angle_revision\": \"084b862ba31bd6134158aa8c5c4fb86d926982a5\", \"got_dawn_revision\": \"03badec5d73ab4138f798b94221546c496177a09\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"679696cfbf5fce8fca4a513208cf44d4e99596c1\", \"got_revision_cp\": \"refs/heads/master@{#830615}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"43bb60e1fa119d80b449c6550dd2b72328b101b9\", \"got_v8_revision\": \"4dbfe4396ea0ba7b275d4a24e236ebebcd1b7811\", \"got_v8_revision_cp\": \"refs/heads/8.9.40@{#1}\", \"got_webrtc_revision\": \"3f77eb468fc4a9a7f5e2751d3d3cbbda38e95082\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32683}\", \"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\": \"679696cfbf5fce8fca4a513208cf44d4e99596c1\", \"swarm_hashes_refs/heads/master(at){#830615}_without_patch\": {\"absl_hardening_tests\": \"358c257a29b73af385de087eaf4aec896317988a\", \"accessibility_unittests\": \"2b850fa82ee03d60fa16be120601891795aeacf2\", \"angle_unittests\": \"33f4833b763f1986ad30cd0d89b27e75af13d289\", \"app_list_unittests\": \"b8266e33ea24dc6bd392ac676f0b7395117b06ea\", \"app_shell_unittests\": \"ce8a83cb80a91758ce97eb0b84357c6d58602ecf\", \"ash_unittests\": \"4377678903050a7de958b04f1373a58c8b4bcb96\", \"aura_unittests\": \"59c5abe783fcf6e015787081e4d06fe32fe35876\", \"base_unittests\": \"44ba9430448428bae5488b2a3a66a12636881850\", \"base_util_unittests\": \"d1f3cced03a11bff7bc74552cdcd3436d77773c5\", \"blink_common_unittests\": \"d4938683e5e7bc5975e93bef325784aaf5b79d0f\", \"blink_fuzzer_unittests\": \"c7ac08625f00008f80d97e5ddbc5f4440a658f5a\", \"blink_heap_unittests\": \"24fc7f57cbb0d02acfa136df82b3078d606118a4\", \"blink_platform_unittests\": \"b6892ac2628a54e768b1f3509cb9ae77ce6fc93c\", \"blink_unittests\": \"2cbea718c5eed77dd53ef9cf2a87e573091b875a\", \"boringssl_crypto_tests\": \"2080169089121f3bc6c062d8160640221fdcbce6\", \"boringssl_ssl_tests\": \"8704d157e72519c0f703329a5a78b3d5f246efc2\", \"browser_tests\": \"631649abe612ea97a4238f737dd699a05bf21251\", \"capture_unittests\": \"173ff4463fa7368fd7da069043535aa7be14c794\", \"cast_unittests\": \"84273161802d99e359257862898cfcb3aa5edbdf\", \"cc_unittests\": \"b7173a2a2a71f159e05289e0d3188e2479a4365f\", \"chrome_app_unittests\": \"cfb922a83265471d781947578c56de08c2449e66\", \"chromedriver_unittests\": \"9d441be597f36a94f57ce28d9bf8acb58f269a52\", \"chromeos_components_unittests\": \"441b1b5a0f78f56f8560005b786e3681e7b7910f\", \"chromeos_unittests\": \"0b8c5f1d902df6a865b1c072e3b3a2bbcd2a4da3\", \"components_browsertests\": \"a882f2002a3699d472bfcdde8e5f28358d06f045\", \"components_unittests\": \"b3fd101e5f94fcb40a5e927f939468f4c7ebe6c7\", \"compositor_unittests\": \"874f5639792ec826923652ca8644217021974c58\", \"content_browsertests\": \"0678f33ebc93f6efc3876979d88ee5898c344539\", \"content_unittests\": \"9c9f5b5e26df26a1e1d5b10375bb1da9ed4ba2c9\", \"crashpad_tests\": \"55f259d831363e9726bdf78f34f1dfaf3cab8bf1\", \"crypto_unittests\": \"382fb3ec3f72aafc7245da5edbb8470a07a7650d\", \"dbus_unittests\": \"33af36288ceebb111e69b44d323a41a1a4c8c886\", \"device_unittests\": \"c3ec001924d8bca1e41ad11c662296a971650049\", \"display_unittests\": \"ecfa67fa16b2aa77cbd20a80d8a6357e58bf10f4\", \"events_unittests\": \"66b9b869c7e1c563260080b9d3d58e4c1df5b35a\", \"exo_unittests\": \"e39df8df69ac792148fafb92de8dfae64500e02c\", \"extensions_browsertests\": \"78f2f9504422555959f6eb303b17c3b7b8de3810\", \"extensions_unittests\": \"2555a3d71aaf3af9edc99dc2cfa1e6934343b403\", \"filesystem_service_unittests\": \"a01bc8245064540e48ac8fcf0d8593442d2110e6\", \"gcm_unit_tests\": \"d7b824537db88c7791c9dbbfa15870aac3f3d6ea\", \"gfx_unittests\": \"e1281707353fff90ed05530709eb3f3bed887b5b\", \"gin_unittests\": \"d613f4143464d8eaa5f1eb6d265889fd1492fbe8\", \"gl_unittests_ozone\": \"cf505e259080d777d6f1db1b20394fdd809fdb87\", \"google_apis_unittests\": \"a423647343b692e35ef3417ccebd6ae979425050\", \"gpu_unittests\": \"56f0ad712d383f900f5317bd148d3741992e8b10\", \"gwp_asan_unittests\": \"151e9c7e9eaec060fa7f85a730be7404737dd4a4\", \"interactive_ui_tests\": \"12b4745dc7557b66a2341182c8de42075e8d1b76\", \"ipc_tests\": \"9caf8c74b390332843c92a3c132ad5b7b66c5f5e\", \"jingle_unittests\": \"f67e9eaa4c16a22b97b63767b5459f39e7a0b19d\", \"keyboard_unittests\": \"f29038d4eab25e4ef70a8263107ec0a535064222\", \"latency_unittests\": \"374aa539ed5ed61be94fbb3eb9df58b78d165207\", \"libjingle_xmpp_unittests\": \"df200ef48cb68baaf90bc45ad229d050d48f4d8f\", \"liburlpattern_unittests\": \"88ba65862ca3793cfc151da91352d2d11fa8128c\", \"media_blink_unittests\": \"6aa9e22493894c6cd4bf9e3d574361fcb8e5ca7d\", \"media_unittests\": \"db4f049e0082f4a79cd79478337906f272f99375\", \"message_center_unittests\": \"c81ba3b67b7250e2ad8fc231ce2e0dcd65980e89\", \"midi_unittests\": \"86d280a550566af902e80ec0f7420485e1ff82ff\", \"mojo_core_unittests\": \"27aa5d5fab1b9f5dbdbdcf0bad48f1642ca44558\", \"mojo_unittests\": \"c89eba01c0fb84a97eb32df0e530cbfd9178215b\", \"nacl_helper_nonsfi_unittests\": \"809c7c28a39696ad1af5f2f3e5a29c58e20bc0ad\", \"nacl_loader_unittests\": \"b2255726e5dc772a367fa1f96c77679740c7ea3d\", \"native_theme_unittests\": \"83e96da84381cdbaa407766cb386baa41fa74062\", \"net_unittests\": \"22e99c63c15fc074f38046e5acbd9a378f1a03a7\", \"ozone_gl_unittests\": \"9641b86008d756164ffc4645138970b7ce8dd483\", \"ozone_unittests\": \"7c93bbc976a5b22fc437c54fc4d33f817263939a\", \"ozone_x11_unittests\": \"7a7ba290b0939c917f56ea2d8eb87ef8b15dfc89\", \"pdf_unittests\": \"a096c2c4bbf55626ed64d02a59bf96d2887816a5\", \"perfetto_unittests\": \"c3868234c8b180a7bdadb06e1ea44b02c630f858\", \"ppapi_unittests\": \"af435bb7e3dbd7820e737f8bb6ed5a91cc64b757\", \"printing_unittests\": \"229181519e85c0eaab92834174c9f2818caf2899\", \"remoting_unittests\": \"5f56e53782c5a96f254ba6ed8af99f8ea8c25008\", \"sandbox_linux_unittests\": \"6d7685d481d3fc34d489ef3a4b3584daaa83f050\", \"service_manager_unittests\": \"3607c84b70f424e6cc450d489d6184190c013ad4\", \"services_unittests\": \"f935d27b8459ff9e26121a7af3f8fa671fe15f47\", \"shell_dialogs_unittests\": \"d944c9289f137c8d425b8724b9a40ec338053eb1\", \"skia_unittests\": \"2210955941e602d675ae472e5dd083665b6c6957\", \"snapshot_unittests\": \"08d02cbf89e73ed8a9dc16f84ab8a57fbf5e4a54\", \"sql_unittests\": \"2b8a730832180a3947e4c11fb332fb8c66e4d92b\", \"storage_unittests\": \"47b7da25e76b941afb34b5b4d4f8663c5db54a71\", \"sync_integration_tests\": \"639859cc4f2086f99819c5bd3c5f44c2c34a990c\", \"traffic_annotation_auditor_unittests\": \"662ae9d884916f19cec65d6ae93fc13b0af94abf\", \"ui_base_unittests\": \"9b961a20e462de93d34b1dd8af5e557f7701906c\", \"ui_chromeos_unittests\": \"5b16f5f67ce3622b15aa23013ab78aac6b797c01\", \"ui_touch_selection_unittests\": \"a6c09fe20c30cd00739841013487274ab8360c4e\", \"unit_tests\": \"8e6b2784c77b9a3fbe4148d7a78407f2003998a6\", \"url_unittests\": \"c89410293b7db7d561dcbc14d6adc43ee0d0b7be\", \"usage_time_limit_unittests\": \"c391611ee1660e1b142befe92707bf81aed9f19e\", \"views_unittests\": \"0bd3b3c0d2f88df0fb80e710a7d659a5f3e45507\", \"viz_unittests\": \"4af9a436d0d3e886730d5cfc200be4d8c4ef8f56\", \"wm_unittests\": \"0df1b33e70793d965b0a649e1b5dff42f08d4add\", \"wtf_unittests\": \"e6dd5f52107d71bf509663761e5efbe2f3619876\", \"zlib_unittests\": \"1cb0913c14f154e93d79a1330134098900b3dff1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3df726b65531685b338b7c2caf48988c15becc2e6a96e549d7512dce09d4fac6_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_dd987fcd94b516d81fcf1552cd73a9eed370c3dc02cc1a52ddee828f1ab8817d_v2\", \"builder_f568157a4ec00fb9568da05a054c670841713183d1f68e80f18d1b79a7a19e1f_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-131-omak\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606239806910591",
"status": "COMPLETED",
"status_changed_ts": "1606245691289523",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21453",
"builder:linux-chromeos-dbg",
"buildset:commit/git/679696cfbf5fce8fca4a513208cf44d4e99596c1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/679696cfbf5fce8fca4a513208cf44d4e99596c1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028159280125697456",
"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/8862729218157744480/+/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:50142bbdfb879910",
"user_agent:luci-scheduler"
],
"updated_ts": "1606245691301295",
"url": "https://ci.chromium.org/b/8862729218157744480",
"utcnow_ts": "1606245692582349"
}
}
[19:21:32.597] Invocation finished in 1h38m20.269991254s with status SUCCEEDED