[08:18:41.255] New invocation is queued and will start shortly
[08:18:42.391] Starting the invocation (attempt 1)
[08:18:42.430] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:18:42.431] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:18:42.431] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021128233159381360",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b5adf756eff062f934875b2c4ac88f20301a7567\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9021128233159381360",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/b5adf756eff062f934875b2c4ac88f20301a7567",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5adf756eff062f934875b2c4ac88f20301a7567",
"gitiles_ref:refs/heads/master"
]
}
[08:18:44.834] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612945122669857",
"id": "8855698171010021712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b5adf756eff062f934875b2c4ac88f20301a7567\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612945124359784",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22564",
"builder:linux-chromeos-dbg",
"buildset:commit/git/b5adf756eff062f934875b2c4ac88f20301a7567",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5adf756eff062f934875b2c4ac88f20301a7567",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021128233159381360",
"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/8855698171010021712/+/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": "1612945124360092",
"url": "https://ci.chromium.org/b/8855698171010021712",
"utcnow_ts": "1612945124820081"
}
}
[08:18:44.834] Task URL: https://ci.chromium.org/b/8855698171010021712
[08:18:44.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:2:0) after 1m0s
[08:18:54.468] Received PubSub notification, asking Buildbucket for the build status
[08:18:54.543] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:44.817] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:2:0)
[08:19:44.817] Timer tick, asking Buildbucket for the build status
[08:19:44.964] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:44.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:4:0) after 1m0s
[08:20:44.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:4:0)
[08:20:44.947] Timer tick, asking Buildbucket for the build status
[08:20:45.011] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:45.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:5:0) after 1m0s
[08:21:45.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:5:0)
[08:21:45.033] Timer tick, asking Buildbucket for the build status
[08:21:45.103] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:45.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:6:0) after 1m0s
[08:22:45.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:6:0)
[08:22:45.127] Timer tick, asking Buildbucket for the build status
[08:22:45.230] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:45.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:7:0) after 1m0s
[08:23:45.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:7:0)
[08:23:45.255] Timer tick, asking Buildbucket for the build status
[08:23:47.557] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:47.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:8:0) after 1m0s
[08:24:47.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:8:0)
[08:24:47.581] Timer tick, asking Buildbucket for the build status
[08:24:48.665] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:48.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:9:0) after 1m0s
[08:25:48.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:9:0)
[08:25:48.681] Timer tick, asking Buildbucket for the build status
[08:25:49.091] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:49.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:10:0) after 1m0s
[08:26:49.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:10:0)
[08:26:49.135] Timer tick, asking Buildbucket for the build status
[08:26:49.268] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:49.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:11:0) after 1m0s
[08:27:49.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:11:0)
[08:27:49.301] Timer tick, asking Buildbucket for the build status
[08:27:49.464] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:49.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:12:0) after 1m0s
[08:28:49.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:12:0)
[08:28:49.481] Timer tick, asking Buildbucket for the build status
[08:28:49.581] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:49.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:13:0) after 1m0s
[08:29:49.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:13:0)
[08:29:49.612] Timer tick, asking Buildbucket for the build status
[08:29:49.718] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:49.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:14:0) after 1m0s
[08:30:49.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:14:0)
[08:30:49.745] Timer tick, asking Buildbucket for the build status
[08:30:50.050] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:50.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:15:0) after 1m0s
[08:31:50.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:15:0)
[08:31:50.089] Timer tick, asking Buildbucket for the build status
[08:31:50.523] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:50.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:16:0) after 1m0s
[08:32:50.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:16:0)
[08:32:50.541] Timer tick, asking Buildbucket for the build status
[08:32:50.609] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:50.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:17:0) after 1m0s
[08:33:50.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:17:0)
[08:33:50.609] Timer tick, asking Buildbucket for the build status
[08:33:51.109] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:51.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:18:0) after 1m0s
[08:34:51.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:18:0)
[08:34:51.132] Timer tick, asking Buildbucket for the build status
[08:34:51.235] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:51.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:19:0) after 1m0s
[08:35:51.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:19:0)
[08:35:51.264] Timer tick, asking Buildbucket for the build status
[08:35:51.376] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:51.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:20:0) after 1m0s
[08:36:51.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:20:0)
[08:36:51.412] Timer tick, asking Buildbucket for the build status
[08:36:51.491] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:51.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:21:0) after 1m0s
[08:37:51.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:21:0)
[08:37:51.491] Timer tick, asking Buildbucket for the build status
[08:37:51.575] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:51.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:22:0) after 1m0s
[08:38:51.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:22:0)
[08:38:51.640] Timer tick, asking Buildbucket for the build status
[08:38:51.749] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:51.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:23:0) after 1m0s
[08:39:51.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:23:0)
[08:39:51.880] Timer tick, asking Buildbucket for the build status
[08:39:52.002] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:52.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:24:0) after 1m0s
[08:40:51.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:24:0)
[08:40:51.988] Timer tick, asking Buildbucket for the build status
[08:40:52.115] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:52.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:25:0) after 1m0s
[08:41:52.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:25:0)
[08:41:52.120] Timer tick, asking Buildbucket for the build status
[08:41:52.193] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:52.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:26:0) after 1m0s
[08:42:52.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:26:0)
[08:42:52.685] Timer tick, asking Buildbucket for the build status
[08:42:52.961] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:52.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:27:0) after 1m0s
[08:43:53.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:27:0)
[08:43:53.010] Timer tick, asking Buildbucket for the build status
[08:43:53.159] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:53.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:28:0) after 1m0s
[08:44:53.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:28:0)
[08:44:53.251] Timer tick, asking Buildbucket for the build status
[08:44:53.326] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:53.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:29:0) after 1m0s
[08:45:53.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:29:0)
[08:45:53.382] Timer tick, asking Buildbucket for the build status
[08:45:53.467] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:53.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:30:0) after 1m0s
[08:46:53.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:30:0)
[08:46:53.437] Timer tick, asking Buildbucket for the build status
[08:46:53.598] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:53.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:31:0) after 1m0s
[08:47:53.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:31:0)
[08:47:53.654] Timer tick, asking Buildbucket for the build status
[08:47:53.842] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:53.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:32:0) after 1m0s
[08:48:53.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:32:0)
[08:48:53.887] Timer tick, asking Buildbucket for the build status
[08:48:54.416] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:54.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:33:0) after 1m0s
[08:49:54.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:33:0)
[08:49:54.466] Timer tick, asking Buildbucket for the build status
[08:49:54.531] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:54.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:34:0) after 1m0s
[08:50:54.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:34:0)
[08:50:54.571] Timer tick, asking Buildbucket for the build status
[08:50:54.625] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:54.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:35:0) after 1m0s
[08:51:54.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:35:0)
[08:51:54.644] Timer tick, asking Buildbucket for the build status
[08:51:54.703] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:54.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:36:0) after 1m0s
[08:52:54.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:36:0)
[08:52:54.735] Timer tick, asking Buildbucket for the build status
[08:52:54.847] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:54.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:37:0) after 1m0s
[08:53:54.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:37:0)
[08:53:54.856] Timer tick, asking Buildbucket for the build status
[08:53:54.990] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:54.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:38:0) after 1m0s
[08:54:54.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:38:0)
[08:54:54.970] Timer tick, asking Buildbucket for the build status
[08:54:55.078] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:55.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:39:0) after 1m0s
[08:55:55.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:39:0)
[08:55:55.157] Timer tick, asking Buildbucket for the build status
[08:55:55.393] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:55.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:40:0) after 1m0s
[08:56:55.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:40:0)
[08:56:55.415] Timer tick, asking Buildbucket for the build status
[08:56:56.619] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:56.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:41:0) after 1m0s
[08:57:56.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:41:0)
[08:57:56.752] Timer tick, asking Buildbucket for the build status
[08:57:56.874] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:56.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:42:0) after 1m0s
[08:58:57.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:42:0)
[08:58:57.142] Timer tick, asking Buildbucket for the build status
[08:58:57.229] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:57.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:43:0) after 1m0s
[08:59:57.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:43:0)
[08:59:57.308] Timer tick, asking Buildbucket for the build status
[08:59:57.361] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:57.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:44:0) after 1m0s
[09:00:57.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:44:0)
[09:00:57.613] Timer tick, asking Buildbucket for the build status
[09:00:57.811] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:57.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:45:0) after 1m0s
[09:01:57.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:45:0)
[09:01:57.993] Timer tick, asking Buildbucket for the build status
[09:01:58.125] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:58.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:46:0) after 1m0s
[09:02:58.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:46:0)
[09:02:58.217] Timer tick, asking Buildbucket for the build status
[09:02:58.286] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:58.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:47:0) after 1m0s
[09:03:58.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:47:0)
[09:03:58.332] Timer tick, asking Buildbucket for the build status
[09:03:58.441] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:58.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:48:0) after 1m0s
[09:04:58.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:48:0)
[09:04:58.472] Timer tick, asking Buildbucket for the build status
[09:04:58.589] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:58.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:49:0) after 1m0s
[09:05:58.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:49:0)
[09:05:58.652] Timer tick, asking Buildbucket for the build status
[09:05:59.036] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:59.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:50:0) after 1m0s
[09:06:59.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:50:0)
[09:06:59.051] Timer tick, asking Buildbucket for the build status
[09:06:59.257] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:59.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:51:0) after 1m0s
[09:07:59.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:51:0)
[09:07:59.288] Timer tick, asking Buildbucket for the build status
[09:07:59.904] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:59.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:52:0) after 1m0s
[09:08:59.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:52:0)
[09:08:59.957] Timer tick, asking Buildbucket for the build status
[09:09:00.316] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:00.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:53:0) after 1m0s
[09:10:00.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:53:0)
[09:10:00.360] Timer tick, asking Buildbucket for the build status
[09:10:00.522] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:00.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:54:0) after 1m0s
[09:11:00.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:54:0)
[09:11:00.584] Timer tick, asking Buildbucket for the build status
[09:11:00.856] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:00.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:55:0) after 1m0s
[09:12:01.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:55:0)
[09:12:01.557] Timer tick, asking Buildbucket for the build status
[09:12:01.864] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:01.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:56:0) after 1m0s
[09:13:01.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:56:0)
[09:13:01.874] Timer tick, asking Buildbucket for the build status
[09:13:01.959] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:01.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:57:0) after 1m0s
[09:14:01.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:57:0)
[09:14:01.981] Timer tick, asking Buildbucket for the build status
[09:14:02.105] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:02.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:58:0) after 1m0s
[09:15:02.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:58:0)
[09:15:02.215] Timer tick, asking Buildbucket for the build status
[09:15:02.353] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:02.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:59:0) after 1m0s
[09:16:02.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:59:0)
[09:16:02.530] Timer tick, asking Buildbucket for the build status
[09:16:02.629] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:02.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:60:0) after 1m0s
[09:17:02.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:60:0)
[09:17:02.693] Timer tick, asking Buildbucket for the build status
[09:17:02.863] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:02.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:61:0) after 1m0s
[09:18:02.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:61:0)
[09:18:02.939] Timer tick, asking Buildbucket for the build status
[09:18:03.179] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:03.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:62:0) after 1m0s
[09:19:03.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:62:0)
[09:19:03.224] Timer tick, asking Buildbucket for the build status
[09:19:03.522] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:03.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:63:0) after 1m0s
[09:20:03.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:63:0)
[09:20:03.599] Timer tick, asking Buildbucket for the build status
[09:20:04.104] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:04.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:64:0) after 1m0s
[09:21:04.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:64:0)
[09:21:04.201] Timer tick, asking Buildbucket for the build status
[09:21:05.272] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:05.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:65:0) after 1m0s
[09:22:05.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:65:0)
[09:22:05.258] Timer tick, asking Buildbucket for the build status
[09:22:05.560] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:05.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:66:0) after 1m0s
[09:23:05.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:66:0)
[09:23:05.574] Timer tick, asking Buildbucket for the build status
[09:23:05.680] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:05.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:67:0) after 1m0s
[09:24:05.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:67:0)
[09:24:05.730] Timer tick, asking Buildbucket for the build status
[09:24:06.043] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:06.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:68:0) after 1m0s
[09:25:06.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:68:0)
[09:25:06.119] Timer tick, asking Buildbucket for the build status
[09:25:06.209] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:06.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:69:0) after 1m0s
[09:26:06.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:69:0)
[09:26:06.287] Timer tick, asking Buildbucket for the build status
[09:26:06.385] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:06.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:70:0) after 1m0s
[09:27:06.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:70:0)
[09:27:06.472] Timer tick, asking Buildbucket for the build status
[09:27:06.858] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:06.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:71:0) after 1m0s
[09:28:06.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:71:0)
[09:28:06.961] Timer tick, asking Buildbucket for the build status
[09:28:07.069] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:07.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:72:0) after 1m0s
[09:29:07.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:72:0)
[09:29:07.112] Timer tick, asking Buildbucket for the build status
[09:29:07.283] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:07.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:73:0) after 1m0s
[09:30:07.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:73:0)
[09:30:07.336] Timer tick, asking Buildbucket for the build status
[09:30:07.456] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:07.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:74:0) after 1m0s
[09:31:07.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:74:0)
[09:31:07.524] Timer tick, asking Buildbucket for the build status
[09:31:07.662] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:07.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:75:0) after 1m0s
[09:32:07.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:75:0)
[09:32:07.721] Timer tick, asking Buildbucket for the build status
[09:32:07.843] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:07.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:76:0) after 1m0s
[09:33:07.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:76:0)
[09:33:07.941] Timer tick, asking Buildbucket for the build status
[09:33:08.018] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:08.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:77:0) after 1m0s
[09:34:08.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:77:0)
[09:34:08.170] Timer tick, asking Buildbucket for the build status
[09:34:08.276] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:08.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:78:0) after 1m0s
[09:35:08.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:78:0)
[09:35:08.320] Timer tick, asking Buildbucket for the build status
[09:35:08.397] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:08.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:79:0) after 1m0s
[09:36:08.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:79:0)
[09:36:08.418] Timer tick, asking Buildbucket for the build status
[09:36:08.490] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:08.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:80:0) after 1m0s
[09:37:08.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:80:0)
[09:37:08.537] Timer tick, asking Buildbucket for the build status
[09:37:08.754] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:08.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:81:0) after 1m0s
[09:38:08.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:81:0)
[09:38:08.761] Timer tick, asking Buildbucket for the build status
[09:38:08.894] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:08.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:82:0) after 1m0s
[09:39:08.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:82:0)
[09:39:08.986] Timer tick, asking Buildbucket for the build status
[09:39:09.262] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:09.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:83:0) after 1m0s
[09:40:09.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:83:0)
[09:40:09.268] Timer tick, asking Buildbucket for the build status
[09:40:09.347] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:09.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:84:0) after 1m0s
[09:41:09.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:84:0)
[09:41:09.370] Timer tick, asking Buildbucket for the build status
[09:41:09.450] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:09.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:85:0) after 1m0s
[09:42:09.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:85:0)
[09:42:09.478] Timer tick, asking Buildbucket for the build status
[09:42:09.742] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:09.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:86:0) after 1m0s
[09:43:09.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:86:0)
[09:43:09.781] Timer tick, asking Buildbucket for the build status
[09:43:10.026] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:10.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:87:0) after 1m0s
[09:44:10.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:87:0)
[09:44:10.044] Timer tick, asking Buildbucket for the build status
[09:44:10.286] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:10.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:88:0) after 1m0s
[09:45:10.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:88:0)
[09:45:10.349] Timer tick, asking Buildbucket for the build status
[09:45:10.561] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:10.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:89:0) after 1m0s
[09:46:10.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:89:0)
[09:46:10.578] Timer tick, asking Buildbucket for the build status
[09:46:10.789] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:10.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:90:0) after 1m0s
[09:47:10.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:90:0)
[09:47:10.835] Timer tick, asking Buildbucket for the build status
[09:47:11.519] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:11.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:91:0) after 1m0s
[09:48:11.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:91:0)
[09:48:11.571] Timer tick, asking Buildbucket for the build status
[09:48:11.637] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:11.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:92:0) after 1m0s
[09:49:11.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:92:0)
[09:49:11.769] Timer tick, asking Buildbucket for the build status
[09:49:11.905] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:11.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:93:0) after 1m0s
[09:50:12.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:93:0)
[09:50:12.065] Timer tick, asking Buildbucket for the build status
[09:50:12.138] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:12.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:94:0) after 1m0s
[09:51:12.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:94:0)
[09:51:12.253] Timer tick, asking Buildbucket for the build status
[09:51:12.340] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:12.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:95:0) after 1m0s
[09:52:12.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:95:0)
[09:52:12.631] Timer tick, asking Buildbucket for the build status
[09:52:12.703] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:12.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:96:0) after 1m0s
[09:53:12.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:96:0)
[09:53:12.819] Timer tick, asking Buildbucket for the build status
[09:53:12.911] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:12.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:97:0) after 1m0s
[09:54:13.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:97:0)
[09:54:13.001] Timer tick, asking Buildbucket for the build status
[09:54:13.096] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:13.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:98:0) after 1m0s
[09:55:13.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:98:0)
[09:55:13.195] Timer tick, asking Buildbucket for the build status
[09:55:13.306] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:13.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:99:0) after 1m0s
[09:56:13.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:99:0)
[09:56:13.516] Timer tick, asking Buildbucket for the build status
[09:56:13.751] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:13.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:100:0) after 1m0s
[09:57:13.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:100:0)
[09:57:13.879] Timer tick, asking Buildbucket for the build status
[09:57:14.138] Build 8855698171010021712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:14.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021128233159381360:101:0) after 1m0s
[09:58:00.653] Received PubSub notification, asking Buildbucket for the build status
[09:58:00.723] Build 8855698171010021712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:58:00.723] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612951078042592",
"created_by": "project:chromium",
"created_ts": "1612945122669857",
"id": "8855698171010021712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b5adf756eff062f934875b2c4ac88f20301a7567\"}}",
"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\": \"b5adf756eff062f934875b2c4ac88f20301a7567\", \"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-east1-d-8-8-y7i3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22564, \"got_angle_revision\": \"bb062070cb5257098f0e2d775fa66b74d6d32468\", \"got_dawn_revision\": \"b6b0090b501799fb98f8ca3cae1d87bd991635ed\", \"got_nacl_revision\": \"4de55da44c4b511989359381e8b7a88a01fe0634\", \"got_revision\": \"b5adf756eff062f934875b2c4ac88f20301a7567\", \"got_revision_cp\": \"refs/heads/master@{#852535}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"9677c6d282788b0e2b7e2a02d539b5fa86279ee1\", \"got_v8_revision\": \"c369eee9f5827733bc6784843744c4ac8a9bea0b\", \"got_v8_revision_cp\": \"refs/heads/9.0.147@{#1}\", \"got_webrtc_revision\": \"bb8f32f5410c93c675a1dac55aebd15c11945839\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33207}\", \"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\": \"b5adf756eff062f934875b2c4ac88f20301a7567\", \"swarm_hashes_refs/heads/master(at){#852535}_without_patch\": {\"absl_hardening_tests\": \"972c59c1dd1d41032afc972377c97f087f03c09b\", \"accessibility_unittests\": \"89e0d99cb33a4bcdad7bfd1696338f8f22a78480\", \"angle_unittests\": \"85c489c338a6a3804cd463efbe36aabd51f62416\", \"app_list_unittests\": \"891455069b16dc498cd4b32c26c1f39e014b2256\", \"app_shell_unittests\": \"73af4d64d3d844c6dc595b0428a9883092075071\", \"ash_unittests\": \"1aae96abdab90a6782c8347e63ef32b5f25c000e\", \"aura_unittests\": \"1c1c897414a631400ff820da8eba8c3ba96d491f\", \"base_unittests\": \"44e7999c8fbe261bc024708589f5545f9c9f4794\", \"base_util_unittests\": \"49fd43e7f95bea405b387c5fbd3f74214a41ff63\", \"blink_common_unittests\": \"c1129ad56302861f04831bfada244425a702dd20\", \"blink_fuzzer_unittests\": \"eae52795cdb29ffe588ae59cb43b655c93560cd0\", \"blink_heap_unittests\": \"62b21cfb8da30e2bae79c31404a74a89d6cc8469\", \"blink_platform_unittests\": \"a09c3799cbefe9bb8d1ef977d2fdd65346a49f82\", \"blink_unittests\": \"a770f508ef73e86e02b09e0d58cd55d17e4b00fb\", \"boringssl_crypto_tests\": \"0b543909bd73684c40e5e18553b711491d22ce13\", \"boringssl_ssl_tests\": \"77d17f9682f10edbad54b57a080ad6f58d0609d6\", \"browser_tests\": \"428fd57ce503a6742f6489578e4e6eb96073fac7\", \"capture_unittests\": \"bacf06b711e945eb96e335f866c53909e28e0e3e\", \"cast_unittests\": \"651ef29ba0996ba854ab5f17ccfef301617e9cb3\", \"cc_unittests\": \"640f0df7e9166b349c1ca4a2d8608dc02a27ad21\", \"chrome_app_unittests\": \"90a9f931b58438cceb7744640dc1a1185ca2650b\", \"chromedriver_unittests\": \"59c74f4f9f64e6539f54aa635666f4adccceec00\", \"chromeos_components_unittests\": \"6773b35e5d4458d849813bed19521f8785dfc967\", \"chromeos_unittests\": \"2c8dac23c5e5618f61e22517d86ca924a3a4b9b8\", \"components_browsertests\": \"07228ca9a5e0ed277e21cd9aa99e467b6f03093c\", \"components_unittests\": \"8a5b172ee919b4dadc3dfa42e8749fd20e6891a2\", \"compositor_unittests\": \"3fb1c6aa60a22c5565b7aab2c1f6b8ec2ed8a02f\", \"content_browsertests\": \"bf7492a4febfb82049a61578638d18817c44a1eb\", \"content_unittests\": \"a8c5269442db2f54937344f08d7df124729d8369\", \"crashpad_tests\": \"16ed0fb86511aba6bb03808c3aa618f6f61dcc8d\", \"crypto_unittests\": \"93bb0f98b3297925e7e1e18b2a98639484a77955\", \"dbus_unittests\": \"c6aee50558455dbd299e8cd22b0d54bcb4680a41\", \"device_unittests\": \"da6d728721de0b4a3a2f9d256e7798eb5c56d7e9\", \"display_unittests\": \"1197df36ca81bba684fbc14d85443288a9b63d51\", \"events_unittests\": \"f7f570ee6cf862d5adddcbc6a5f7aaff034ab177\", \"exo_unittests\": \"ff4603e37aa8c328abaa263b9f101d21c6f14be1\", \"extensions_browsertests\": \"f4ec6e44bcf18785bbf487da1ca3f5604de3ded2\", \"extensions_unittests\": \"39ba28932af3564d740acc7ddcd501b5a07ef854\", \"filesystem_service_unittests\": \"c6654757e86599c07ee6f650984069034eca13ce\", \"gcm_unit_tests\": \"be45f34529e19f72c35c00d56c504f4a7066d8a7\", \"gfx_unittests\": \"e06a8e0b2540e9625ee96e00fe2a876261fce7ec\", \"gin_unittests\": \"a8538803f4e4c2eb759c85f398fb925551f74196\", \"gl_unittests_ozone\": \"3fb90ef063ee174d53063dfe6357a2f3f0a61a24\", \"google_apis_unittests\": \"c418217eb2fd45a185ec5c5bb45ab8abecf0f263\", \"gpu_unittests\": \"5e5c55586be520ecc79c2164d2a582955d06fb49\", \"gwp_asan_unittests\": \"5b05a0403cd1f17f3de6a511abb29383b3ecf501\", \"interactive_ui_tests\": \"cce4269a5f3e728c7e06a30070ac454cb260d08b\", \"ipc_tests\": \"d11e8afdc772b3ae0620a6e6bea4cc3d8453d22a\", \"jingle_unittests\": \"a004a6c8f9d8def79445a837d46db6640778e899\", \"keyboard_unittests\": \"87375da9b69cce8cf6d4aecd187e7a343584fa17\", \"latency_unittests\": \"93950e1e860ab21c774f8211f6b96501c021ca39\", \"libjingle_xmpp_unittests\": \"1f9cc2f779fae5de062bcef8fa65b6257e4b1715\", \"liburlpattern_unittests\": \"713f4e62ddda6c8381c25fd1e3a8d111dc3d2168\", \"media_blink_unittests\": \"b6bdb4fb401ef014a733996ca45686687c3db08f\", \"media_unittests\": \"9ba58de5e038b7078da524156154962e3563c877\", \"message_center_unittests\": \"db891b5bf27364a04b06211138c9e5c90f545afb\", \"midi_unittests\": \"66d63ef780b97e4de19a2be5a0b885479a7c71d4\", \"mojo_core_unittests\": \"be7116264cfa77835fd97516b8f5b3383558d11d\", \"mojo_unittests\": \"adeb2e8a9cda5c1d0f85adb343fd51cb0bffabb8\", \"nacl_helper_nonsfi_unittests\": \"37f056cb2e657a23d88eae4fcc7f54970ad99911\", \"nacl_loader_unittests\": \"30639050334ff7625d1632476eac1c84509f3bf0\", \"native_theme_unittests\": \"59a0c56bd967038639001cb535ed6cf2cd4f5fdb\", \"net_unittests\": \"caada5d04bdfcd1932fd4d4afa99343766b2d768\", \"ozone_gl_unittests\": \"c394249a36a4b186c79b972cd0acf59e2e0325ec\", \"ozone_unittests\": \"daa47b9ae45d9d8e4434f81ce9a9d02fede86e5d\", \"ozone_x11_unittests\": \"16d5ca04e8f555c845ca29ca2d28c3a4b486ecaf\", \"pdf_unittests\": \"c6c9bac61ee22adf3901f5a89c454a79b2a505a4\", \"perfetto_unittests\": \"3f5a08fa2c5d212e6a2d8227b01303a2c3aba433\", \"ppapi_unittests\": \"d343f1c277b4da32c6b0711998f6663c40bb708a\", \"printing_unittests\": \"d95c5bbb29f842d52bc9a9d6be234ba8a9714d76\", \"remoting_unittests\": \"3c604a62e49d31cb0658db1c2c5c0874a758dfa9\", \"sandbox_linux_unittests\": \"b0f1b475cd4dba6116bb85e414505b452c315ce5\", \"service_manager_unittests\": \"20b29878b73a0877c9238f1db235bc9fecdd4917\", \"services_unittests\": \"5ee69be55225b4ba025ee1d2e0fdd62f6dc20299\", \"shell_dialogs_unittests\": \"e6bf971932a068a2d5cc0f05ffa14d27ad626a9a\", \"shell_encryption_unittests\": \"9f69814dc9f18363801dec7aab274a08c0fabf68\", \"skia_unittests\": \"eb7f0fe7fd43768ab1b12688a355fcee792137b3\", \"snapshot_unittests\": \"7d1bc6b25841018d42addb660f387b6bee4f4ec8\", \"sql_unittests\": \"1bcd5d48702398d342196c1e4203297e5109d017\", \"storage_unittests\": \"aa3f90d04b8f01c8a8e389290397a49ebf59865b\", \"sync_integration_tests\": \"78c7f79708328774a683fa073d4d270e21e1f862\", \"traffic_annotation_auditor_unittests\": \"c388ec9428ce1bbacee8e94efa23b571a4d7c17d\", \"ui_base_unittests\": \"256259db50c7aa6e87e5303f8462006a506a8df9\", \"ui_chromeos_unittests\": \"d4939de01a23e285a23f47c22de70c9af10e29d9\", \"ui_touch_selection_unittests\": \"def38e62a9e6329fd86f16efc23f1f1f54667a4c\", \"unit_tests\": \"becf98d11afb3abffa6bbe5405b5d0b181da3e21\", \"url_unittests\": \"66d97113a77641ef9d4a00e8c2a058daf839f4d4\", \"usage_time_limit_unittests\": \"0395eab6006b251eff96d628398921cf948c2e8c\", \"views_unittests\": \"0e8c0c33f53332af4e861df8b51bf7129934045c\", \"viz_unittests\": \"c5ea1e967c14d85b151fd6222001b1463a500498\", \"wm_unittests\": \"4005ba998e384df9d006007af3fcf12f7ae7fbd1\", \"wtf_unittests\": \"8cf920d3af78401d4f2777df0f70713366233222\", \"zlib_unittests\": \"07ae077199cef9edbd88604f8367eec2a77e1283\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_151f80801b9f29276c11c5f05dab27ce5673f9c9ba442aaf2cf20aab9215f522_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_800f6f487d95d787b5e050c93b44c7c7276a85aefb5f9344834f1f03ffd0e322_v2\", \"builder_983dbffb8cc86de1533c3acacd740027aafc9d2942de9f299ba8447770e514ac_v2\", \"builder_bcc6b3e5c0858529730294da730af8ea17f2c5c79b8b0dc7af4e722a8412ac73_v2\", \"builder_c18d585c17603559d8d68e3de2c6e12032537b56b99cb619aa84174b37006d15_v2\", \"builder_cb8f28a5d59bb80cbafed89b56af03ba2ea85f5e24941631d330b6bd1d886cb5_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-east1-d-8-8-y7i3\"], \"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\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612945132129656",
"status": "COMPLETED",
"status_changed_ts": "1612951078557975",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22564",
"builder:linux-chromeos-dbg",
"buildset:commit/git/b5adf756eff062f934875b2c4ac88f20301a7567",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5adf756eff062f934875b2c4ac88f20301a7567",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021128233159381360",
"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/8855698171010021712/+/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:51a3d6f5bf7cbb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1612951078624939",
"url": "https://ci.chromium.org/b/8855698171010021712",
"utcnow_ts": "1612951080715024"
}
}
[09:58:00.724] Invocation finished in 1h39m19.487471693s with status SUCCEEDED