[20:42:49.355] New invocation is queued and will start shortly
[20:42:50.525] Starting the invocation (attempt 1)
[20:42:50.581] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:42:50.581] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:42:50.581] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020175446564730560",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"94f9a6961690a13e4a24931fa6d43470fd803ce8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020175446564730560",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/94f9a6961690a13e4a24931fa6d43470fd803ce8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/94f9a6961690a13e4a24931fa6d43470fd803ce8",
"gitiles_ref:refs/heads/master"
]
}
[20:42:52.227] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613853770724895",
"id": "8854745384467667936",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"94f9a6961690a13e4a24931fa6d43470fd803ce8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613853771690010",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45589",
"builder:linux-chromeos-rel",
"buildset:commit/git/94f9a6961690a13e4a24931fa6d43470fd803ce8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/94f9a6961690a13e4a24931fa6d43470fd803ce8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020175446564730560",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854745384467667936/+/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": "1613853771690140",
"url": "https://ci.chromium.org/b/8854745384467667936",
"utcnow_ts": "1613853772218258"
}
}
[20:42:52.227] Task URL: https://ci.chromium.org/b/8854745384467667936
[20:42:52.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:2:0) after 1m0s
[20:43:52.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:2:0)
[20:43:52.405] Timer tick, asking Buildbucket for the build status
[20:43:52.560] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:43:52.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:3:0) after 1m0s
[20:44:52.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:3:0)
[20:44:52.788] Timer tick, asking Buildbucket for the build status
[20:44:52.863] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:44:52.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:4:0) after 1m0s
[20:45:53.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:4:0)
[20:45:53.111] Timer tick, asking Buildbucket for the build status
[20:45:53.211] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:45:53.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:5:0) after 1m0s
[20:46:53.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:5:0)
[20:46:53.468] Timer tick, asking Buildbucket for the build status
[20:46:53.608] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:46:53.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:6:0) after 1m0s
[20:47:53.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:6:0)
[20:47:53.819] Timer tick, asking Buildbucket for the build status
[20:47:53.922] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:47:53.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:7:0) after 1m0s
[20:48:53.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:7:0)
[20:48:53.971] Timer tick, asking Buildbucket for the build status
[20:48:54.060] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:48:54.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:8:0) after 1m0s
[20:49:54.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:8:0)
[20:49:54.215] Timer tick, asking Buildbucket for the build status
[20:49:54.279] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:49:54.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:9:0) after 1m0s
[20:50:55.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:9:0)
[20:50:55.279] Timer tick, asking Buildbucket for the build status
[20:50:55.345] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:50:55.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:10:0) after 1m0s
[20:51:55.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:10:0)
[20:51:55.361] Timer tick, asking Buildbucket for the build status
[20:51:55.593] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:51:55.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:11:0) after 1m0s
[20:52:55.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:11:0)
[20:52:55.610] Timer tick, asking Buildbucket for the build status
[20:52:55.680] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:52:55.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:12:0) after 1m0s
[20:53:55.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:12:0)
[20:53:55.751] Timer tick, asking Buildbucket for the build status
[20:53:55.817] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:53:55.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:13:0) after 1m0s
[20:54:55.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:13:0)
[20:54:55.830] Timer tick, asking Buildbucket for the build status
[20:54:55.942] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:54:55.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:14:0) after 1m0s
[20:55:55.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:14:0)
[20:55:55.969] Timer tick, asking Buildbucket for the build status
[20:55:56.075] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:55:56.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:15:0) after 1m0s
[20:56:56.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:15:0)
[20:56:56.125] Timer tick, asking Buildbucket for the build status
[20:56:56.192] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:56:56.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:16:0) after 1m0s
[20:57:56.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:16:0)
[20:57:56.237] Timer tick, asking Buildbucket for the build status
[20:57:56.410] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:57:56.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:17:0) after 1m0s
[20:58:56.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:17:0)
[20:58:56.463] Timer tick, asking Buildbucket for the build status
[20:58:56.714] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:58:56.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:18:0) after 1m0s
[20:59:56.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:18:0)
[20:59:56.735] Timer tick, asking Buildbucket for the build status
[20:59:56.824] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:56.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:19:0) after 1m0s
[21:00:56.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:19:0)
[21:00:56.843] Timer tick, asking Buildbucket for the build status
[21:00:56.918] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:56.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:20:0) after 1m0s
[21:01:57.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:20:0)
[21:01:57.154] Timer tick, asking Buildbucket for the build status
[21:01:57.221] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:57.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:21:0) after 1m0s
[21:02:57.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:21:0)
[21:02:57.307] Timer tick, asking Buildbucket for the build status
[21:02:57.503] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:57.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:22:0) after 1m0s
[21:03:57.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:22:0)
[21:03:57.574] Timer tick, asking Buildbucket for the build status
[21:03:57.667] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:57.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:23:0) after 1m0s
[21:04:57.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:23:0)
[21:04:57.712] Timer tick, asking Buildbucket for the build status
[21:04:57.786] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:57.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:24:0) after 1m0s
[21:06:00.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:24:0)
[21:06:00.556] Timer tick, asking Buildbucket for the build status
[21:06:00.628] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:00.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:25:0) after 1m0s
[21:07:00.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:25:0)
[21:07:00.690] Timer tick, asking Buildbucket for the build status
[21:07:00.849] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:00.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:26:0) after 1m0s
[21:08:00.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:26:0)
[21:08:00.844] Timer tick, asking Buildbucket for the build status
[21:08:00.995] Build 8854745384467667936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:08:00.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:27:0) after 1m0s
[21:08:06.085] Received PubSub notification, asking Buildbucket for the build status
[21:08:06.327] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:01.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:27:0)
[21:09:01.119] Timer tick, asking Buildbucket for the build status
[21:09:01.332] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:01.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:29:0) after 1m0s
[21:10:01.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:29:0)
[21:10:01.363] Timer tick, asking Buildbucket for the build status
[21:10:01.434] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:01.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:30:0) after 1m0s
[21:11:01.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:30:0)
[21:11:01.484] Timer tick, asking Buildbucket for the build status
[21:11:01.560] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:01.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:31:0) after 1m0s
[21:12:01.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:31:0)
[21:12:01.710] Timer tick, asking Buildbucket for the build status
[21:12:01.783] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:01.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:32:0) after 1m0s
[21:13:01.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:32:0)
[21:13:01.853] Timer tick, asking Buildbucket for the build status
[21:13:02.030] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:02.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:33:0) after 1m0s
[21:14:02.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:33:0)
[21:14:02.210] Timer tick, asking Buildbucket for the build status
[21:14:02.450] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:02.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:34:0) after 1m0s
[21:15:02.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:34:0)
[21:15:02.615] Timer tick, asking Buildbucket for the build status
[21:15:02.737] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:02.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:35:0) after 1m0s
[21:16:02.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:35:0)
[21:16:02.833] Timer tick, asking Buildbucket for the build status
[21:16:03.325] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:03.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:36:0) after 1m0s
[21:17:03.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:36:0)
[21:17:03.331] Timer tick, asking Buildbucket for the build status
[21:17:03.406] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:03.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:37:0) after 1m0s
[21:18:03.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:37:0)
[21:18:03.462] Timer tick, asking Buildbucket for the build status
[21:18:03.713] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:03.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:38:0) after 1m0s
[21:19:03.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:38:0)
[21:19:03.682] Timer tick, asking Buildbucket for the build status
[21:19:03.843] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:03.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:39:0) after 1m0s
[21:20:03.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:39:0)
[21:20:03.841] Timer tick, asking Buildbucket for the build status
[21:20:03.916] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:03.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:40:0) after 1m0s
[21:21:04.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:40:0)
[21:21:04.079] Timer tick, asking Buildbucket for the build status
[21:21:04.164] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:04.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:41:0) after 1m0s
[21:22:04.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:41:0)
[21:22:04.166] Timer tick, asking Buildbucket for the build status
[21:22:04.246] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:04.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:42:0) after 1m0s
[21:23:04.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:42:0)
[21:23:04.282] Timer tick, asking Buildbucket for the build status
[21:23:04.389] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:04.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:43:0) after 1m0s
[21:24:04.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:43:0)
[21:24:04.521] Timer tick, asking Buildbucket for the build status
[21:24:04.735] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:04.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:44:0) after 1m0s
[21:25:04.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:44:0)
[21:25:04.892] Timer tick, asking Buildbucket for the build status
[21:25:04.951] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:04.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:45:0) after 1m0s
[21:26:05.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:45:0)
[21:26:05.023] Timer tick, asking Buildbucket for the build status
[21:26:05.296] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:05.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:46:0) after 1m0s
[21:27:05.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:46:0)
[21:27:05.420] Timer tick, asking Buildbucket for the build status
[21:27:05.695] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:05.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:47:0) after 1m0s
[21:28:05.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:47:0)
[21:28:05.814] Timer tick, asking Buildbucket for the build status
[21:28:05.938] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:05.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:48:0) after 1m0s
[21:29:05.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:48:0)
[21:29:05.976] Timer tick, asking Buildbucket for the build status
[21:29:06.135] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:06.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:49:0) after 1m0s
[21:30:06.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:49:0)
[21:30:06.245] Timer tick, asking Buildbucket for the build status
[21:30:06.752] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:06.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:50:0) after 1m0s
[21:31:07.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:50:0)
[21:31:07.108] Timer tick, asking Buildbucket for the build status
[21:31:07.279] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:07.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:51:0) after 1m0s
[21:32:07.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:51:0)
[21:32:07.297] Timer tick, asking Buildbucket for the build status
[21:32:07.629] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:07.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:52:0) after 1m0s
[21:33:07.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:52:0)
[21:33:07.704] Timer tick, asking Buildbucket for the build status
[21:33:07.790] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:07.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:53:0) after 1m0s
[21:34:07.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:53:0)
[21:34:07.918] Timer tick, asking Buildbucket for the build status
[21:34:08.214] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:08.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:54:0) after 1m0s
[21:35:08.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:54:0)
[21:35:08.263] Timer tick, asking Buildbucket for the build status
[21:35:08.336] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:08.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:55:0) after 1m0s
[21:36:08.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:55:0)
[21:36:08.441] Timer tick, asking Buildbucket for the build status
[21:36:08.516] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:08.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:56:0) after 1m0s
[21:37:08.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:56:0)
[21:37:08.614] Timer tick, asking Buildbucket for the build status
[21:37:08.693] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:08.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:57:0) after 1m0s
[21:38:08.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:57:0)
[21:38:08.671] Timer tick, asking Buildbucket for the build status
[21:38:08.901] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:08.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:58:0) after 1m0s
[21:39:08.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:58:0)
[21:39:08.878] Timer tick, asking Buildbucket for the build status
[21:39:09.221] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:09.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:59:0) after 1m0s
[21:40:09.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:59:0)
[21:40:09.241] Timer tick, asking Buildbucket for the build status
[21:40:09.655] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:09.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:60:0) after 1m0s
[21:41:09.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:60:0)
[21:41:09.679] Timer tick, asking Buildbucket for the build status
[21:41:09.996] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:09.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:61:0) after 1m0s
[21:42:10.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:61:0)
[21:42:10.075] Timer tick, asking Buildbucket for the build status
[21:42:10.315] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:10.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:62:0) after 1m0s
[21:43:10.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:62:0)
[21:43:10.342] Timer tick, asking Buildbucket for the build status
[21:43:10.419] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:10.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:63:0) after 1m0s
[21:44:10.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:63:0)
[21:44:10.474] Timer tick, asking Buildbucket for the build status
[21:44:10.560] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:10.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:64:0) after 1m0s
[21:45:10.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:64:0)
[21:45:10.615] Timer tick, asking Buildbucket for the build status
[21:45:11.016] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:11.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:65:0) after 1m0s
[21:46:11.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:65:0)
[21:46:11.056] Timer tick, asking Buildbucket for the build status
[21:46:11.137] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:11.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:66:0) after 1m0s
[21:47:11.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:66:0)
[21:47:11.158] Timer tick, asking Buildbucket for the build status
[21:47:11.223] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:11.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:67:0) after 1m0s
[21:48:11.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:67:0)
[21:48:11.264] Timer tick, asking Buildbucket for the build status
[21:48:11.605] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:11.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:68:0) after 1m0s
[21:49:11.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:68:0)
[21:49:11.628] Timer tick, asking Buildbucket for the build status
[21:49:11.903] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:11.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:69:0) after 1m0s
[21:50:11.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:69:0)
[21:50:11.889] Timer tick, asking Buildbucket for the build status
[21:50:12.283] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:12.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:70:0) after 1m0s
[21:51:12.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:70:0)
[21:51:12.361] Timer tick, asking Buildbucket for the build status
[21:51:12.430] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:12.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:71:0) after 1m0s
[21:52:12.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:71:0)
[21:52:12.523] Timer tick, asking Buildbucket for the build status
[21:52:12.816] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:12.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:72:0) after 1m0s
[21:53:12.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:72:0)
[21:53:12.868] Timer tick, asking Buildbucket for the build status
[21:53:12.955] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:12.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:73:0) after 1m0s
[21:54:13.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:73:0)
[21:54:13.037] Timer tick, asking Buildbucket for the build status
[21:54:13.122] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:13.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:74:0) after 1m0s
[21:55:13.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:74:0)
[21:55:13.181] Timer tick, asking Buildbucket for the build status
[21:55:13.282] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:13.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:75:0) after 1m0s
[21:56:13.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:75:0)
[21:56:13.302] Timer tick, asking Buildbucket for the build status
[21:56:13.590] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:13.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:76:0) after 1m0s
[21:57:13.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:76:0)
[21:57:13.712] Timer tick, asking Buildbucket for the build status
[21:57:13.778] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:13.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:77:0) after 1m0s
[21:58:13.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:77:0)
[21:58:13.781] Timer tick, asking Buildbucket for the build status
[21:58:13.873] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:13.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:78:0) after 1m0s
[21:59:13.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:78:0)
[21:59:13.909] Timer tick, asking Buildbucket for the build status
[21:59:14.112] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:14.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:79:0) after 1m0s
[22:00:14.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:79:0)
[22:00:14.155] Timer tick, asking Buildbucket for the build status
[22:00:14.277] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:14.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:80:0) after 1m0s
[22:01:14.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:80:0)
[22:01:14.506] Timer tick, asking Buildbucket for the build status
[22:01:14.635] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:14.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:81:0) after 1m0s
[22:02:14.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:81:0)
[22:02:14.823] Timer tick, asking Buildbucket for the build status
[22:02:14.896] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:14.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:82:0) after 1m0s
[22:03:15.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:82:0)
[22:03:15.004] Timer tick, asking Buildbucket for the build status
[22:03:15.095] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:15.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:83:0) after 1m0s
[22:04:15.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:83:0)
[22:04:15.230] Timer tick, asking Buildbucket for the build status
[22:04:15.297] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:15.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:84:0) after 1m0s
[22:05:15.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:84:0)
[22:05:15.456] Timer tick, asking Buildbucket for the build status
[22:05:15.534] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:15.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:85:0) after 1m0s
[22:06:16.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:85:0)
[22:06:16.511] Timer tick, asking Buildbucket for the build status
[22:06:16.630] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:16.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:86:0) after 1m0s
[22:07:16.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:86:0)
[22:07:16.764] Timer tick, asking Buildbucket for the build status
[22:07:16.852] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:16.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:87:0) after 1m0s
[22:08:16.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:87:0)
[22:08:16.874] Timer tick, asking Buildbucket for the build status
[22:08:17.133] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:17.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:88:0) after 1m0s
[22:09:17.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:88:0)
[22:09:17.156] Timer tick, asking Buildbucket for the build status
[22:09:17.302] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:17.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:89:0) after 1m0s
[22:10:17.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:89:0)
[22:10:17.390] Timer tick, asking Buildbucket for the build status
[22:10:17.465] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:17.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:90:0) after 1m0s
[22:11:17.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:90:0)
[22:11:17.495] Timer tick, asking Buildbucket for the build status
[22:11:17.804] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:17.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:91:0) after 1m0s
[22:12:17.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:91:0)
[22:12:17.829] Timer tick, asking Buildbucket for the build status
[22:12:17.924] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:17.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:92:0) after 1m0s
[22:13:17.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:92:0)
[22:13:17.948] Timer tick, asking Buildbucket for the build status
[22:13:18.035] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:18.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:93:0) after 1m0s
[22:14:18.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:93:0)
[22:14:18.119] Timer tick, asking Buildbucket for the build status
[22:14:18.210] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:18.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:94:0) after 1m0s
[22:15:18.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:94:0)
[22:15:18.197] Timer tick, asking Buildbucket for the build status
[22:15:18.270] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:18.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:95:0) after 1m0s
[22:16:18.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:95:0)
[22:16:18.313] Timer tick, asking Buildbucket for the build status
[22:16:18.383] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:18.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:96:0) after 1m0s
[22:17:18.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:96:0)
[22:17:18.509] Timer tick, asking Buildbucket for the build status
[22:17:18.662] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:18.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:97:0) after 1m0s
[22:18:18.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:97:0)
[22:18:18.687] Timer tick, asking Buildbucket for the build status
[22:18:18.778] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:18.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:98:0) after 1m0s
[22:19:18.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:98:0)
[22:19:18.801] Timer tick, asking Buildbucket for the build status
[22:19:19.006] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:19.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:99:0) after 1m0s
[22:20:19.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:99:0)
[22:20:19.066] Timer tick, asking Buildbucket for the build status
[22:20:19.153] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:19.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:100:0) after 1m0s
[22:21:19.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:100:0)
[22:21:19.236] Timer tick, asking Buildbucket for the build status
[22:21:19.323] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:19.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:101:0) after 1m0s
[22:22:19.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:101:0)
[22:22:19.432] Timer tick, asking Buildbucket for the build status
[22:22:19.833] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:19.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:102:0) after 1m0s
[22:23:19.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:102:0)
[22:23:19.852] Timer tick, asking Buildbucket for the build status
[22:23:20.033] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:20.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:103:0) after 1m0s
[22:24:20.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:103:0)
[22:24:20.060] Timer tick, asking Buildbucket for the build status
[22:24:20.140] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:20.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:104:0) after 1m0s
[22:25:20.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:104:0)
[22:25:20.166] Timer tick, asking Buildbucket for the build status
[22:25:20.244] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:20.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:105:0) after 1m0s
[22:26:20.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:105:0)
[22:26:20.263] Timer tick, asking Buildbucket for the build status
[22:26:20.329] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:20.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:106:0) after 1m0s
[22:27:20.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:106:0)
[22:27:20.409] Timer tick, asking Buildbucket for the build status
[22:27:20.494] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:20.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:107:0) after 1m0s
[22:28:20.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:107:0)
[22:28:20.488] Timer tick, asking Buildbucket for the build status
[22:28:20.595] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:20.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:108:0) after 1m0s
[22:29:20.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:108:0)
[22:29:20.663] Timer tick, asking Buildbucket for the build status
[22:29:21.014] Build 8854745384467667936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:21.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020175446564730560:109:0) after 1m0s
[22:29:44.479] Received PubSub notification, asking Buildbucket for the build status
[22:29:44.568] Build 8854745384467667936: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:29:44.568] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613860183316934",
"created_by": "project:chromium",
"created_ts": "1613853770724895",
"id": "8854745384467667936",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"94f9a6961690a13e4a24931fa6d43470fd803ce8\"}}",
"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\": \"94f9a6961690a13e4a24931fa6d43470fd803ce8\", \"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-50-275x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45589, \"got_angle_revision\": \"d3d30921fc4c74ff24d27c1ad038445fa497046e\", \"got_dawn_revision\": \"1258e245a978083cab0b707c84dea814eadb3fbb\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"94f9a6961690a13e4a24931fa6d43470fd803ce8\", \"got_revision_cp\": \"refs/heads/master@{#856113}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"d85a7a27b27269741a779a72f33436b83d98687c\", \"got_v8_revision\": \"2430d8fffa7d4f8a0992bcb5eb3725e5367cd9ac\", \"got_v8_revision_cp\": \"refs/heads/9.0.229@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"94f9a6961690a13e4a24931fa6d43470fd803ce8\", \"swarm_hashes_refs/heads/master(at){#856113}_without_patch\": {\"absl_hardening_tests\": \"16744b70f9d590796d06d6906688edb675b743c4\", \"accessibility_unittests\": \"97ae7ea5372c3db660b5920a32507b540424ac57\", \"angle_unittests\": \"080b6f108b3a650be8b00ce295037a18856f2c6c\", \"app_list_unittests\": \"b544d6f17b550722890987d3dea31e0c710f2667\", \"app_shell_unittests\": \"55225ef5ca4e4a4bde02204772b41590dc1c6e08\", \"ash_unittests\": \"0e189e4bfed845b68885dc763c7d52f167020f51\", \"aura_unittests\": \"f608c6e9718b814a151751e70bf899e6a98e898d\", \"base_unittests\": \"893b25bec9c0205941ad491b6a94ce206e10d6d7\", \"base_util_unittests\": \"72c38111eea35fa040a86e0e2951f2af11c29f97\", \"blink_common_unittests\": \"ced885ea5aa1eba42b74a6acc8377c7f2bcb28f9\", \"blink_fuzzer_unittests\": \"11577d4f7d868a74a8806131bdf42c85c0e15cd2\", \"blink_heap_unittests\": \"630137ff530d88e1c95da5e34ea9779d3b1c1ee9\", \"blink_platform_unittests\": \"4e49fed69500a50d5cbf23fafe4f0d5e42e9ebaf\", \"blink_unittests\": \"dbc5c9c2c385c4b2b0f564447cb40a6ef3360d6b\", \"boringssl_crypto_tests\": \"cadccfb06ce1331dd7a96b2db1a6e3db28960cd6\", \"boringssl_ssl_tests\": \"c0e755952560d51141113456d829a577c2f255fa\", \"browser_tests\": \"af628f5e321d497f3b3e2847e6e26fd97b556384\", \"capture_unittests\": \"35d335627e05158b71b02180b498ee86d16af24a\", \"cast_unittests\": \"7a36547ec0335d52887a8276cd2f57bd1fa2fd19\", \"cc_unittests\": \"ffbadd1b753cf57eb045073a3e1d51f14042af7d\", \"chrome_app_unittests\": \"cc1bb4be71b000c273561e084aa19e665e512445\", \"chromedriver_unittests\": \"2241bb6b554a7f0cddc84bc1f709e6b35ad48722\", \"chromeos_components_unittests\": \"e172a16fd92a1b843aca14cd2acb091eba22a44d\", \"chromeos_unittests\": \"d10f2c5faae9266069c1fa8685384a3d68047f6e\", \"components_browsertests\": \"dae8c558eda58e3519d7d14262be235b4082ab44\", \"components_unittests\": \"749a7c4ecd4f1b50cbe50f6be6c7dd68d5bb1540\", \"compositor_unittests\": \"cd493f2c64573af7980a7c185e9daa419a3b7d2e\", \"content_browsertests\": \"c036a202a8e895d3da2558bb0bd5ffb4130ab3ab\", \"content_unittests\": \"c8df36c828f353be25fbcf8d38fa3ee3c8c154e9\", \"crashpad_tests\": \"edef239b7220ee13332dd83d8cbea9d2c0ffd30c\", \"crypto_unittests\": \"f6cf178e1152d46b39e9ef5c40149f47716f782d\", \"dbus_unittests\": \"27ecb2f5c5cc26d774653b18a571d6e3138587ee\", \"device_unittests\": \"652f6a9b0cea66fdbda996e7d9a47fbd716b0eea\", \"display_unittests\": \"fafa248d8d5f155ea767fd197fcb450d582fd64c\", \"events_unittests\": \"a3d3f1157447b87bfe0bb8e8b6d111653fc8e288\", \"exo_unittests\": \"7de89bd30e04289896b8a40ad2ee38ef310ba7d7\", \"extensions_browsertests\": \"304479efb90f6240af8c7397e94d484311d1ed33\", \"extensions_unittests\": \"7eecd6b8955d2a057cfde8b4f39d82909b9ab6f5\", \"filesystem_service_unittests\": \"0552aa03c7e5108ab2a2f436abd8ecfd9ddf194c\", \"gcm_unit_tests\": \"55ad9ad2decf2801a5fad8355ed0f35ce91a5833\", \"gfx_unittests\": \"950a6a8611ef12d63caa37a43f7fa96329a158a9\", \"gin_unittests\": \"cd04425776775b4d34960bc71220cd211fa65ff8\", \"gl_unittests_ozone\": \"083dabf7b4cd2f4ad9aa3c853bc3fcba983d26bb\", \"google_apis_unittests\": \"4d73e538ff36d70fed0d00cca6142592bddaa262\", \"gpu_unittests\": \"b5be91dbb78813cce9d551362943778401e1e8ff\", \"gwp_asan_unittests\": \"911d337f2c9cbf3360419db8985c877ac370ca0f\", \"interactive_ui_tests\": \"1cbffddf72af02e1eb1148985bee6957b3266101\", \"ipc_tests\": \"1d17db001f6e344f0a69c2db26cdd9157726b2f4\", \"jingle_unittests\": \"de9368c1e61ca3f5d957ab92ac46a42bd8fd46bb\", \"keyboard_unittests\": \"4128c98bf720660b26c968c1f51fd9af37fdf22e\", \"latency_unittests\": \"3cfaacc38a948c810763fc75742ea03858d85adb\", \"libjingle_xmpp_unittests\": \"ac9be026873d936e877d4ca3f527568e24c6b116\", \"liburlpattern_unittests\": \"ba4d6d7253aa7d69a7ad683ffc047575a4f62667\", \"media_blink_unittests\": \"8ef384420ceab0ed6c1d1695797d8cd338b7d8f9\", \"media_unittests\": \"8b3b713a8e4438aaa26ff599c35d01fafb940bd1\", \"message_center_unittests\": \"d1645caa52a1089752f4f9cf270a55c569efe4a4\", \"midi_unittests\": \"8616d00722514e2f338c4d259f61623693a7739f\", \"mojo_core_unittests\": \"7ed46d38a39a3acf4b9a8ddcaa2934b79f2225a6\", \"mojo_unittests\": \"b698038f18a1bc1738405e85accf42b661d0e0af\", \"nacl_helper_nonsfi_unittests\": \"144ebe766abe8553f2519dc028896d3440a12f68\", \"nacl_loader_unittests\": \"e0927947e10bec71234da510159f3f878b9ec363\", \"native_theme_unittests\": \"83567ebbd8858c3c82b6687264c4666d008a3f3d\", \"net_unittests\": \"6ee6f9e15de5a952e8a6586c88ee91ad6d009168\", \"ozone_gl_unittests\": \"449be7d08108d6e5d6a289c14de82c033d1a56b1\", \"ozone_unittests\": \"7d9b38ac3d542d55bbdcc02e3aa18332064a7c3f\", \"ozone_x11_unittests\": \"750aec6c7c0947079bb13e4546eb0a561704396d\", \"pdf_unittests\": \"19de6b00d4cf2e3c0a3eea0fce8bccd4438d7682\", \"perfetto_unittests\": \"610f7baa0bdf0baa5413d9c99c1853446f315b44\", \"ppapi_unittests\": \"69ab00f71836800af5842b8d5797b11c0bbc40f4\", \"printing_unittests\": \"394c2e7833566d393b03bcf74be56288fbed3ee9\", \"remoting_unittests\": \"e7569b874fa4a480a44b52e2ba605f8e5e1e5f81\", \"sandbox_linux_unittests\": \"f1d2d0f0479271de9b72c1393696ba415dc3629b\", \"service_manager_unittests\": \"89ea9f0806c113ede72ae92d05f86b919087a3a6\", \"services_unittests\": \"653ff4d4d70e8f74033e316b0c705fc0e14c5205\", \"shell_dialogs_unittests\": \"bb78b8fb8d34c7e0697f82d699c095f187e3b8d7\", \"shell_encryption_unittests\": \"4bca1eea80133601aca7adf464cb7d52d0ad4494\", \"skia_unittests\": \"c3312231d5bb52706970be74c8348ad4d4a36f2b\", \"snapshot_unittests\": \"bc0b6ae3348d46cf260f287c21ec2a271c186042\", \"sql_unittests\": \"cd1b518066558e1dec7e859b94421a5507624fd7\", \"storage_unittests\": \"039be8618359496379b89c6c8dfefb27bc4bbfda\", \"sync_integration_tests\": \"d480ac414591d6d56cc95e346143d2d9ea98d3fc\", \"traffic_annotation_auditor_unittests\": \"1cbeee1bd112bd44e6b438ba422aad471b3bc521\", \"ui_base_unittests\": \"134e5ed52a852c5f862b6df54d3178e2f22a7851\", \"ui_chromeos_unittests\": \"6762eabd00f3e9b3f463728289b679d9c1f039b7\", \"ui_touch_selection_unittests\": \"f4a650c488908c95cee2ca1b1c791ffe064e0431\", \"unit_tests\": \"65cedab6de15c996abb1cc62de0ba2c02ab9af2a\", \"url_unittests\": \"7f522d44de383b314c96a8fb54c0687bf69783cc\", \"usage_time_limit_unittests\": \"c97eb6f804bb4dc0ebbacbf9d4e208ae2d294886\", \"views_unittests\": \"eef11ce2464b84eed46ce86b6881370283dcaa70\", \"viz_unittests\": \"ce6fd8ab7902d3d6c00bd3c53502834259046a5f\", \"wayland_client_perftests\": \"68599c177329dea85ce26e205c5296f0e15de16a\", \"wm_unittests\": \"c096fb201814a75519466bd22c38794e8e60d28d\", \"wtf_unittests\": \"c3129035d2c03bcbab140889d94e0f94908777a2\", \"zlib_unittests\": \"37aedabe9ebe702bf855482fe1e4012f5477490e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_5165e2de7796d7dcb4f0b4d7ef826fa605d2b1188c14fc8becf427ca962c0c8e_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-50-275x\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613855284607003",
"status": "COMPLETED",
"status_changed_ts": "1613860183587142",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45589",
"builder:linux-chromeos-rel",
"buildset:commit/git/94f9a6961690a13e4a24931fa6d43470fd803ce8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/94f9a6961690a13e4a24931fa6d43470fd803ce8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020175446564730560",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854745384467667936/+/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:51d9ffd203a8b010",
"user_agent:luci-scheduler"
],
"updated_ts": "1613860183602688",
"url": "https://ci.chromium.org/b/8854745384467667936",
"utcnow_ts": "1613860184560918"
}
}
[22:29:44.568] Invocation finished in 1h46m55.22815509s with status SUCCEEDED