[00:36:04.310] New invocation is queued and will start shortly
[00:36:05.475] Starting the invocation (attempt 1)
[00:36:05.525] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:36:05.525] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:36:05.525] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028042707871477424",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"490ed7f40cdc335548f88a8b7bf75168e08612dc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9028042707871477424",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/490ed7f40cdc335548f88a8b7bf75168e08612dc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/490ed7f40cdc335548f88a8b7bf75168e08612dc",
"gitiles_ref:refs/heads/master"
]
}
[00:36:06.252] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606350965650758",
"id": "8862612645800995952",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"490ed7f40cdc335548f88a8b7bf75168e08612dc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606350966127786",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21473",
"builder:linux-chromeos-dbg",
"buildset:commit/git/490ed7f40cdc335548f88a8b7bf75168e08612dc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/490ed7f40cdc335548f88a8b7bf75168e08612dc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028042707871477424",
"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/8862612645800995952/+/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": "1606350966127911",
"url": "https://ci.chromium.org/b/8862612645800995952",
"utcnow_ts": "1606350966234136"
}
}
[00:36:06.252] Task URL: https://ci.chromium.org/b/8862612645800995952
[00:36:06.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:2:0) after 1m0s
[00:37:06.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:2:0)
[00:37:06.274] Timer tick, asking Buildbucket for the build status
[00:37:06.378] Build 8862612645800995952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:06.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:3:0) after 1m0s
[00:38:06.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:3:0)
[00:38:06.399] Timer tick, asking Buildbucket for the build status
[00:38:06.472] Build 8862612645800995952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:06.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:4:0) after 1m0s
[00:39:06.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:4:0)
[00:39:06.507] Timer tick, asking Buildbucket for the build status
[00:39:06.583] Build 8862612645800995952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:06.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:5:0) after 1m0s
[00:40:06.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:5:0)
[00:40:06.690] Timer tick, asking Buildbucket for the build status
[00:40:06.785] Build 8862612645800995952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:06.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:6:0) after 1m0s
[00:41:06.196] Received PubSub notification, asking Buildbucket for the build status
[00:41:06.708] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:06.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:6:0)
[00:41:06.835] Timer tick, asking Buildbucket for the build status
[00:41:07.440] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:07.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:8:0) after 1m0s
[00:42:07.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:8:0)
[00:42:07.599] Timer tick, asking Buildbucket for the build status
[00:42:07.697] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:07.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:9:0) after 1m0s
[00:43:07.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:9:0)
[00:43:07.675] Timer tick, asking Buildbucket for the build status
[00:43:07.734] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:07.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:10:0) after 1m0s
[00:44:07.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:10:0)
[00:44:07.759] Timer tick, asking Buildbucket for the build status
[00:44:07.874] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:07.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:11:0) after 1m0s
[00:45:07.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:11:0)
[00:45:07.898] Timer tick, asking Buildbucket for the build status
[00:45:07.963] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:07.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:12:0) after 1m0s
[00:46:07.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:12:0)
[00:46:07.970] Timer tick, asking Buildbucket for the build status
[00:46:08.353] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:08.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:13:0) after 1m0s
[00:47:08.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:13:0)
[00:47:08.345] Timer tick, asking Buildbucket for the build status
[00:47:08.605] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:08.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:14:0) after 1m0s
[00:48:08.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:14:0)
[00:48:08.667] Timer tick, asking Buildbucket for the build status
[00:48:09.078] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:09.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:15:0) after 1m0s
[00:49:09.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:15:0)
[00:49:09.128] Timer tick, asking Buildbucket for the build status
[00:49:09.254] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:09.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:16:0) after 1m0s
[00:50:09.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:16:0)
[00:50:09.273] Timer tick, asking Buildbucket for the build status
[00:50:09.330] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:09.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:17:0) after 1m0s
[00:51:09.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:17:0)
[00:51:09.382] Timer tick, asking Buildbucket for the build status
[00:51:09.541] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:09.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:18:0) after 1m0s
[00:52:09.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:18:0)
[00:52:09.661] Timer tick, asking Buildbucket for the build status
[00:52:09.716] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:09.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:19:0) after 1m0s
[00:53:09.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:19:0)
[00:53:09.784] Timer tick, asking Buildbucket for the build status
[00:53:09.844] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:09.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:20:0) after 1m0s
[00:54:10.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:20:0)
[00:54:10.013] Timer tick, asking Buildbucket for the build status
[00:54:10.122] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:10.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:21:0) after 1m0s
[00:55:10.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:21:0)
[00:55:10.508] Timer tick, asking Buildbucket for the build status
[00:55:10.602] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:10.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:22:0) after 1m0s
[00:56:10.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:22:0)
[00:56:10.628] Timer tick, asking Buildbucket for the build status
[00:56:10.722] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:10.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:23:0) after 1m0s
[00:57:10.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:23:0)
[00:57:10.785] Timer tick, asking Buildbucket for the build status
[00:57:11.001] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:11.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:24:0) after 1m0s
[00:58:11.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:24:0)
[00:58:11.085] Timer tick, asking Buildbucket for the build status
[00:58:11.169] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:11.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:25:0) after 1m0s
[00:59:11.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:25:0)
[00:59:11.187] Timer tick, asking Buildbucket for the build status
[00:59:11.237] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:11.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:26:0) after 1m0s
[01:00:11.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:26:0)
[01:00:11.356] Timer tick, asking Buildbucket for the build status
[01:00:11.458] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:11.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:27:0) after 1m0s
[01:01:11.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:27:0)
[01:01:11.536] Timer tick, asking Buildbucket for the build status
[01:01:11.842] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:11.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:28:0) after 1m0s
[01:02:11.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:28:0)
[01:02:11.893] Timer tick, asking Buildbucket for the build status
[01:02:12.014] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:12.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:29:0) after 1m0s
[01:03:12.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:29:0)
[01:03:12.059] Timer tick, asking Buildbucket for the build status
[01:03:12.454] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:12.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:30:0) after 1m0s
[01:04:12.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:30:0)
[01:04:12.511] Timer tick, asking Buildbucket for the build status
[01:04:12.571] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:12.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:31:0) after 1m0s
[01:05:12.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:31:0)
[01:05:12.606] Timer tick, asking Buildbucket for the build status
[01:05:12.676] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:12.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:32:0) after 1m0s
[01:06:12.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:32:0)
[01:06:12.698] Timer tick, asking Buildbucket for the build status
[01:06:13.025] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:13.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:33:0) after 1m0s
[01:07:13.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:33:0)
[01:07:13.142] Timer tick, asking Buildbucket for the build status
[01:07:13.515] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:13.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:34:0) after 1m0s
[01:08:13.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:34:0)
[01:08:13.643] Timer tick, asking Buildbucket for the build status
[01:08:13.712] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:13.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:35:0) after 1m0s
[01:09:13.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:35:0)
[01:09:13.826] Timer tick, asking Buildbucket for the build status
[01:09:13.882] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:13.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:36:0) after 1m0s
[01:10:13.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:36:0)
[01:10:13.957] Timer tick, asking Buildbucket for the build status
[01:10:14.238] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:14.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:37:0) after 1m0s
[01:11:14.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:37:0)
[01:11:14.289] Timer tick, asking Buildbucket for the build status
[01:11:14.400] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:14.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:38:0) after 1m0s
[01:12:14.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:38:0)
[01:12:14.429] Timer tick, asking Buildbucket for the build status
[01:12:14.492] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:14.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:39:0) after 1m0s
[01:13:14.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:39:0)
[01:13:14.521] Timer tick, asking Buildbucket for the build status
[01:13:16.761] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:16.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:40:0) after 1m0s
[01:14:16.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:40:0)
[01:14:16.910] Timer tick, asking Buildbucket for the build status
[01:14:17.021] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:17.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:41:0) after 1m0s
[01:15:17.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:41:0)
[01:15:17.099] Timer tick, asking Buildbucket for the build status
[01:15:17.269] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:17.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:42:0) after 1m0s
[01:16:17.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:42:0)
[01:16:17.342] Timer tick, asking Buildbucket for the build status
[01:16:18.303] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:18.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:43:0) after 1m0s
[01:17:18.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:43:0)
[01:17:18.392] Timer tick, asking Buildbucket for the build status
[01:17:18.546] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:18.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:44:0) after 1m0s
[01:18:18.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:44:0)
[01:18:18.616] Timer tick, asking Buildbucket for the build status
[01:18:18.743] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:18.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:45:0) after 1m0s
[01:19:18.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:45:0)
[01:19:18.800] Timer tick, asking Buildbucket for the build status
[01:19:18.882] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:18.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:46:0) after 1m0s
[01:20:18.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:46:0)
[01:20:18.905] Timer tick, asking Buildbucket for the build status
[01:20:18.973] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:18.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:47:0) after 1m0s
[01:21:19.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:47:0)
[01:21:19.029] Timer tick, asking Buildbucket for the build status
[01:21:19.146] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:19.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:48:0) after 1m0s
[01:22:19.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:48:0)
[01:22:19.235] Timer tick, asking Buildbucket for the build status
[01:22:19.298] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:19.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:49:0) after 1m0s
[01:23:19.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:49:0)
[01:23:19.346] Timer tick, asking Buildbucket for the build status
[01:23:19.404] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:19.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:50:0) after 1m0s
[01:24:19.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:50:0)
[01:24:19.452] Timer tick, asking Buildbucket for the build status
[01:24:19.522] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:19.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:51:0) after 1m0s
[01:25:19.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:51:0)
[01:25:19.498] Timer tick, asking Buildbucket for the build status
[01:25:19.569] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:19.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:52:0) after 1m0s
[01:26:19.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:52:0)
[01:26:19.608] Timer tick, asking Buildbucket for the build status
[01:26:19.712] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:19.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:53:0) after 1m0s
[01:27:19.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:53:0)
[01:27:19.783] Timer tick, asking Buildbucket for the build status
[01:27:19.877] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:19.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:54:0) after 1m0s
[01:28:19.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:54:0)
[01:28:19.882] Timer tick, asking Buildbucket for the build status
[01:28:20.010] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:20.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:55:0) after 1m0s
[01:29:20.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:55:0)
[01:29:20.029] Timer tick, asking Buildbucket for the build status
[01:29:20.356] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:20.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:56:0) after 1m0s
[01:30:20.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:56:0)
[01:30:20.369] Timer tick, asking Buildbucket for the build status
[01:30:20.552] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:20.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:57:0) after 1m0s
[01:31:20.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:57:0)
[01:31:20.573] Timer tick, asking Buildbucket for the build status
[01:31:21.119] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:21.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:58:0) after 1m0s
[01:32:21.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:58:0)
[01:32:21.117] Timer tick, asking Buildbucket for the build status
[01:32:21.510] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:21.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:59:0) after 1m0s
[01:33:21.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:59:0)
[01:33:21.545] Timer tick, asking Buildbucket for the build status
[01:33:22.264] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:22.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:60:0) after 1m0s
[01:34:22.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:60:0)
[01:34:22.317] Timer tick, asking Buildbucket for the build status
[01:34:22.509] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:22.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:61:0) after 1m0s
[01:35:22.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:61:0)
[01:35:22.581] Timer tick, asking Buildbucket for the build status
[01:35:22.918] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:22.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:62:0) after 1m0s
[01:36:22.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:62:0)
[01:36:22.920] Timer tick, asking Buildbucket for the build status
[01:36:23.223] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:23.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:63:0) after 1m0s
[01:37:23.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:63:0)
[01:37:23.253] Timer tick, asking Buildbucket for the build status
[01:37:23.507] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:23.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:64:0) after 1m0s
[01:38:23.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:64:0)
[01:38:23.503] Timer tick, asking Buildbucket for the build status
[01:38:23.985] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:23.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:65:0) after 1m0s
[01:39:24.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:65:0)
[01:39:24.036] Timer tick, asking Buildbucket for the build status
[01:39:24.174] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:24.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:66:0) after 1m0s
[01:40:24.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:66:0)
[01:40:24.227] Timer tick, asking Buildbucket for the build status
[01:40:24.340] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:24.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:67:0) after 1m0s
[01:41:24.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:67:0)
[01:41:24.351] Timer tick, asking Buildbucket for the build status
[01:41:24.562] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:24.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:68:0) after 1m0s
[01:42:24.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:68:0)
[01:42:24.610] Timer tick, asking Buildbucket for the build status
[01:42:24.684] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:24.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:69:0) after 1m0s
[01:43:24.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:69:0)
[01:43:24.819] Timer tick, asking Buildbucket for the build status
[01:43:24.933] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:24.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:70:0) after 1m0s
[01:44:24.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:70:0)
[01:44:24.940] Timer tick, asking Buildbucket for the build status
[01:44:25.012] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:25.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:71:0) after 1m0s
[01:45:25.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:71:0)
[01:45:25.080] Timer tick, asking Buildbucket for the build status
[01:45:25.495] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:25.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:72:0) after 1m0s
[01:46:25.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:72:0)
[01:46:25.588] Timer tick, asking Buildbucket for the build status
[01:46:25.724] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:25.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:73:0) after 1m0s
[01:47:25.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:73:0)
[01:47:25.756] Timer tick, asking Buildbucket for the build status
[01:47:25.837] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:25.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:74:0) after 1m0s
[01:48:25.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:74:0)
[01:48:25.901] Timer tick, asking Buildbucket for the build status
[01:48:26.050] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:26.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:75:0) after 1m0s
[01:49:26.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:75:0)
[01:49:26.078] Timer tick, asking Buildbucket for the build status
[01:49:26.561] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:26.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:76:0) after 1m0s
[01:50:26.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:76:0)
[01:50:26.705] Timer tick, asking Buildbucket for the build status
[01:50:26.814] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:26.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:77:0) after 1m0s
[01:51:26.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:77:0)
[01:51:26.920] Timer tick, asking Buildbucket for the build status
[01:51:27.655] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:27.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:78:0) after 1m0s
[01:52:27.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:78:0)
[01:52:27.724] Timer tick, asking Buildbucket for the build status
[01:52:27.793] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:27.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:79:0) after 1m0s
[01:53:27.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:79:0)
[01:53:27.786] Timer tick, asking Buildbucket for the build status
[01:53:27.989] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:27.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:80:0) after 1m0s
[01:54:27.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:80:0)
[01:54:27.996] Timer tick, asking Buildbucket for the build status
[01:54:28.066] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:28.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:81:0) after 1m0s
[01:55:28.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:81:0)
[01:55:28.115] Timer tick, asking Buildbucket for the build status
[01:55:28.228] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:28.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:82:0) after 1m0s
[01:56:28.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:82:0)
[01:56:28.273] Timer tick, asking Buildbucket for the build status
[01:56:28.569] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:28.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:83:0) after 1m0s
[01:57:28.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:83:0)
[01:57:28.591] Timer tick, asking Buildbucket for the build status
[01:57:28.661] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:28.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:84:0) after 1m0s
[01:58:28.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:84:0)
[01:58:28.699] Timer tick, asking Buildbucket for the build status
[01:58:28.779] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:28.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:85:0) after 1m0s
[01:59:28.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:85:0)
[01:59:28.851] Timer tick, asking Buildbucket for the build status
[01:59:29.292] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:29.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:86:0) after 1m0s
[02:00:29.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:86:0)
[02:00:29.334] Timer tick, asking Buildbucket for the build status
[02:00:29.408] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:29.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:87:0) after 1m0s
[02:01:29.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:87:0)
[02:01:29.432] Timer tick, asking Buildbucket for the build status
[02:01:29.640] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:29.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:88:0) after 1m0s
[02:02:29.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:88:0)
[02:02:29.711] Timer tick, asking Buildbucket for the build status
[02:02:30.540] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:30.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:89:0) after 1m0s
[02:03:30.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:89:0)
[02:03:30.636] Timer tick, asking Buildbucket for the build status
[02:03:30.865] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:30.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:90:0) after 1m0s
[02:04:30.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:90:0)
[02:04:30.888] Timer tick, asking Buildbucket for the build status
[02:04:31.562] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:31.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:91:0) after 1m0s
[02:05:31.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:91:0)
[02:05:31.612] Timer tick, asking Buildbucket for the build status
[02:05:31.684] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:31.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:92:0) after 1m0s
[02:06:31.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:92:0)
[02:06:31.722] Timer tick, asking Buildbucket for the build status
[02:06:32.156] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:32.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:93:0) after 1m0s
[02:07:32.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:93:0)
[02:07:32.211] Timer tick, asking Buildbucket for the build status
[02:07:32.722] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:32.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:94:0) after 1m0s
[02:08:32.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:94:0)
[02:08:32.736] Timer tick, asking Buildbucket for the build status
[02:08:32.811] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:32.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:95:0) after 1m0s
[02:09:32.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:95:0)
[02:09:32.897] Timer tick, asking Buildbucket for the build status
[02:09:32.965] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:32.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:96:0) after 1m0s
[02:10:32.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:96:0)
[02:10:32.973] Timer tick, asking Buildbucket for the build status
[02:10:33.068] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:33.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:97:0) after 1m0s
[02:11:33.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:97:0)
[02:11:33.111] Timer tick, asking Buildbucket for the build status
[02:11:33.233] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:33.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:98:0) after 1m0s
[02:12:33.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:98:0)
[02:12:33.313] Timer tick, asking Buildbucket for the build status
[02:12:33.402] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:33.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:99:0) after 1m0s
[02:13:33.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:99:0)
[02:13:33.477] Timer tick, asking Buildbucket for the build status
[02:13:33.540] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:33.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:100:0) after 1m0s
[02:14:33.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:100:0)
[02:14:33.655] Timer tick, asking Buildbucket for the build status
[02:14:33.893] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:33.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:101:0) after 1m0s
[02:15:33.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:101:0)
[02:15:33.944] Timer tick, asking Buildbucket for the build status
[02:15:34.009] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:34.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:102:0) after 1m0s
[02:16:34.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:102:0)
[02:16:34.023] Timer tick, asking Buildbucket for the build status
[02:16:34.235] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:34.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:103:0) after 1m0s
[02:17:34.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:103:0)
[02:17:34.271] Timer tick, asking Buildbucket for the build status
[02:17:34.447] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:34.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:104:0) after 1m0s
[02:18:34.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:104:0)
[02:18:34.485] Timer tick, asking Buildbucket for the build status
[02:18:34.565] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:34.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:105:0) after 1m0s
[02:19:34.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:105:0)
[02:19:34.539] Timer tick, asking Buildbucket for the build status
[02:19:34.610] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:34.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:106:0) after 1m0s
[02:20:34.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:106:0)
[02:20:34.638] Timer tick, asking Buildbucket for the build status
[02:20:35.059] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:35.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:107:0) after 1m0s
[02:21:35.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:107:0)
[02:21:35.149] Timer tick, asking Buildbucket for the build status
[02:21:35.270] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:35.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:108:0) after 1m0s
[02:22:35.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:108:0)
[02:22:35.312] Timer tick, asking Buildbucket for the build status
[02:22:35.397] Build 8862612645800995952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:35.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028042707871477424:109:0) after 1m0s
[02:22:54.673] Received PubSub notification, asking Buildbucket for the build status
[02:22:55.018] Build 8862612645800995952: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:22:55.018] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606357371242467",
"created_by": "project:chromium",
"created_ts": "1606350965650758",
"failure_reason": "BUILD_FAILURE",
"id": "8862612645800995952",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"490ed7f40cdc335548f88a8b7bf75168e08612dc\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- GetCurrentBrowsingContextMediaDialogTest.DoneCallbackCalledWhenWindowClosed\\n\\n- GetCurrentBrowsingContextMediaDialogTest.DoneCallbackCalledWithAudioShareFalse\\n\\n- GetCurrentBrowsingContextMediaDialogTest.ShareButtonAccepts\\n\\n- GetCurrentBrowsingContextMediaDialogTest.DoneCallbackCalledWithAudioShare\\n\\n- ...4 more failure(s) (8 total)...\"}, \"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\": \"490ed7f40cdc335548f88a8b7bf75168e08612dc\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-81-hu9b\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21473, \"got_angle_revision\": \"bc82325e3445f76a09f720ddbc835b0d404af2b9\", \"got_dawn_revision\": \"2b606e9297e0ef91677b280560fdeb281ca80bc1\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"490ed7f40cdc335548f88a8b7bf75168e08612dc\", \"got_revision_cp\": \"refs/heads/master@{#831186}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"43bb60e1fa119d80b449c6550dd2b72328b101b9\", \"got_v8_revision\": \"b8bd12afedf4219a3d91069de5e13ed0c728430e\", \"got_v8_revision_cp\": \"refs/heads/8.9.52@{#1}\", \"got_webrtc_revision\": \"0db3396646aa4383b990678e09f8519a1d793d65\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32693}\", \"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\": \"490ed7f40cdc335548f88a8b7bf75168e08612dc\", \"swarm_hashes_refs/heads/master(at){#831186}_without_patch\": {\"absl_hardening_tests\": \"17dae1e4d30714b5cd5bc4f36ea051cf61129b13\", \"accessibility_unittests\": \"23ce8fd46d09f4db5177fbcc8ebebbe7f2d787a8\", \"angle_unittests\": \"7a78f778530b3bbd5256cae8aa78b2a628a08784\", \"app_list_unittests\": \"892e38ff6d0da3fd4310e06081c41cacfae0ac01\", \"app_shell_unittests\": \"ff8aa06284d80f319594bf3d7f6431160b851931\", \"ash_unittests\": \"bc9e692e1a9b982e2d10824348ca75868dd88a9a\", \"aura_unittests\": \"e58f373411fe1233d5edd9445a6393725ebc25b5\", \"base_unittests\": \"7aaf3aad7d5b861ab550ea12a4d4237da2f93f68\", \"base_util_unittests\": \"1c90c9c37c4dd1076678f186d7d071a89ecb927d\", \"blink_common_unittests\": \"c7decf710e7781fc9166ec7639f97467228e3fed\", \"blink_fuzzer_unittests\": \"5ae9046bfb493bbacd5a9d1f1a908bd46b184dd3\", \"blink_heap_unittests\": \"8341029499aed7fa56240b2c34a3f020f4daa331\", \"blink_platform_unittests\": \"0e99982291dce0d34d12a1f7af7ad918a0bfdc78\", \"blink_unittests\": \"751ae6a194a4b0e4c06ca7f592ff65b22300ccc0\", \"boringssl_crypto_tests\": \"838307690c4c08f323df9fe3e2743b4fd86a5d98\", \"boringssl_ssl_tests\": \"8ee4b692bf866f793c51ef95c63b5b7924dbe284\", \"browser_tests\": \"94aec380771226105a4852b477ef44a2399aa427\", \"capture_unittests\": \"b48ab79d933a8689898695f80a8be2e869f4b6e9\", \"cast_unittests\": \"2c0701faaa6e8a7721430363dc843c31d106a75d\", \"cc_unittests\": \"d56e72884ca331323c164fc6373e183b3aa19693\", \"chrome_app_unittests\": \"7fd42c9e2fff5ec318e58ebd6c5c156b2907b2db\", \"chromedriver_unittests\": \"859ecc7dcb0243e6929855c488126fa346172432\", \"chromeos_components_unittests\": \"a03c25f2cebaa6146497875bda95d2db4a492c2b\", \"chromeos_unittests\": \"7e8962fb45ebc7300f2a67db53b5223036e93ae9\", \"components_browsertests\": \"8480865a519254a93cba58aa476fd8a6f2d79ba9\", \"components_unittests\": \"d1d5a23e40cacf41290b4d75e451d463d3339de6\", \"compositor_unittests\": \"0b2f9d6fee267c5d51ad43e7edb8e5773ca0a8de\", \"content_browsertests\": \"49d0af7799c74e24e3969cbae7e90dba5960892a\", \"content_unittests\": \"fd5b9e316307d2eda8268945b65b6cf0484de1f9\", \"crashpad_tests\": \"1484eb73c65f70e02afe89c75a59246ae18bb587\", \"crypto_unittests\": \"602301311b8e3edb53fe1f8cd65c0b1eecf7675c\", \"dbus_unittests\": \"087be5a37b13a8708c1a9a98cffda78ef732246d\", \"device_unittests\": \"ce14d98470e8b10397757f3ccdd7d7d6768b9324\", \"display_unittests\": \"0912ebbc55a1b093487ee37f0e25d90a7a9b5a45\", \"events_unittests\": \"071cb8ac6c6d8c2ad9e6dadf5b3177f123a81c0b\", \"exo_unittests\": \"6729eae9418ebb86fe9397cb546eac6dabc4d155\", \"extensions_browsertests\": \"d8e78049fa38ad31b243f03b3fa2d6c089fab3e2\", \"extensions_unittests\": \"3af7cbd1e8951d8165e86a8854af7ad49a2e33de\", \"filesystem_service_unittests\": \"132dda2a106256ab0fac82b726c1df3fb2405a22\", \"gcm_unit_tests\": \"4e7d84767ff5fd4fbc8281ae970661464905a0f7\", \"gfx_unittests\": \"0b5786b27b0312dd08d4500a01f7437b88549cf6\", \"gin_unittests\": \"6502a719a4ce7935b349ea0f5726970944895d70\", \"gl_unittests_ozone\": \"127861df9ab393dfd96d1bd86ca7010854302b5d\", \"google_apis_unittests\": \"0bf48f5c1dd2ace618003c0a8bdf0e847021a476\", \"gpu_unittests\": \"26e74d17f928ff7e4ab0a123b4abc557b2546e52\", \"gwp_asan_unittests\": \"b9f58930bf8317e6508a4d6f746be9b8b2fce724\", \"interactive_ui_tests\": \"7560041f98e761d6cc164b02f662cfa672dc9b22\", \"ipc_tests\": \"83d5cbcce79335912de5f6f85bd49a9204bb0972\", \"jingle_unittests\": \"4549d8ad93fe8a5d564930ebea00b5d3d7252719\", \"keyboard_unittests\": \"01c6336402944637269da9eef51123fb3e1fbd7c\", \"latency_unittests\": \"ffee2b0566b58ec9634b3145cf7a78d878bf9d6e\", \"libjingle_xmpp_unittests\": \"39645593e0a0d7a893de8098b3ea890da16e6a4d\", \"liburlpattern_unittests\": \"a57e5bc5fc3e72f824e27c55fcb38504137a559f\", \"media_blink_unittests\": \"5a0504577fcc228465c1675332a8bbf4d5a37f04\", \"media_unittests\": \"671032d35699f6b42e479c7bdab8dfa3d3ad564f\", \"message_center_unittests\": \"7c87ad134384bf002843686feb42bde0aa3dc898\", \"midi_unittests\": \"dc9ca51f8ff7c1ebdf58c58183c0b1dbab476db4\", \"mojo_core_unittests\": \"e90a6d9a17b6a54c9ccb20066160027b2f69f8ba\", \"mojo_unittests\": \"695ba0d1fc98f72970884da32392d8f748976828\", \"nacl_helper_nonsfi_unittests\": \"184d4a57973ad39e0a8a226e0f6fb498146b2be2\", \"nacl_loader_unittests\": \"eedd7bff3eebc8018852d9556f915edacf5459d7\", \"native_theme_unittests\": \"a9f04bd2df438a994119207bb6861f99022c33d7\", \"net_unittests\": \"f701fe4aa0d61acc1b1b9f0547e81a68e6b857a8\", \"ozone_gl_unittests\": \"2086f5c804c04dbd51198511551536962e627dd2\", \"ozone_unittests\": \"259705db9a2c8cce62b3f0e91dea9577b017a22c\", \"ozone_x11_unittests\": \"dcfe42e0a64b14487116a92d7cf8dc06a5a2f0fb\", \"pdf_unittests\": \"bf10630884289aa178aee01c862e333b059c1a9e\", \"perfetto_unittests\": \"35506cbe85639b1669ed6f0d6ac656dc860a2f0f\", \"ppapi_unittests\": \"97076d8cccd6f0211b39b9ab6a1a5225ec4423ef\", \"printing_unittests\": \"6f816af5d409f9aefc9a01a9fbc0ac9011a21ea5\", \"remoting_unittests\": \"1f1dfb5717131aab1fc001bbf27d174107a32acd\", \"sandbox_linux_unittests\": \"11a0015bb5b8aef5b2a445382ec702ef9bd1deb1\", \"service_manager_unittests\": \"f40b01a80f0b92028226f40eea8cc7220590be53\", \"services_unittests\": \"8cc91c116c305b5ef76918726070f71138b56bee\", \"shell_dialogs_unittests\": \"4586148f6eca654a8c273e17c8f29755d45817e5\", \"skia_unittests\": \"4a114f0f093087705017ab41e35d355a9de433ef\", \"snapshot_unittests\": \"356126d6a1aabbef4872aa870900ee4696f5eb4c\", \"sql_unittests\": \"a1e41b08ef89ffa92113574a44fd8860162337ca\", \"storage_unittests\": \"a5270cd69b233f4941e615fcd4a6188ea7d5553e\", \"sync_integration_tests\": \"c367ed2cc7d8631ba7a2cf08446f7ab3590b9ec3\", \"traffic_annotation_auditor_unittests\": \"83a73fbe9b04b98f9faf1984a1a972bcb20e4e30\", \"ui_base_unittests\": \"dd0c91258a53a11bc6e6d87da14a041b7c4df94c\", \"ui_chromeos_unittests\": \"6f4868f239ad550c187869b4c23a6b924c7d82f4\", \"ui_touch_selection_unittests\": \"709a631e92fbf43e207f139e7da33b1427871390\", \"unit_tests\": \"07f196515e3bbebd3f1c97d743e921d52c66d41f\", \"url_unittests\": \"88ada9be3dd2e312915bd25469be3249f32f23a8\", \"usage_time_limit_unittests\": \"fffbe30a5b49b92ce8c645768658c2c7ea26df06\", \"views_unittests\": \"d9e6cf435a2eedbbed52f1d5bd0a87fe8be4a86b\", \"viz_unittests\": \"155da7ff7a2031fb12f58ae5737e2f5838baa134\", \"wm_unittests\": \"9ec54014317114f03e078d64d6e4181257766976\", \"wtf_unittests\": \"669512cb8bf7c92dcf04ef2706b1934bf5c8d13d\", \"zlib_unittests\": \"0bf6a9ec146f24ef8c1ebf3006fe4ea5a65e60ad\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02faf20e857a95e089f85681f3a573ea5341e1d0e2ee123c756bb8827a7a2b5a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-81-hu9b\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- GetCurrentBrowsingContextMediaDialogTest.DoneCallbackCalledWhenWindowClosed\\n\\n- GetCurrentBrowsingContextMediaDialogTest.DoneCallbackCalledWithAudioShareFalse\\n\\n- GetCurrentBrowsingContextMediaDialogTest.ShareButtonAccepts\\n\\n- GetCurrentBrowsingContextMediaDialogTest.DoneCallbackCalledWithAudioShare\\n\\n- ...4 more failure(s) (8 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606351265711318",
"status": "COMPLETED",
"status_changed_ts": "1606351265931901",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21473",
"builder:linux-chromeos-dbg",
"buildset:commit/git/490ed7f40cdc335548f88a8b7bf75168e08612dc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/490ed7f40cdc335548f88a8b7bf75168e08612dc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028042707871477424",
"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/8862612645800995952/+/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:501acc16327ce510",
"user_agent:luci-scheduler"
],
"updated_ts": "1606357374327815",
"url": "https://ci.chromium.org/b/8862612645800995952",
"utcnow_ts": "1606357375003347"
}
}
[02:22:55.020] Invocation finished in 1h46m50.728244069s with status FAILED