[18:51:53.189] New invocation is queued and will start shortly
[18:51:54.312] Starting the invocation (attempt 1)
[18:51:54.342] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:51:54.342] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:51:54.343] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020182426061032352",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d099425505990beea8751f1da4625a4f639c8991\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020182426061032352",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/d099425505990beea8751f1da4625a4f639c8991",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d099425505990beea8751f1da4625a4f639c8991",
"gitiles_ref:refs/heads/master"
]
}
[18:51:55.025] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613847114415582",
"id": "8854752364112932048",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d099425505990beea8751f1da4625a4f639c8991\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613847114841904",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45588",
"builder:linux-chromeos-rel",
"buildset:commit/git/d099425505990beea8751f1da4625a4f639c8991",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d099425505990beea8751f1da4625a4f639c8991",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020182426061032352",
"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/8854752364112932048/+/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": "1613847114842012",
"url": "https://ci.chromium.org/b/8854752364112932048",
"utcnow_ts": "1613847115008843"
}
}
[18:51:55.025] Task URL: https://ci.chromium.org/b/8854752364112932048
[18:51:55.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:2:0) after 1m0s
[18:52:55.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:2:0)
[18:52:55.109] Timer tick, asking Buildbucket for the build status
[18:52:56.860] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:52:56.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:3:0) after 1m0s
[18:53:56.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:3:0)
[18:53:56.931] Timer tick, asking Buildbucket for the build status
[18:53:57.000] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:53:57.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:4:0) after 1m0s
[18:54:56.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:4:0)
[18:54:56.995] Timer tick, asking Buildbucket for the build status
[18:54:57.073] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:54:57.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:5:0) after 1m0s
[18:55:57.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:5:0)
[18:55:57.090] Timer tick, asking Buildbucket for the build status
[18:55:57.155] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:55:57.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:6:0) after 1m0s
[18:56:57.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:6:0)
[18:56:57.172] Timer tick, asking Buildbucket for the build status
[18:56:57.291] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:56:57.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:7:0) after 1m0s
[18:57:57.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:7:0)
[18:57:57.316] Timer tick, asking Buildbucket for the build status
[18:57:57.449] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:57:57.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:8:0) after 1m0s
[18:58:57.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:8:0)
[18:58:57.464] Timer tick, asking Buildbucket for the build status
[18:58:57.641] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:58:57.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:9:0) after 1m0s
[18:59:57.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:9:0)
[18:59:57.660] Timer tick, asking Buildbucket for the build status
[18:59:58.000] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:59:58.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:10:0) after 1m0s
[19:00:58.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:10:0)
[19:00:58.018] Timer tick, asking Buildbucket for the build status
[19:00:58.096] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:00:58.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:11:0) after 1m0s
[19:01:58.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:11:0)
[19:01:58.118] Timer tick, asking Buildbucket for the build status
[19:01:58.191] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:58.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:12:0) after 1m0s
[19:02:58.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:12:0)
[19:02:58.208] Timer tick, asking Buildbucket for the build status
[19:02:58.284] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:02:58.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:13:0) after 1m0s
[19:03:58.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:13:0)
[19:03:58.347] Timer tick, asking Buildbucket for the build status
[19:03:58.424] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:58.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:14:0) after 1m0s
[19:04:58.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:14:0)
[19:04:58.456] Timer tick, asking Buildbucket for the build status
[19:04:58.598] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:58.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:15:0) after 1m0s
[19:05:58.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:15:0)
[19:05:58.616] Timer tick, asking Buildbucket for the build status
[19:05:58.893] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:58.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:16:0) after 1m0s
[19:06:58.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:16:0)
[19:06:58.915] Timer tick, asking Buildbucket for the build status
[19:06:58.991] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:58.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:17:0) after 1m0s
[19:07:59.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:17:0)
[19:07:59.063] Timer tick, asking Buildbucket for the build status
[19:07:59.265] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:07:59.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:18:0) after 1m0s
[19:08:59.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:18:0)
[19:08:59.283] Timer tick, asking Buildbucket for the build status
[19:08:59.520] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:08:59.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:19:0) after 1m0s
[19:09:59.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:19:0)
[19:09:59.538] Timer tick, asking Buildbucket for the build status
[19:09:59.669] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:09:59.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:20:0) after 1m0s
[19:10:59.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:20:0)
[19:10:59.722] Timer tick, asking Buildbucket for the build status
[19:10:59.783] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:10:59.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:21:0) after 1m0s
[19:11:59.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:21:0)
[19:11:59.806] Timer tick, asking Buildbucket for the build status
[19:11:59.872] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:11:59.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:22:0) after 1m0s
[19:12:59.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:22:0)
[19:12:59.938] Timer tick, asking Buildbucket for the build status
[19:13:00.049] Build 8854752364112932048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:13:00.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:23:0) after 1m0s
[19:13:43.529] Received PubSub notification, asking Buildbucket for the build status
[19:13:43.597] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:00.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:23:0)
[19:14:00.069] Timer tick, asking Buildbucket for the build status
[19:14:00.294] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:00.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:25:0) after 1m0s
[19:15:00.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:25:0)
[19:15:00.454] Timer tick, asking Buildbucket for the build status
[19:15:00.559] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:00.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:26:0) after 1m0s
[19:16:04.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:26:0)
[19:16:04.318] Timer tick, asking Buildbucket for the build status
[19:16:04.394] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:04.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:27:0) after 1m0s
[19:17:04.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:27:0)
[19:17:04.365] Timer tick, asking Buildbucket for the build status
[19:17:04.440] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:04.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:28:0) after 1m0s
[19:18:04.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:28:0)
[19:18:04.552] Timer tick, asking Buildbucket for the build status
[19:18:04.633] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:04.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:29:0) after 1m0s
[19:19:05.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:29:0)
[19:19:05.070] Timer tick, asking Buildbucket for the build status
[19:19:05.290] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:05.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:30:0) after 1m0s
[19:20:05.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:30:0)
[19:20:05.565] Timer tick, asking Buildbucket for the build status
[19:20:05.793] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:05.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:31:0) after 1m0s
[19:21:06.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:31:0)
[19:21:06.113] Timer tick, asking Buildbucket for the build status
[19:21:06.187] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:06.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:32:0) after 1m0s
[19:22:06.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:32:0)
[19:22:06.423] Timer tick, asking Buildbucket for the build status
[19:22:06.502] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:06.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:33:0) after 1m0s
[19:23:06.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:33:0)
[19:23:06.666] Timer tick, asking Buildbucket for the build status
[19:23:06.738] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:06.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:34:0) after 1m0s
[19:24:06.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:34:0)
[19:24:06.786] Timer tick, asking Buildbucket for the build status
[19:24:06.907] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:06.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:35:0) after 1m0s
[19:25:06.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:35:0)
[19:25:06.972] Timer tick, asking Buildbucket for the build status
[19:25:07.185] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:07.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:36:0) after 1m0s
[19:26:07.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:36:0)
[19:26:07.278] Timer tick, asking Buildbucket for the build status
[19:26:07.508] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:07.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:37:0) after 1m0s
[19:27:07.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:37:0)
[19:27:07.637] Timer tick, asking Buildbucket for the build status
[19:27:07.743] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:07.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:38:0) after 1m0s
[19:28:07.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:38:0)
[19:28:07.847] Timer tick, asking Buildbucket for the build status
[19:28:07.968] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:07.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:39:0) after 1m0s
[19:29:08.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:39:0)
[19:29:08.113] Timer tick, asking Buildbucket for the build status
[19:29:08.482] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:08.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:40:0) after 1m0s
[19:30:08.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:40:0)
[19:30:08.548] Timer tick, asking Buildbucket for the build status
[19:30:08.636] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:08.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:41:0) after 1m0s
[19:31:08.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:41:0)
[19:31:08.603] Timer tick, asking Buildbucket for the build status
[19:31:08.691] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:08.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:42:0) after 1m0s
[19:32:08.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:42:0)
[19:32:08.745] Timer tick, asking Buildbucket for the build status
[19:32:08.836] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:08.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:43:0) after 1m0s
[19:33:08.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:43:0)
[19:33:08.855] Timer tick, asking Buildbucket for the build status
[19:33:08.954] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:08.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:44:0) after 1m0s
[19:34:08.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:44:0)
[19:34:08.972] Timer tick, asking Buildbucket for the build status
[19:34:09.102] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:09.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:45:0) after 1m0s
[19:35:09.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:45:0)
[19:35:09.159] Timer tick, asking Buildbucket for the build status
[19:35:09.431] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:09.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:46:0) after 1m0s
[19:36:09.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:46:0)
[19:36:09.499] Timer tick, asking Buildbucket for the build status
[19:36:09.592] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:09.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:47:0) after 1m0s
[19:37:09.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:47:0)
[19:37:09.606] Timer tick, asking Buildbucket for the build status
[19:37:09.781] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:09.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:48:0) after 1m0s
[19:38:09.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:48:0)
[19:38:09.789] Timer tick, asking Buildbucket for the build status
[19:38:10.018] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:10.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:49:0) after 1m0s
[19:39:10.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:49:0)
[19:39:10.049] Timer tick, asking Buildbucket for the build status
[19:39:10.298] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:10.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:50:0) after 1m0s
[19:40:10.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:50:0)
[19:40:10.468] Timer tick, asking Buildbucket for the build status
[19:40:10.702] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:10.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:51:0) after 1m0s
[19:41:10.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:51:0)
[19:41:10.845] Timer tick, asking Buildbucket for the build status
[19:41:11.112] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:11.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:52:0) after 1m0s
[19:42:11.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:52:0)
[19:42:11.304] Timer tick, asking Buildbucket for the build status
[19:42:11.623] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:11.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:53:0) after 1m0s
[19:43:11.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:53:0)
[19:43:11.637] Timer tick, asking Buildbucket for the build status
[19:43:11.701] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:11.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:54:0) after 1m0s
[19:44:11.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:54:0)
[19:44:11.730] Timer tick, asking Buildbucket for the build status
[19:44:11.913] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:11.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:55:0) after 1m0s
[19:45:11.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:55:0)
[19:45:11.966] Timer tick, asking Buildbucket for the build status
[19:45:12.064] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:12.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:56:0) after 1m0s
[19:46:12.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:56:0)
[19:46:12.056] Timer tick, asking Buildbucket for the build status
[19:46:12.417] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:12.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:57:0) after 1m0s
[19:47:12.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:57:0)
[19:47:12.531] Timer tick, asking Buildbucket for the build status
[19:47:12.994] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:12.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:58:0) after 1m0s
[19:48:13.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:58:0)
[19:48:13.080] Timer tick, asking Buildbucket for the build status
[19:48:13.236] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:13.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:59:0) after 1m0s
[19:49:13.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:59:0)
[19:49:13.345] Timer tick, asking Buildbucket for the build status
[19:49:13.513] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:13.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:60:0) after 1m0s
[19:50:13.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:60:0)
[19:50:13.579] Timer tick, asking Buildbucket for the build status
[19:50:13.833] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:13.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:61:0) after 1m0s
[19:51:13.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:61:0)
[19:51:13.911] Timer tick, asking Buildbucket for the build status
[19:51:13.983] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:13.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:62:0) after 1m0s
[19:52:14.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:62:0)
[19:52:14.156] Timer tick, asking Buildbucket for the build status
[19:52:14.254] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:14.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:63:0) after 1m0s
[19:53:14.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:63:0)
[19:53:14.323] Timer tick, asking Buildbucket for the build status
[19:53:14.477] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:14.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:64:0) after 1m0s
[19:54:14.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:64:0)
[19:54:14.586] Timer tick, asking Buildbucket for the build status
[19:54:14.660] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:14.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:65:0) after 1m0s
[19:55:14.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:65:0)
[19:55:14.751] Timer tick, asking Buildbucket for the build status
[19:55:14.821] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:14.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:66:0) after 1m0s
[19:56:14.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:66:0)
[19:56:14.888] Timer tick, asking Buildbucket for the build status
[19:56:14.967] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:14.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:67:0) after 1m0s
[19:57:15.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:67:0)
[19:57:15.001] Timer tick, asking Buildbucket for the build status
[19:57:15.124] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:15.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:68:0) after 1m0s
[19:58:15.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:68:0)
[19:58:15.208] Timer tick, asking Buildbucket for the build status
[19:58:15.430] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:15.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:69:0) after 1m0s
[19:59:15.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:69:0)
[19:59:15.519] Timer tick, asking Buildbucket for the build status
[19:59:15.600] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:15.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:70:0) after 1m0s
[20:00:15.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:70:0)
[20:00:15.654] Timer tick, asking Buildbucket for the build status
[20:00:15.964] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:15.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:71:0) after 1m0s
[20:01:17.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:71:0)
[20:01:17.175] Timer tick, asking Buildbucket for the build status
[20:01:17.250] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:17.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:72:0) after 1m0s
[20:02:17.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:72:0)
[20:02:17.307] Timer tick, asking Buildbucket for the build status
[20:02:17.396] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:17.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:73:0) after 1m0s
[20:03:17.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:73:0)
[20:03:17.419] Timer tick, asking Buildbucket for the build status
[20:03:17.494] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:17.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:74:0) after 1m0s
[20:04:17.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:74:0)
[20:04:17.514] Timer tick, asking Buildbucket for the build status
[20:04:17.717] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:17.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:75:0) after 1m0s
[20:05:17.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:75:0)
[20:05:17.794] Timer tick, asking Buildbucket for the build status
[20:05:17.861] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:17.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:76:0) after 1m0s
[20:06:17.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:76:0)
[20:06:17.878] Timer tick, asking Buildbucket for the build status
[20:06:18.093] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:18.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:77:0) after 1m0s
[20:07:18.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:77:0)
[20:07:18.111] Timer tick, asking Buildbucket for the build status
[20:07:18.199] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:18.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:78:0) after 1m0s
[20:08:18.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:78:0)
[20:08:18.229] Timer tick, asking Buildbucket for the build status
[20:08:18.305] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:18.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:79:0) after 1m0s
[20:09:18.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:79:0)
[20:09:18.364] Timer tick, asking Buildbucket for the build status
[20:09:18.455] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:18.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:80:0) after 1m0s
[20:10:18.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:80:0)
[20:10:18.481] Timer tick, asking Buildbucket for the build status
[20:10:18.557] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:18.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:81:0) after 1m0s
[20:11:18.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:81:0)
[20:11:18.592] Timer tick, asking Buildbucket for the build status
[20:11:18.680] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:18.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:82:0) after 1m0s
[20:12:18.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:82:0)
[20:12:18.793] Timer tick, asking Buildbucket for the build status
[20:12:18.901] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:18.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:83:0) after 1m0s
[20:13:18.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:83:0)
[20:13:18.919] Timer tick, asking Buildbucket for the build status
[20:13:19.267] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:19.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:84:0) after 1m0s
[20:14:19.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:84:0)
[20:14:19.337] Timer tick, asking Buildbucket for the build status
[20:14:19.406] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:19.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:85:0) after 1m0s
[20:15:19.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:85:0)
[20:15:19.473] Timer tick, asking Buildbucket for the build status
[20:15:19.590] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:19.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:86:0) after 1m0s
[20:16:19.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:86:0)
[20:16:19.622] Timer tick, asking Buildbucket for the build status
[20:16:19.704] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:19.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:87:0) after 1m0s
[20:17:19.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:87:0)
[20:17:19.723] Timer tick, asking Buildbucket for the build status
[20:17:20.003] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:20.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:88:0) after 1m0s
[20:18:20.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:88:0)
[20:18:20.035] Timer tick, asking Buildbucket for the build status
[20:18:20.116] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:20.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:89:0) after 1m0s
[20:19:20.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:89:0)
[20:19:20.202] Timer tick, asking Buildbucket for the build status
[20:19:20.514] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:20.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:90:0) after 1m0s
[20:20:20.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:90:0)
[20:20:20.534] Timer tick, asking Buildbucket for the build status
[20:20:20.608] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:20.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:91:0) after 1m0s
[20:21:20.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:91:0)
[20:21:20.691] Timer tick, asking Buildbucket for the build status
[20:21:20.854] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:20.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:92:0) after 1m0s
[20:22:20.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:92:0)
[20:22:20.958] Timer tick, asking Buildbucket for the build status
[20:22:21.530] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:21.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:93:0) after 1m0s
[20:23:21.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:93:0)
[20:23:21.561] Timer tick, asking Buildbucket for the build status
[20:23:21.749] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:21.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:94:0) after 1m0s
[20:24:21.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:94:0)
[20:24:21.770] Timer tick, asking Buildbucket for the build status
[20:24:21.869] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:21.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:95:0) after 1m0s
[20:25:21.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:95:0)
[20:25:21.892] Timer tick, asking Buildbucket for the build status
[20:25:21.967] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:21.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:96:0) after 1m0s
[20:26:22.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:96:0)
[20:26:22.075] Timer tick, asking Buildbucket for the build status
[20:26:22.153] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:22.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:97:0) after 1m0s
[20:27:22.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:97:0)
[20:27:22.139] Timer tick, asking Buildbucket for the build status
[20:27:22.321] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:22.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:98:0) after 1m0s
[20:28:22.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:98:0)
[20:28:22.385] Timer tick, asking Buildbucket for the build status
[20:28:22.790] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:22.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:99:0) after 1m0s
[20:29:22.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:99:0)
[20:29:22.894] Timer tick, asking Buildbucket for the build status
[20:29:23.008] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:23.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:100:0) after 1m0s
[20:30:23.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:100:0)
[20:30:23.088] Timer tick, asking Buildbucket for the build status
[20:30:23.169] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:23.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:101:0) after 1m0s
[20:31:23.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:101:0)
[20:31:23.213] Timer tick, asking Buildbucket for the build status
[20:31:23.286] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:23.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:102:0) after 1m0s
[20:32:23.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:102:0)
[20:32:23.339] Timer tick, asking Buildbucket for the build status
[20:32:23.432] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:23.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:103:0) after 1m0s
[20:33:23.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:103:0)
[20:33:23.452] Timer tick, asking Buildbucket for the build status
[20:33:23.556] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:23.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:104:0) after 1m0s
[20:34:23.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:104:0)
[20:34:23.599] Timer tick, asking Buildbucket for the build status
[20:34:23.929] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:23.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:105:0) after 1m0s
[20:35:24.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:105:0)
[20:35:24.071] Timer tick, asking Buildbucket for the build status
[20:35:24.149] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:24.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:106:0) after 1m0s
[20:36:24.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:106:0)
[20:36:24.160] Timer tick, asking Buildbucket for the build status
[20:36:24.237] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:24.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:107:0) after 1m0s
[20:37:24.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:107:0)
[20:37:24.306] Timer tick, asking Buildbucket for the build status
[20:37:24.396] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:24.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:108:0) after 1m0s
[20:38:24.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:108:0)
[20:38:24.450] Timer tick, asking Buildbucket for the build status
[20:38:24.516] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:24.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:109:0) after 1m0s
[20:39:24.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:109:0)
[20:39:24.506] Timer tick, asking Buildbucket for the build status
[20:39:24.700] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:24.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:110:0) after 1m0s
[20:40:24.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:110:0)
[20:40:24.722] Timer tick, asking Buildbucket for the build status
[20:40:24.964] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:24.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:111:0) after 1m0s
[20:41:24.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:111:0)
[20:41:24.989] Timer tick, asking Buildbucket for the build status
[20:41:25.063] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:25.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:112:0) after 1m0s
[20:42:25.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:112:0)
[20:42:25.138] Timer tick, asking Buildbucket for the build status
[20:42:25.406] Build 8854752364112932048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:25.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020182426061032352:113:0) after 1m0s
[20:42:46.837] Received PubSub notification, asking Buildbucket for the build status
[20:42:46.913] Build 8854752364112932048: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:42:46.913] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613853765799047",
"created_by": "project:chromium",
"created_ts": "1613847114415582",
"id": "8854752364112932048",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d099425505990beea8751f1da4625a4f639c8991\"}}",
"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\": \"d099425505990beea8751f1da4625a4f639c8991\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-31-fyp8\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45588, \"got_angle_revision\": \"d3d30921fc4c74ff24d27c1ad038445fa497046e\", \"got_dawn_revision\": \"1258e245a978083cab0b707c84dea814eadb3fbb\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"d099425505990beea8751f1da4625a4f639c8991\", \"got_revision_cp\": \"refs/heads/master@{#856108}\", \"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\": \"d099425505990beea8751f1da4625a4f639c8991\", \"swarm_hashes_refs/heads/master(at){#856108}_without_patch\": {\"absl_hardening_tests\": \"16744b70f9d590796d06d6906688edb675b743c4\", \"accessibility_unittests\": \"97ae7ea5372c3db660b5920a32507b540424ac57\", \"angle_unittests\": \"080b6f108b3a650be8b00ce295037a18856f2c6c\", \"app_list_unittests\": \"b544d6f17b550722890987d3dea31e0c710f2667\", \"app_shell_unittests\": \"2a6a4faf3456cefd7909aade67cf6071af310c8b\", \"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\": \"4e165f54697ead76ef841d102f492600abd7cd73\", \"capture_unittests\": \"35d335627e05158b71b02180b498ee86d16af24a\", \"cast_unittests\": \"7a36547ec0335d52887a8276cd2f57bd1fa2fd19\", \"cc_unittests\": \"ffbadd1b753cf57eb045073a3e1d51f14042af7d\", \"chrome_app_unittests\": \"cc1bb4be71b000c273561e084aa19e665e512445\", \"chromedriver_unittests\": \"5dca27a7e13d175b73f5f158385b1331e6c5a8eb\", \"chromeos_components_unittests\": \"0864a578249bb5292cba406693bb6229c2491fe4\", \"chromeos_unittests\": \"d10f2c5faae9266069c1fa8685384a3d68047f6e\", \"components_browsertests\": \"b5f1c4db095f299cb6d4f5c2e890a8e41feecaac\", \"components_unittests\": \"2c77031d9a04ded99ef5fa92a6cdd939458f35e1\", \"compositor_unittests\": \"cd493f2c64573af7980a7c185e9daa419a3b7d2e\", \"content_browsertests\": \"dc67d1708a58bee8297ee3cbef5cb13341d16565\", \"content_unittests\": \"70fe09c4c4efbe191dc5fdcc3f563082f5a2c65b\", \"crashpad_tests\": \"edef239b7220ee13332dd83d8cbea9d2c0ffd30c\", \"crypto_unittests\": \"f6cf178e1152d46b39e9ef5c40149f47716f782d\", \"dbus_unittests\": \"27ecb2f5c5cc26d774653b18a571d6e3138587ee\", \"device_unittests\": \"652f6a9b0cea66fdbda996e7d9a47fbd716b0eea\", \"display_unittests\": \"fafa248d8d5f155ea767fd197fcb450d582fd64c\", \"events_unittests\": \"a3d3f1157447b87bfe0bb8e8b6d111653fc8e288\", \"exo_unittests\": \"7de89bd30e04289896b8a40ad2ee38ef310ba7d7\", \"extensions_browsertests\": \"7e5e4c6a2079afc6e27be039e9c386ae884e746e\", \"extensions_unittests\": \"d9ae2b4f20c7bc1c3f5e2f3503b5a5708289d4bd\", \"filesystem_service_unittests\": \"0552aa03c7e5108ab2a2f436abd8ecfd9ddf194c\", \"gcm_unit_tests\": \"3d53ff65c82a1850851a222bc8ccdaa0909d6662\", \"gfx_unittests\": \"950a6a8611ef12d63caa37a43f7fa96329a158a9\", \"gin_unittests\": \"cd04425776775b4d34960bc71220cd211fa65ff8\", \"gl_unittests_ozone\": \"083dabf7b4cd2f4ad9aa3c853bc3fcba983d26bb\", \"google_apis_unittests\": \"896c0bd6bb43bfd7c2589a3982a47e088ac3729b\", \"gpu_unittests\": \"b5be91dbb78813cce9d551362943778401e1e8ff\", \"gwp_asan_unittests\": \"911d337f2c9cbf3360419db8985c877ac370ca0f\", \"interactive_ui_tests\": \"da19b7741f96de426cf82bfb49cd170591fecaf5\", \"ipc_tests\": \"1d17db001f6e344f0a69c2db26cdd9157726b2f4\", \"jingle_unittests\": \"7949a745cf51815856882cb7b726d2e2537462a0\", \"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\": \"428e64ea64665b007b9a9913798bd73182baf502\", \"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\": \"2802a0694c120c2ee8574107ee67dcd128687c5e\", \"sandbox_linux_unittests\": \"f1d2d0f0479271de9b72c1393696ba415dc3629b\", \"service_manager_unittests\": \"89ea9f0806c113ede72ae92d05f86b919087a3a6\", \"services_unittests\": \"09b9f021bbd899e0585375694fab189a01fef8b2\", \"shell_dialogs_unittests\": \"bb78b8fb8d34c7e0697f82d699c095f187e3b8d7\", \"shell_encryption_unittests\": \"4bca1eea80133601aca7adf464cb7d52d0ad4494\", \"skia_unittests\": \"c3312231d5bb52706970be74c8348ad4d4a36f2b\", \"snapshot_unittests\": \"bc0b6ae3348d46cf260f287c21ec2a271c186042\", \"sql_unittests\": \"cd1b518066558e1dec7e859b94421a5507624fd7\", \"storage_unittests\": \"039be8618359496379b89c6c8dfefb27bc4bbfda\", \"sync_integration_tests\": \"4e06c75460a662508bbc0692a062b23e44d0b560\", \"traffic_annotation_auditor_unittests\": \"1cbeee1bd112bd44e6b438ba422aad471b3bc521\", \"ui_base_unittests\": \"134e5ed52a852c5f862b6df54d3178e2f22a7851\", \"ui_chromeos_unittests\": \"2bcb298388c4d226b9c7f786c8c0d5b5b3be93dd\", \"ui_touch_selection_unittests\": \"f4a650c488908c95cee2ca1b1c791ffe064e0431\", \"unit_tests\": \"020eb3d1c34b964a432d9927105978d7f0e97d53\", \"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_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_4a2b13219f689d34aa475139e9738b55334bf25923df6aa4978f2ee96f164d56_v2\", \"builder_6012964051d5021e7307eb12ad598b318c657120f21d3654d81218fef56916e6_v2\", \"builder_61faa0d0c1c079ecf670d8cfa4f78ad3b1687a5534233c7377462c3ee6819708_v2\", \"builder_a10052c67097968898fa29710cdaa0ada58a120001760a536a006ca29eefe964_v2\", \"builder_a27b44a1648dd298adda85735042ac3d0ffdcfd6d22ed3e792b03614ce2ee968_v2\", \"builder_a72d480ca48f57bfd3a2a0028361f62534d8cf527dbb841fd2259fc00e36dedb_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-31-fyp8\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613848417093695",
"status": "COMPLETED",
"status_changed_ts": "1613853766171674",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45588",
"builder:linux-chromeos-rel",
"buildset:commit/git/d099425505990beea8751f1da4625a4f639c8991",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d099425505990beea8751f1da4625a4f639c8991",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020182426061032352",
"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/8854752364112932048/+/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:51d99a3d88017310",
"user_agent:luci-scheduler"
],
"updated_ts": "1613853766176349",
"url": "https://ci.chromium.org/b/8854752364112932048",
"utcnow_ts": "1613853766904633"
}
}
[20:42:46.913] Invocation finished in 1h50m53.738869313s with status SUCCEEDED