[21:36:16.462] New invocation is queued and will start shortly
[21:36:17.735] Starting the invocation (attempt 1)
[21:36:17.782] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:36:17.782] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:36:17.782] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022437007831116832",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"81f3f8b91292cc0c5cbcf2149f35d0ae05431c54\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022437007831116832",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/81f3f8b91292cc0c5cbcf2149f35d0ae05431c54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81f3f8b91292cc0c5cbcf2149f35d0ae05431c54",
"gitiles_ref:refs/heads/master"
]
}
[21:36:21.416] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611696980002652",
"id": "8857006943455797024",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"81f3f8b91292cc0c5cbcf2149f35d0ae05431c54\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611696980942801",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22357",
"builder:linux-chromeos-dbg",
"buildset:commit/git/81f3f8b91292cc0c5cbcf2149f35d0ae05431c54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81f3f8b91292cc0c5cbcf2149f35d0ae05431c54",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022437007831116832",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857006943455797024/+/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": "1611696980942965",
"url": "https://ci.chromium.org/b/8857006943455797024",
"utcnow_ts": "1611696981360360"
}
}
[21:36:21.416] Task URL: https://ci.chromium.org/b/8857006943455797024
[21:36:21.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:2:0) after 1m0s
[21:36:32.564] Received PubSub notification, asking Buildbucket for the build status
[21:36:32.653] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:21.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:2:0)
[21:37:21.525] Timer tick, asking Buildbucket for the build status
[21:37:21.670] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:21.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:4:0) after 1m0s
[21:38:22.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:4:0)
[21:38:22.131] Timer tick, asking Buildbucket for the build status
[21:38:22.337] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:22.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:5:0) after 1m0s
[21:39:22.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:5:0)
[21:39:22.586] Timer tick, asking Buildbucket for the build status
[21:39:22.938] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:22.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:6:0) after 1m0s
[21:40:22.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:6:0)
[21:40:22.997] Timer tick, asking Buildbucket for the build status
[21:40:23.255] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:23.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:7:0) after 1m0s
[21:41:23.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:7:0)
[21:41:23.304] Timer tick, asking Buildbucket for the build status
[21:41:23.515] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:23.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:8:0) after 1m0s
[21:42:24.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:8:0)
[21:42:24.016] Timer tick, asking Buildbucket for the build status
[21:42:24.291] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:24.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:9:0) after 1m0s
[21:43:24.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:9:0)
[21:43:24.500] Timer tick, asking Buildbucket for the build status
[21:43:24.672] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:24.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:10:0) after 1m0s
[21:44:24.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:10:0)
[21:44:24.697] Timer tick, asking Buildbucket for the build status
[21:44:24.821] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:24.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:11:0) after 1m0s
[21:45:24.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:11:0)
[21:45:24.935] Timer tick, asking Buildbucket for the build status
[21:45:25.409] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:25.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:12:0) after 1m0s
[21:46:25.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:12:0)
[21:46:25.417] Timer tick, asking Buildbucket for the build status
[21:46:26.256] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:26.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:13:0) after 1m0s
[21:47:26.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:13:0)
[21:47:26.327] Timer tick, asking Buildbucket for the build status
[21:47:26.506] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:26.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:14:0) after 1m0s
[21:48:26.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:14:0)
[21:48:26.550] Timer tick, asking Buildbucket for the build status
[21:48:26.755] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:26.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:15:0) after 1m0s
[21:49:26.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:15:0)
[21:49:26.831] Timer tick, asking Buildbucket for the build status
[21:49:27.230] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:27.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:16:0) after 1m0s
[21:50:27.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:16:0)
[21:50:27.268] Timer tick, asking Buildbucket for the build status
[21:50:27.370] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:27.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:17:0) after 1m0s
[21:51:27.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:17:0)
[21:51:27.583] Timer tick, asking Buildbucket for the build status
[21:51:27.747] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:27.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:18:0) after 1m0s
[21:52:28.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:18:0)
[21:52:28.090] Timer tick, asking Buildbucket for the build status
[21:52:28.359] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:28.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:19:0) after 1m0s
[21:53:28.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:19:0)
[21:53:28.569] Timer tick, asking Buildbucket for the build status
[21:53:29.413] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:29.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:20:0) after 1m0s
[21:54:29.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:20:0)
[21:54:29.729] Timer tick, asking Buildbucket for the build status
[21:54:29.886] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:29.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:21:0) after 1m0s
[21:55:30.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:21:0)
[21:55:30.125] Timer tick, asking Buildbucket for the build status
[21:55:30.220] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:30.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:22:0) after 1m0s
[21:56:30.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:22:0)
[21:56:30.322] Timer tick, asking Buildbucket for the build status
[21:56:30.545] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:30.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:23:0) after 1m0s
[21:57:30.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:23:0)
[21:57:30.553] Timer tick, asking Buildbucket for the build status
[21:57:30.723] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:30.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:24:0) after 1m0s
[21:58:30.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:24:0)
[21:58:30.994] Timer tick, asking Buildbucket for the build status
[21:58:31.123] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:31.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:25:0) after 1m0s
[21:59:31.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:25:0)
[21:59:31.701] Timer tick, asking Buildbucket for the build status
[21:59:31.996] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:31.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:26:0) after 1m0s
[22:00:32.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:26:0)
[22:00:32.254] Timer tick, asking Buildbucket for the build status
[22:00:32.356] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:32.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:27:0) after 1m0s
[22:01:32.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:27:0)
[22:01:32.551] Timer tick, asking Buildbucket for the build status
[22:01:32.896] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:32.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:28:0) after 1m0s
[22:02:33.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:28:0)
[22:02:33.076] Timer tick, asking Buildbucket for the build status
[22:02:33.277] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:33.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:29:0) after 1m0s
[22:03:33.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:29:0)
[22:03:33.329] Timer tick, asking Buildbucket for the build status
[22:03:33.398] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:33.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:30:0) after 1m0s
[22:04:33.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:30:0)
[22:04:33.473] Timer tick, asking Buildbucket for the build status
[22:04:33.613] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:33.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:31:0) after 1m0s
[22:05:33.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:31:0)
[22:05:33.752] Timer tick, asking Buildbucket for the build status
[22:05:33.811] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:33.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:32:0) after 1m0s
[22:06:33.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:32:0)
[22:06:33.994] Timer tick, asking Buildbucket for the build status
[22:06:35.099] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:35.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:33:0) after 1m0s
[22:07:35.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:33:0)
[22:07:35.121] Timer tick, asking Buildbucket for the build status
[22:07:35.293] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:35.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:34:0) after 1m0s
[22:08:35.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:34:0)
[22:08:35.317] Timer tick, asking Buildbucket for the build status
[22:08:35.427] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:35.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:35:0) after 1m0s
[22:09:35.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:35:0)
[22:09:35.459] Timer tick, asking Buildbucket for the build status
[22:09:35.535] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:35.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:36:0) after 1m0s
[22:10:35.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:36:0)
[22:10:35.570] Timer tick, asking Buildbucket for the build status
[22:10:35.928] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:35.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:37:0) after 1m0s
[22:11:35.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:37:0)
[22:11:35.998] Timer tick, asking Buildbucket for the build status
[22:11:36.084] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:36.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:38:0) after 1m0s
[22:12:36.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:38:0)
[22:12:36.230] Timer tick, asking Buildbucket for the build status
[22:12:36.355] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:36.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:39:0) after 1m0s
[22:13:36.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:39:0)
[22:13:36.475] Timer tick, asking Buildbucket for the build status
[22:13:36.587] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:36.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:40:0) after 1m0s
[22:14:36.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:40:0)
[22:14:36.644] Timer tick, asking Buildbucket for the build status
[22:14:36.746] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:36.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:41:0) after 1m0s
[22:15:36.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:41:0)
[22:15:36.811] Timer tick, asking Buildbucket for the build status
[22:15:36.934] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:36.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:42:0) after 1m0s
[22:16:36.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:42:0)
[22:16:36.941] Timer tick, asking Buildbucket for the build status
[22:16:37.085] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:37.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:43:0) after 1m0s
[22:17:37.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:43:0)
[22:17:37.179] Timer tick, asking Buildbucket for the build status
[22:17:37.317] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:37.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:44:0) after 1m0s
[22:18:37.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:44:0)
[22:18:37.493] Timer tick, asking Buildbucket for the build status
[22:18:37.969] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:37.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:45:0) after 1m0s
[22:19:38.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:45:0)
[22:19:38.140] Timer tick, asking Buildbucket for the build status
[22:19:38.326] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:38.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:46:0) after 1m0s
[22:20:38.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:46:0)
[22:20:38.641] Timer tick, asking Buildbucket for the build status
[22:20:39.342] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:39.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:47:0) after 1m0s
[22:21:39.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:47:0)
[22:21:39.396] Timer tick, asking Buildbucket for the build status
[22:21:39.589] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:39.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:48:0) after 1m0s
[22:22:39.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:48:0)
[22:22:39.787] Timer tick, asking Buildbucket for the build status
[22:22:39.837] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:39.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:49:0) after 1m0s
[22:23:40.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:49:0)
[22:23:40.087] Timer tick, asking Buildbucket for the build status
[22:23:40.202] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:40.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:50:0) after 1m0s
[22:24:40.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:50:0)
[22:24:40.406] Timer tick, asking Buildbucket for the build status
[22:24:40.473] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:40.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:51:0) after 1m0s
[22:25:40.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:51:0)
[22:25:40.653] Timer tick, asking Buildbucket for the build status
[22:25:40.767] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:40.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:52:0) after 1m0s
[22:26:40.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:52:0)
[22:26:40.903] Timer tick, asking Buildbucket for the build status
[22:26:41.062] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:41.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:53:0) after 1m0s
[22:27:41.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:53:0)
[22:27:41.136] Timer tick, asking Buildbucket for the build status
[22:27:41.328] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:41.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:54:0) after 1m0s
[22:28:41.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:54:0)
[22:28:41.462] Timer tick, asking Buildbucket for the build status
[22:28:41.649] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:41.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:55:0) after 1m0s
[22:29:41.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:55:0)
[22:29:41.863] Timer tick, asking Buildbucket for the build status
[22:29:42.355] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:42.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:56:0) after 1m0s
[22:30:42.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:56:0)
[22:30:42.587] Timer tick, asking Buildbucket for the build status
[22:30:42.804] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:42.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:57:0) after 1m0s
[22:31:43.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:57:0)
[22:31:43.012] Timer tick, asking Buildbucket for the build status
[22:31:44.081] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:44.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:58:0) after 1m0s
[22:32:44.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:58:0)
[22:32:44.196] Timer tick, asking Buildbucket for the build status
[22:32:44.545] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:44.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:59:0) after 1m0s
[22:33:44.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:59:0)
[22:33:44.599] Timer tick, asking Buildbucket for the build status
[22:33:44.853] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:44.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:60:0) after 1m0s
[22:34:44.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:60:0)
[22:34:44.980] Timer tick, asking Buildbucket for the build status
[22:34:45.270] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:45.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:61:0) after 1m0s
[22:35:46.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:61:0)
[22:35:46.277] Timer tick, asking Buildbucket for the build status
[22:35:46.465] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:46.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:62:0) after 1m0s
[22:36:46.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:62:0)
[22:36:46.685] Timer tick, asking Buildbucket for the build status
[22:36:47.378] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:47.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:63:0) after 1m0s
[22:37:47.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:63:0)
[22:37:47.520] Timer tick, asking Buildbucket for the build status
[22:37:47.725] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:47.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:64:0) after 1m0s
[22:38:47.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:64:0)
[22:38:47.795] Timer tick, asking Buildbucket for the build status
[22:38:47.947] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:47.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:65:0) after 1m0s
[22:39:47.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:65:0)
[22:39:47.970] Timer tick, asking Buildbucket for the build status
[22:39:48.100] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:48.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:66:0) after 1m0s
[22:40:48.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:66:0)
[22:40:48.101] Timer tick, asking Buildbucket for the build status
[22:40:49.459] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:49.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:67:0) after 1m0s
[22:41:49.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:67:0)
[22:41:49.637] Timer tick, asking Buildbucket for the build status
[22:41:49.857] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:49.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:68:0) after 1m0s
[22:42:49.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:68:0)
[22:42:49.973] Timer tick, asking Buildbucket for the build status
[22:42:50.302] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:50.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:69:0) after 1m0s
[22:43:50.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:69:0)
[22:43:50.323] Timer tick, asking Buildbucket for the build status
[22:43:50.857] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:50.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:70:0) after 1m0s
[22:44:50.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:70:0)
[22:44:50.902] Timer tick, asking Buildbucket for the build status
[22:44:51.121] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:51.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:71:0) after 1m0s
[22:45:51.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:71:0)
[22:45:51.166] Timer tick, asking Buildbucket for the build status
[22:45:51.314] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:51.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:72:0) after 1m0s
[22:46:51.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:72:0)
[22:46:51.381] Timer tick, asking Buildbucket for the build status
[22:46:51.577] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:51.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:73:0) after 1m0s
[22:47:51.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:73:0)
[22:47:51.648] Timer tick, asking Buildbucket for the build status
[22:47:52.251] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:52.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:74:0) after 1m0s
[22:48:52.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:74:0)
[22:48:52.263] Timer tick, asking Buildbucket for the build status
[22:48:52.541] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:52.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:75:0) after 1m0s
[22:49:52.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:75:0)
[22:49:52.576] Timer tick, asking Buildbucket for the build status
[22:49:52.743] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:52.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:76:0) after 1m0s
[22:50:52.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:76:0)
[22:50:52.736] Timer tick, asking Buildbucket for the build status
[22:50:52.996] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:52.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:77:0) after 1m0s
[22:51:53.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:77:0)
[22:51:53.092] Timer tick, asking Buildbucket for the build status
[22:51:53.282] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:53.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:78:0) after 1m0s
[22:52:53.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:78:0)
[22:52:53.286] Timer tick, asking Buildbucket for the build status
[22:52:53.498] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:53.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:79:0) after 1m0s
[22:53:53.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:79:0)
[22:53:53.551] Timer tick, asking Buildbucket for the build status
[22:53:53.649] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:53.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:80:0) after 1m0s
[22:54:53.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:80:0)
[22:54:53.707] Timer tick, asking Buildbucket for the build status
[22:54:53.806] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:53.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:81:0) after 1m0s
[22:55:53.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:81:0)
[22:55:53.895] Timer tick, asking Buildbucket for the build status
[22:55:54.298] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:54.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:82:0) after 1m0s
[22:56:54.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:82:0)
[22:56:54.327] Timer tick, asking Buildbucket for the build status
[22:56:54.875] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:54.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:83:0) after 1m0s
[22:57:54.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:83:0)
[22:57:54.952] Timer tick, asking Buildbucket for the build status
[22:57:55.155] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:55.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:84:0) after 1m0s
[22:58:55.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:84:0)
[22:58:55.189] Timer tick, asking Buildbucket for the build status
[22:58:55.399] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:55.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:85:0) after 1m0s
[22:59:55.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:85:0)
[22:59:55.450] Timer tick, asking Buildbucket for the build status
[22:59:55.932] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:55.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:86:0) after 1m0s
[23:00:55.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:86:0)
[23:00:55.994] Timer tick, asking Buildbucket for the build status
[23:00:56.300] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:56.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:87:0) after 1m0s
[23:01:56.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:87:0)
[23:01:56.322] Timer tick, asking Buildbucket for the build status
[23:01:56.483] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:56.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:88:0) after 1m0s
[23:02:56.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:88:0)
[23:02:56.509] Timer tick, asking Buildbucket for the build status
[23:02:56.967] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:56.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:89:0) after 1m0s
[23:03:57.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:89:0)
[23:03:57.004] Timer tick, asking Buildbucket for the build status
[23:03:57.089] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:57.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:90:0) after 1m0s
[23:04:57.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:90:0)
[23:04:57.119] Timer tick, asking Buildbucket for the build status
[23:04:57.205] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:57.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:91:0) after 1m0s
[23:05:57.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:91:0)
[23:05:57.238] Timer tick, asking Buildbucket for the build status
[23:05:57.315] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:57.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:92:0) after 1m0s
[23:06:57.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:92:0)
[23:06:57.387] Timer tick, asking Buildbucket for the build status
[23:06:57.820] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:57.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:93:0) after 1m0s
[23:07:57.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:93:0)
[23:07:57.836] Timer tick, asking Buildbucket for the build status
[23:07:57.903] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:57.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:94:0) after 1m0s
[23:08:57.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:94:0)
[23:08:57.930] Timer tick, asking Buildbucket for the build status
[23:08:58.043] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:58.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:95:0) after 1m0s
[23:09:58.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:95:0)
[23:09:58.118] Timer tick, asking Buildbucket for the build status
[23:09:58.837] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:58.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:96:0) after 1m0s
[23:10:58.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:96:0)
[23:10:58.858] Timer tick, asking Buildbucket for the build status
[23:10:59.293] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:59.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:97:0) after 1m0s
[23:11:59.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:97:0)
[23:11:59.315] Timer tick, asking Buildbucket for the build status
[23:11:59.775] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:59.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:98:0) after 1m0s
[23:12:59.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:98:0)
[23:12:59.799] Timer tick, asking Buildbucket for the build status
[23:12:59.935] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:59.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:99:0) after 1m0s
[23:14:00.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:99:0)
[23:14:00.036] Timer tick, asking Buildbucket for the build status
[23:14:00.430] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:00.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:100:0) after 1m0s
[23:15:00.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:100:0)
[23:15:00.762] Timer tick, asking Buildbucket for the build status
[23:15:00.861] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:00.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:101:0) after 1m0s
[23:16:01.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:101:0)
[23:16:01.262] Timer tick, asking Buildbucket for the build status
[23:16:01.759] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:01.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:102:0) after 1m0s
[23:17:01.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:102:0)
[23:17:01.782] Timer tick, asking Buildbucket for the build status
[23:17:01.932] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:01.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:103:0) after 1m0s
[23:18:01.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:103:0)
[23:18:01.959] Timer tick, asking Buildbucket for the build status
[23:18:02.197] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:02.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:104:0) after 1m0s
[23:19:02.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:104:0)
[23:19:02.241] Timer tick, asking Buildbucket for the build status
[23:19:02.350] Build 8857006943455797024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:02.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022437007831116832:105:0) after 1m0s
[23:19:31.131] Received PubSub notification, asking Buildbucket for the build status
[23:19:31.470] Build 8857006943455797024: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[23:19:31.470] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611703169962222",
"created_by": "project:chromium",
"created_ts": "1611696980002652",
"failure_reason": "BUILD_FAILURE",
"id": "8857006943455797024",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"81f3f8b91292cc0c5cbcf2149f35d0ae05431c54\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**ash_unittests** failed because of:\\n\\n- DesksTest.TransientWindows\"}, \"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\": \"81f3f8b91292cc0c5cbcf2149f35d0ae05431c54\", \"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-197-j1hi\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22357, \"got_angle_revision\": \"50f7d64610097f0a1eeef27e6e35612ad52b1023\", \"got_dawn_revision\": \"2fe8cab10aeb3956b619a6c0c062417e05aa95d3\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"81f3f8b91292cc0c5cbcf2149f35d0ae05431c54\", \"got_revision_cp\": \"refs/heads/master@{#847313}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"ea1f7d10db1f22f3327f4c0bc690695bc1a73aa0\", \"got_v8_revision\": \"c316f1301cc02dea5fe5722364062578c071f4af\", \"got_v8_revision_cp\": \"refs/heads/9.0.71@{#1}\", \"got_webrtc_revision\": \"c57089a97a3df454f4356d882cc8df173e8b3ead\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33072}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"81f3f8b91292cc0c5cbcf2149f35d0ae05431c54\", \"swarm_hashes_refs/heads/master(at){#847313}_without_patch\": {\"absl_hardening_tests\": \"3393d1028a6aeab1ed3a1f2de8b80435198cd2e6\", \"accessibility_unittests\": \"53da71ad01697bd4b0b36ef8aa76c37768a5f930\", \"angle_unittests\": \"c29df9aa00dd5fd53b05ae39486fe6d9c82daa6b\", \"app_list_unittests\": \"a0a715c81b2b8ea7cbbaf720ee169c8f48070f2e\", \"app_shell_unittests\": \"ab398923c45f9260357b18f95a59be617654d8e8\", \"ash_unittests\": \"b192265fac3a6bd9fcfaa1c9cf39f3ad930e8589\", \"aura_unittests\": \"da5604e895c883053aee4db88fc901d177759ff4\", \"base_unittests\": \"5f2a2f752a6041e279ab3a80881bb94e55308bdb\", \"base_util_unittests\": \"b48153bff250b60f7b91e763c3038f5802a330bf\", \"blink_common_unittests\": \"c1bcdf7a0553ee40273b373f00ec55e425362ba8\", \"blink_fuzzer_unittests\": \"3ac229131d9a240483fb05f5c42f74e32bbbf120\", \"blink_heap_unittests\": \"54f589f8097187c2ff6e2c7bfc959f7c7b35a410\", \"blink_platform_unittests\": \"3f1a983bb9b4c6ebbbc8325c6310f7bdda9da034\", \"blink_unittests\": \"aefd8b19ccfc66422b00df4603d8c18f212a4928\", \"boringssl_crypto_tests\": \"5cd741eeac3164f83da1c684f659a218a3012c04\", \"boringssl_ssl_tests\": \"8d00ced5ed2435677972325d803cb03ebb8d5d70\", \"browser_tests\": \"34e3677d0970416b4f9e1db6227ba97f4a1f45bb\", \"capture_unittests\": \"43df9ee209a591409d39b11ab71da5a396501bc4\", \"cast_unittests\": \"c4a0ce9477cca5f6492ac48a83116bf28efb3b22\", \"cc_unittests\": \"49a82d9bca07cbf4cc3ff6c2ecb28cbcb128e9cd\", \"chrome_app_unittests\": \"cddf631e1b779d851767d357954e782443060d1e\", \"chromedriver_unittests\": \"4c1cb6b8539992f65f13fcc450cb5d2dda8612fe\", \"chromeos_components_unittests\": \"a69d806b5b0a80980bfb85278a35a80e2a47fe65\", \"chromeos_unittests\": \"f47dc9dc6b9a9febcc9d00d85b642a1792b388af\", \"components_browsertests\": \"2283beb866332d770b5e55b212ad95e01e9b3a7f\", \"components_unittests\": \"d6f5a088be7d65f29381ab16b52839eaf58ff189\", \"compositor_unittests\": \"18de0031e87aca0cf4cd34154fc3407759e853ba\", \"content_browsertests\": \"71c7494aad427a65b99705397238ed21ac319605\", \"content_unittests\": \"f4d6fcec89622951cb5d2b97baa57f85c6fdb068\", \"crashpad_tests\": \"726504c60a13b63e66b904afda4fae471ad67ae7\", \"crypto_unittests\": \"f6aecfed2940cbdd29aa52843bb58eb89e724025\", \"dbus_unittests\": \"e16d825fd2a96121dde60b4ea22d35ae951e0308\", \"device_unittests\": \"1159431526537309a4cd2ee960412b8b698fec10\", \"display_unittests\": \"b5829701ba60ba30a776671fbdc43599ac6f214a\", \"events_unittests\": \"7c5bfd32221e2f3493c6747152075cc536b0ac97\", \"exo_unittests\": \"3e9f44b2ace81440373b275085eac9d60d5b2de9\", \"extensions_browsertests\": \"e0bf46d29c082a08d8e474943f9d927ce2f4de63\", \"extensions_unittests\": \"085723c83ce8f3f560141fa75ed356a67a9f6b93\", \"filesystem_service_unittests\": \"305ea30576f257198dfd0f5393adf476dde3cb6c\", \"gcm_unit_tests\": \"a2ac36812f36ca055e4218dc171e1f0d72c71644\", \"gfx_unittests\": \"228b23dca0566ab52c243ea3a745c2f584ab056e\", \"gin_unittests\": \"e172dfbc58adf3707d1b78b0098c6e2dfc280129\", \"gl_unittests_ozone\": \"28b2cbc5e606d2f569deebba04b3452003ff7681\", \"google_apis_unittests\": \"a751960a316e481bea7ae3bb90ab38c2f16197f2\", \"gpu_unittests\": \"25212e794b84e019c40ef7009bb7c9690c8481c5\", \"gwp_asan_unittests\": \"10fdd017f7a0544270f4ced2dae25986e8aeb8f2\", \"interactive_ui_tests\": \"524b81f26bbc5a51d75f4cda0ca06f9b22847b8d\", \"ipc_tests\": \"b842e2fa728c3f85d992ce08315841187984c110\", \"jingle_unittests\": \"7a69c3ba3471d227929bdfac10c6b388a726f859\", \"keyboard_unittests\": \"17acf65c4e37bc02c55425be6f838731519f72a6\", \"latency_unittests\": \"021d0273b84b2b51854bb164a334209b685695d2\", \"libjingle_xmpp_unittests\": \"511d3f4626fbc6ea1a16cf9fd89de3f0569cac4a\", \"liburlpattern_unittests\": \"85098f06dc11ccb987107fdc0d0b5ea59ba7a450\", \"media_blink_unittests\": \"61aaed84c3f14c97a966814af1772a322962968f\", \"media_unittests\": \"d3cec3a710490018e83638f4f3d9ad019cbc5ba8\", \"message_center_unittests\": \"e9fe90a1bfd5a04f9e63b96f38eb19a4adb3d4d2\", \"midi_unittests\": \"1d087ca71ce47bcaec8c61ac33bdf2d538cc3c58\", \"mojo_core_unittests\": \"4bb7dcdeef0a6754db4841fe4498923933749058\", \"mojo_unittests\": \"3a1cb11099ae06198719f9c61bf41f58717207d7\", \"nacl_helper_nonsfi_unittests\": \"46004937e74144aaeba58aa79702a81874c80a15\", \"nacl_loader_unittests\": \"dc6f0aa27ea54b2f295b7f26b8e3981a5b8a0c47\", \"native_theme_unittests\": \"227b5d5ecb4c5456b273cbda44896b17219bb791\", \"net_unittests\": \"07d4eee48e0b8a965282316b1a2121fcc8816b1f\", \"ozone_gl_unittests\": \"c1ed655c756d6b7c2dda1db9307e4a9c355b7c98\", \"ozone_unittests\": \"ea925cdde95919c3b0c02bb2e60b103a2472e69d\", \"ozone_x11_unittests\": \"4ef1e95a17e204c9d1c6ef1c47cba77cf88f2fb2\", \"pdf_unittests\": \"1412f79500955276c131d2bfa1eded7fa4dc84f1\", \"perfetto_unittests\": \"4031aa349510ead603319a27078af36db1515a18\", \"ppapi_unittests\": \"8ab98efbd970db69ca60ce9117c487a8bf066167\", \"printing_unittests\": \"1470a15360a38de475d2aa15a6b4b4a39319d6f1\", \"remoting_unittests\": \"484020d0bb5922ca5d6e827616df4c69100e37bd\", \"sandbox_linux_unittests\": \"de91cfafbf062f6e6ccace7059176d627a92085b\", \"service_manager_unittests\": \"19d031944326243ba5a05ba7d451f4448280c7cd\", \"services_unittests\": \"e9c49f4b474a59653218512320d0d0a76ecbdfff\", \"shell_dialogs_unittests\": \"bcae219ceca7230c9f8b1a36fe1fde6f53263160\", \"shell_encryption_unittests\": \"5d87c6be703a92d9a18981d9597772eed70c48e8\", \"skia_unittests\": \"18986d61eef5b2f86ea926643c27e1523611b345\", \"snapshot_unittests\": \"209b7927ddb72392869d00488efb5527743ea7ff\", \"sql_unittests\": \"3c600613627e77833c54e8bbc57a78e45f54b209\", \"storage_unittests\": \"5dad204801eb4e286b1d7f4c314bfe870c7d8fa5\", \"sync_integration_tests\": \"d271276d4cf75df778923ee16ea9adcc6e27cc00\", \"traffic_annotation_auditor_unittests\": \"8f55d4997751c3f9f369badbdd6333d888bc2197\", \"ui_base_unittests\": \"b79c4262239c413e71fddb0e33485aef6ecb31d2\", \"ui_chromeos_unittests\": \"b7ca4d32afc2b07048532591a2e9fc2772f0ddf6\", \"ui_touch_selection_unittests\": \"4d54fd47a3cfcbe17a4ae0a4afecf29781aa0123\", \"unit_tests\": \"14c99b0ee2b248b4a7c1137c0cb5774580446622\", \"url_unittests\": \"83768886713d0ef8dcf9fd2c10d9a8ac3af79eb2\", \"usage_time_limit_unittests\": \"4e3d9c2f16592a991309a07ad1fd08833962caf3\", \"views_unittests\": \"b16360a83e1c3b507c7e696e45a7621cf300efe2\", \"viz_unittests\": \"5fcd9761046818b8339f10a917c481e26aca7994\", \"wm_unittests\": \"46141bcade1a633e6cbd8385013acf96a32d075c\", \"wtf_unittests\": \"fd3ae3d5d7679f79fa6a38a4425a93d753edc5ec\", \"zlib_unittests\": \"63cc7076dd1b334403b59c3e43b697ca3260ae78\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02c50c25350278ea3e2feb85c748c248af9e0ccc93852ce717c8651b544f7a96_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_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-197-j1hi\"], \"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\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**ash_unittests** failed because of:\\n\\n- DesksTest.TransientWindows\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611696991674961",
"status": "COMPLETED",
"status_changed_ts": "1611696992143595",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22357",
"builder:linux-chromeos-dbg",
"buildset:commit/git/81f3f8b91292cc0c5cbcf2149f35d0ae05431c54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81f3f8b91292cc0c5cbcf2149f35d0ae05431c54",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022437007831116832",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857006943455797024/+/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:515971df251a6810",
"user_agent:luci-scheduler"
],
"updated_ts": "1611703170772594",
"url": "https://ci.chromium.org/b/8857006943455797024",
"utcnow_ts": "1611703171431923"
}
}
[23:19:31.470] Invocation finished in 1h43m15.024203215s with status FAILED