[16:51:19.264] New invocation is queued and will start shortly
[16:51:20.582] Starting the invocation (attempt 1)
[16:51:20.669] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:51:20.670] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:51:20.671] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019918220481918128",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9b910fbb09ae9d195a9e034bc22025c7b4d277be\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019918220481918128",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/9b910fbb09ae9d195a9e034bc22025c7b4d277be",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b910fbb09ae9d195a9e034bc22025c7b4d277be",
"gitiles_ref:refs/heads/master"
]
}
[16:51:21.835] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614099080850040",
"id": "8854488158156429776",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b910fbb09ae9d195a9e034bc22025c7b4d277be\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614099081610606",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22748",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9b910fbb09ae9d195a9e034bc22025c7b4d277be",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b910fbb09ae9d195a9e034bc22025c7b4d277be",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019918220481918128",
"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/8854488158156429776/+/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": "1614099081610740",
"url": "https://ci.chromium.org/b/8854488158156429776",
"utcnow_ts": "1614099081821459"
}
}
[16:51:21.835] Task URL: https://ci.chromium.org/b/8854488158156429776
[16:51:21.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:2:0) after 1m0s
[16:52:21.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:2:0)
[16:52:21.976] Timer tick, asking Buildbucket for the build status
[16:52:22.045] Build 8854488158156429776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:52:22.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:3:0) after 1m0s
[16:53:22.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:3:0)
[16:53:22.172] Timer tick, asking Buildbucket for the build status
[16:53:22.238] Build 8854488158156429776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:53:22.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:4:0) after 1m0s
[16:53:52.129] Received PubSub notification, asking Buildbucket for the build status
[16:53:52.198] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:22.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:4:0)
[16:54:22.371] Timer tick, asking Buildbucket for the build status
[16:54:22.463] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:22.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:6:0) after 1m0s
[16:55:22.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:6:0)
[16:55:22.468] Timer tick, asking Buildbucket for the build status
[16:55:22.574] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:22.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:7:0) after 1m0s
[16:56:22.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:7:0)
[16:56:22.641] Timer tick, asking Buildbucket for the build status
[16:56:22.805] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:22.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:8:0) after 1m0s
[16:57:22.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:8:0)
[16:57:22.856] Timer tick, asking Buildbucket for the build status
[16:57:22.946] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:22.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:9:0) after 1m0s
[16:58:23.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:9:0)
[16:58:23.090] Timer tick, asking Buildbucket for the build status
[16:58:23.301] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:23.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:10:0) after 1m0s
[16:59:23.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:10:0)
[16:59:23.905] Timer tick, asking Buildbucket for the build status
[16:59:23.991] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:23.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:11:0) after 1m0s
[17:00:24.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:11:0)
[17:00:24.060] Timer tick, asking Buildbucket for the build status
[17:00:24.350] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:24.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:12:0) after 1m0s
[17:01:24.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:12:0)
[17:01:24.495] Timer tick, asking Buildbucket for the build status
[17:01:24.745] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:24.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:13:0) after 1m0s
[17:02:24.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:13:0)
[17:02:24.921] Timer tick, asking Buildbucket for the build status
[17:02:25.013] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:25.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:14:0) after 1m0s
[17:03:25.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:14:0)
[17:03:25.127] Timer tick, asking Buildbucket for the build status
[17:03:25.423] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:25.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:15:0) after 1m0s
[17:04:25.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:15:0)
[17:04:25.507] Timer tick, asking Buildbucket for the build status
[17:04:26.984] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:26.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:16:0) after 1m0s
[17:05:27.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:16:0)
[17:05:27.142] Timer tick, asking Buildbucket for the build status
[17:05:27.397] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:27.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:17:0) after 1m0s
[17:06:27.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:17:0)
[17:06:27.623] Timer tick, asking Buildbucket for the build status
[17:06:27.711] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:27.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:18:0) after 1m0s
[17:07:27.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:18:0)
[17:07:27.834] Timer tick, asking Buildbucket for the build status
[17:07:27.948] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:27.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:19:0) after 1m0s
[17:08:28.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:19:0)
[17:08:28.026] Timer tick, asking Buildbucket for the build status
[17:08:28.103] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:28.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:20:0) after 1m0s
[17:09:28.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:20:0)
[17:09:28.130] Timer tick, asking Buildbucket for the build status
[17:09:28.411] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:28.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:21:0) after 1m0s
[17:10:28.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:21:0)
[17:10:28.442] Timer tick, asking Buildbucket for the build status
[17:10:28.733] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:28.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:22:0) after 1m0s
[17:11:28.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:22:0)
[17:11:28.804] Timer tick, asking Buildbucket for the build status
[17:11:28.945] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:28.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:23:0) after 1m0s
[17:12:29.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:23:0)
[17:12:29.147] Timer tick, asking Buildbucket for the build status
[17:12:29.281] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:29.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:24:0) after 1m0s
[17:13:29.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:24:0)
[17:13:29.328] Timer tick, asking Buildbucket for the build status
[17:13:29.414] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:29.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:25:0) after 1m0s
[17:14:29.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:25:0)
[17:14:29.463] Timer tick, asking Buildbucket for the build status
[17:14:31.340] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:31.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:26:0) after 1m0s
[17:15:31.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:26:0)
[17:15:31.400] Timer tick, asking Buildbucket for the build status
[17:15:31.531] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:31.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:27:0) after 1m0s
[17:16:31.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:27:0)
[17:16:31.583] Timer tick, asking Buildbucket for the build status
[17:16:31.676] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:31.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:28:0) after 1m0s
[17:17:31.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:28:0)
[17:17:31.833] Timer tick, asking Buildbucket for the build status
[17:17:31.915] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:31.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:29:0) after 1m0s
[17:18:32.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:29:0)
[17:18:32.056] Timer tick, asking Buildbucket for the build status
[17:18:32.309] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:32.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:30:0) after 1m0s
[17:19:32.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:30:0)
[17:19:32.518] Timer tick, asking Buildbucket for the build status
[17:19:33.104] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:33.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:31:0) after 1m0s
[17:20:33.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:31:0)
[17:20:33.267] Timer tick, asking Buildbucket for the build status
[17:20:33.519] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:33.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:32:0) after 1m0s
[17:21:33.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:32:0)
[17:21:33.628] Timer tick, asking Buildbucket for the build status
[17:21:34.030] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:34.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:33:0) after 1m0s
[17:22:34.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:33:0)
[17:22:34.093] Timer tick, asking Buildbucket for the build status
[17:22:34.164] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:34.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:34:0) after 1m0s
[17:23:34.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:34:0)
[17:23:34.209] Timer tick, asking Buildbucket for the build status
[17:23:34.295] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:34.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:35:0) after 1m0s
[17:24:34.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:35:0)
[17:24:34.318] Timer tick, asking Buildbucket for the build status
[17:24:34.402] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:34.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:36:0) after 1m0s
[17:25:34.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:36:0)
[17:25:34.422] Timer tick, asking Buildbucket for the build status
[17:25:34.694] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:34.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:37:0) after 1m0s
[17:26:34.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:37:0)
[17:26:34.722] Timer tick, asking Buildbucket for the build status
[17:26:34.807] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:34.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:38:0) after 1m0s
[17:27:34.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:38:0)
[17:27:34.828] Timer tick, asking Buildbucket for the build status
[17:27:35.072] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:35.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:39:0) after 1m0s
[17:28:35.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:39:0)
[17:28:35.114] Timer tick, asking Buildbucket for the build status
[17:28:35.344] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:35.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:40:0) after 1m0s
[17:29:35.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:40:0)
[17:29:35.413] Timer tick, asking Buildbucket for the build status
[17:29:35.494] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:35.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:41:0) after 1m0s
[17:30:35.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:41:0)
[17:30:35.520] Timer tick, asking Buildbucket for the build status
[17:30:35.729] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:35.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:42:0) after 1m0s
[17:31:35.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:42:0)
[17:31:35.884] Timer tick, asking Buildbucket for the build status
[17:31:36.204] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:36.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:43:0) after 1m0s
[17:32:36.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:43:0)
[17:32:36.292] Timer tick, asking Buildbucket for the build status
[17:32:36.512] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:36.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:44:0) after 1m0s
[17:33:36.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:44:0)
[17:33:36.693] Timer tick, asking Buildbucket for the build status
[17:33:37.010] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:37.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:45:0) after 1m0s
[17:34:37.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:45:0)
[17:34:37.157] Timer tick, asking Buildbucket for the build status
[17:34:37.259] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:37.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:46:0) after 1m0s
[17:35:37.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:46:0)
[17:35:37.337] Timer tick, asking Buildbucket for the build status
[17:35:37.713] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:37.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:47:0) after 1m0s
[17:36:37.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:47:0)
[17:36:37.787] Timer tick, asking Buildbucket for the build status
[17:36:37.877] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:37.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:48:0) after 1m0s
[17:37:37.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:48:0)
[17:37:37.933] Timer tick, asking Buildbucket for the build status
[17:37:38.025] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:38.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:49:0) after 1m0s
[17:38:38.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:49:0)
[17:38:38.048] Timer tick, asking Buildbucket for the build status
[17:38:38.129] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:38.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:50:0) after 1m0s
[17:39:38.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:50:0)
[17:39:38.124] Timer tick, asking Buildbucket for the build status
[17:39:38.202] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:38.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:51:0) after 1m0s
[17:40:38.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:51:0)
[17:40:38.271] Timer tick, asking Buildbucket for the build status
[17:40:38.384] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:38.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:52:0) after 1m0s
[17:41:38.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:52:0)
[17:41:38.485] Timer tick, asking Buildbucket for the build status
[17:41:38.656] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:38.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:53:0) after 1m0s
[17:42:38.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:53:0)
[17:42:38.852] Timer tick, asking Buildbucket for the build status
[17:42:39.239] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:39.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:54:0) after 1m0s
[17:43:39.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:54:0)
[17:43:39.278] Timer tick, asking Buildbucket for the build status
[17:43:39.681] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:39.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:55:0) after 1m0s
[17:44:39.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:55:0)
[17:44:39.806] Timer tick, asking Buildbucket for the build status
[17:44:40.042] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:40.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:56:0) after 1m0s
[17:45:40.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:56:0)
[17:45:40.064] Timer tick, asking Buildbucket for the build status
[17:45:40.654] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:40.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:57:0) after 1m0s
[17:46:40.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:57:0)
[17:46:40.784] Timer tick, asking Buildbucket for the build status
[17:46:40.886] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:40.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:58:0) after 1m0s
[17:47:41.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:58:0)
[17:47:41.093] Timer tick, asking Buildbucket for the build status
[17:47:41.211] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:41.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:59:0) after 1m0s
[17:48:41.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:59:0)
[17:48:41.412] Timer tick, asking Buildbucket for the build status
[17:48:41.504] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:41.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:60:0) after 1m0s
[17:49:41.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:60:0)
[17:49:41.643] Timer tick, asking Buildbucket for the build status
[17:49:41.745] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:41.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:61:0) after 1m0s
[17:50:42.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:61:0)
[17:50:42.229] Timer tick, asking Buildbucket for the build status
[17:50:42.374] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:42.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:62:0) after 1m0s
[17:51:42.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:62:0)
[17:51:42.742] Timer tick, asking Buildbucket for the build status
[17:51:42.861] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:42.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:63:0) after 1m0s
[17:52:43.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:63:0)
[17:52:43.011] Timer tick, asking Buildbucket for the build status
[17:52:43.161] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:43.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:64:0) after 1m0s
[17:53:43.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:64:0)
[17:53:43.343] Timer tick, asking Buildbucket for the build status
[17:53:43.699] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:43.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:65:0) after 1m0s
[17:54:43.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:65:0)
[17:54:43.792] Timer tick, asking Buildbucket for the build status
[17:54:44.031] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:44.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:66:0) after 1m0s
[17:55:44.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:66:0)
[17:55:44.146] Timer tick, asking Buildbucket for the build status
[17:55:44.227] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:44.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:67:0) after 1m0s
[17:56:44.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:67:0)
[17:56:44.327] Timer tick, asking Buildbucket for the build status
[17:56:44.643] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:44.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:68:0) after 1m0s
[17:57:44.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:68:0)
[17:57:44.886] Timer tick, asking Buildbucket for the build status
[17:57:44.980] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:44.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:69:0) after 1m0s
[17:58:45.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:69:0)
[17:58:45.024] Timer tick, asking Buildbucket for the build status
[17:58:45.218] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:45.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:70:0) after 1m0s
[17:59:45.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:70:0)
[17:59:45.292] Timer tick, asking Buildbucket for the build status
[17:59:45.697] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:45.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:71:0) after 1m0s
[18:00:45.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:71:0)
[18:00:45.809] Timer tick, asking Buildbucket for the build status
[18:00:45.982] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:45.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:72:0) after 1m0s
[18:01:46.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:72:0)
[18:01:46.067] Timer tick, asking Buildbucket for the build status
[18:01:46.204] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:46.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:73:0) after 1m0s
[18:02:46.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:73:0)
[18:02:46.342] Timer tick, asking Buildbucket for the build status
[18:02:46.531] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:46.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:74:0) after 1m0s
[18:03:46.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:74:0)
[18:03:46.620] Timer tick, asking Buildbucket for the build status
[18:03:46.709] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:46.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:75:0) after 1m0s
[18:04:46.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:75:0)
[18:04:46.822] Timer tick, asking Buildbucket for the build status
[18:04:47.152] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:47.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:76:0) after 1m0s
[18:05:47.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:76:0)
[18:05:47.363] Timer tick, asking Buildbucket for the build status
[18:05:47.483] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:47.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:77:0) after 1m0s
[18:06:47.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:77:0)
[18:06:47.566] Timer tick, asking Buildbucket for the build status
[18:06:47.670] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:47.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:78:0) after 1m0s
[18:07:47.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:78:0)
[18:07:47.711] Timer tick, asking Buildbucket for the build status
[18:07:47.815] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:47.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:79:0) after 1m0s
[18:08:47.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:79:0)
[18:08:47.866] Timer tick, asking Buildbucket for the build status
[18:08:47.968] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:47.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:80:0) after 1m0s
[18:09:48.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:80:0)
[18:09:48.088] Timer tick, asking Buildbucket for the build status
[18:09:48.167] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:48.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:81:0) after 1m0s
[18:10:48.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:81:0)
[18:10:48.197] Timer tick, asking Buildbucket for the build status
[18:10:48.288] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:48.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:82:0) after 1m0s
[18:11:48.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:82:0)
[18:11:48.339] Timer tick, asking Buildbucket for the build status
[18:11:48.505] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:48.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:83:0) after 1m0s
[18:12:48.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:83:0)
[18:12:48.615] Timer tick, asking Buildbucket for the build status
[18:12:48.909] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:48.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:84:0) after 1m0s
[18:13:48.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:84:0)
[18:13:48.981] Timer tick, asking Buildbucket for the build status
[18:13:49.156] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:49.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:85:0) after 1m0s
[18:14:49.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:85:0)
[18:14:49.153] Timer tick, asking Buildbucket for the build status
[18:14:49.448] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:49.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:86:0) after 1m0s
[18:15:49.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:86:0)
[18:15:49.539] Timer tick, asking Buildbucket for the build status
[18:15:49.626] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:49.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:87:0) after 1m0s
[18:16:49.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:87:0)
[18:16:49.683] Timer tick, asking Buildbucket for the build status
[18:16:49.990] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:49.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:88:0) after 1m0s
[18:17:50.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:88:0)
[18:17:50.010] Timer tick, asking Buildbucket for the build status
[18:17:50.129] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:50.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:89:0) after 1m0s
[18:18:50.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:89:0)
[18:18:50.204] Timer tick, asking Buildbucket for the build status
[18:18:50.288] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:50.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:90:0) after 1m0s
[18:19:50.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:90:0)
[18:19:50.432] Timer tick, asking Buildbucket for the build status
[18:19:50.750] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:50.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:91:0) after 1m0s
[18:20:50.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:91:0)
[18:20:50.955] Timer tick, asking Buildbucket for the build status
[18:20:51.320] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:51.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:92:0) after 1m0s
[18:21:51.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:92:0)
[18:21:51.483] Timer tick, asking Buildbucket for the build status
[18:21:51.638] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:51.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:93:0) after 1m0s
[18:22:51.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:93:0)
[18:22:51.714] Timer tick, asking Buildbucket for the build status
[18:22:51.799] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:51.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:94:0) after 1m0s
[18:23:51.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:94:0)
[18:23:51.867] Timer tick, asking Buildbucket for the build status
[18:23:52.149] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:52.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:95:0) after 1m0s
[18:24:52.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:95:0)
[18:24:52.196] Timer tick, asking Buildbucket for the build status
[18:24:52.415] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:52.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:96:0) after 1m0s
[18:25:52.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:96:0)
[18:25:52.759] Timer tick, asking Buildbucket for the build status
[18:25:53.003] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:53.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:97:0) after 1m0s
[18:26:53.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:97:0)
[18:26:53.017] Timer tick, asking Buildbucket for the build status
[18:26:53.741] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:53.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:98:0) after 1m0s
[18:27:53.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:98:0)
[18:27:53.814] Timer tick, asking Buildbucket for the build status
[18:27:53.991] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:53.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:99:0) after 1m0s
[18:28:54.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:99:0)
[18:28:54.028] Timer tick, asking Buildbucket for the build status
[18:28:54.189] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:54.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:100:0) after 1m0s
[18:29:54.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:100:0)
[18:29:54.213] Timer tick, asking Buildbucket for the build status
[18:29:54.354] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:54.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:101:0) after 1m0s
[18:30:54.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:101:0)
[18:30:54.440] Timer tick, asking Buildbucket for the build status
[18:30:54.740] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:54.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:102:0) after 1m0s
[18:31:54.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:102:0)
[18:31:54.761] Timer tick, asking Buildbucket for the build status
[18:31:54.857] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:54.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:103:0) after 1m0s
[18:32:54.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:103:0)
[18:32:54.909] Timer tick, asking Buildbucket for the build status
[18:32:54.988] Build 8854488158156429776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:54.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019918220481918128:104:0) after 1m0s
[18:33:25.217] Received PubSub notification, asking Buildbucket for the build status
[18:33:25.357] Build 8854488158156429776: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[18:33:25.357] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614105204764146",
"created_by": "project:chromium",
"created_ts": "1614099080850040",
"failure_reason": "BUILD_FAILURE",
"id": "8854488158156429776",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b910fbb09ae9d195a9e034bc22025c7b4d277be\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- SaveCardBubbleViewsFullFormBrowserTestWithAutofillUpstream.Upload_ClickingNoThanksClosesBubble\\n\\n- SaveCardBubbleViewsFullFormBrowserTestForManageCard.Local_ManageCardsDoneButtonClosesBubble\\n\\n- All/EcheAppIntegrationTest.WindowNonResizeableAndNonMaximizable/_Default\\n\\n- All/FileTasksBrowserTestWithMediaApp.MultiSelectDefaultHandler/Regular\\n\\n- ...178 more failure(s) (182 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\": \"9b910fbb09ae9d195a9e034bc22025c7b4d277be\", \"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-76-83di\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22748, \"got_angle_revision\": \"1a70e5a04584ce3586c9ce7243b419f0df7b052f\", \"got_dawn_revision\": \"76a94b17be3c6cfc7e88d30b90e99d7b89c8f30b\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"9b910fbb09ae9d195a9e034bc22025c7b4d277be\", \"got_revision_cp\": \"refs/heads/master@{#856726}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"22186f076bf3bbe1a818792bde93b297e3773f7e\", \"got_v8_revision\": \"8bc6184274d97b9b57d5389e423f6f3f7c092918\", \"got_v8_revision_cp\": \"refs/heads/9.0.239@{#1}\", \"got_webrtc_revision\": \"d0844a80deaab28d7df8e5dff9f71e6ab6919025\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33323}\", \"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\": \"9b910fbb09ae9d195a9e034bc22025c7b4d277be\", \"swarm_hashes_refs/heads/master(at){#856726}_without_patch\": {\"absl_hardening_tests\": \"77167e62f82367770522fcf525dec4fe68c7d36c\", \"accessibility_unittests\": \"aa8399ff571afe16609248518fc22bb103fc188b\", \"angle_unittests\": \"44d6a9d7d0a84d74fffa3dbfbce81bce3ea7fcf4\", \"app_list_unittests\": \"dedb7b5e8d6ad71f811ea1015507ebc94cae8ffd\", \"app_shell_unittests\": \"0cc88f7dc017f5eebe932713f3df8b44d08c4fc9\", \"ash_unittests\": \"838d05ae404bb1cd2ce9e52365c80b869177f60e\", \"aura_unittests\": \"259dc8704176092a329d5acf8d151a5cdab7b9d3\", \"base_unittests\": \"09b5c91128d3ec03d10bce68ac5aee2f261913ff\", \"base_util_unittests\": \"637f170bf1bf1930cd9aa8d0dc05da5f835445bf\", \"blink_common_unittests\": \"93a74a1257c4f0d804537b67211da65f8582b0be\", \"blink_fuzzer_unittests\": \"278d4a6cecc684a5c8513e1892fc00c30bbaac58\", \"blink_heap_unittests\": \"09bd931d3dc86e8a375208f267d5c045b343867b\", \"blink_platform_unittests\": \"4faab509a94e247d17e500a148ebef7648a04656\", \"blink_unittests\": \"785df4265967a10e6c8acc167aa7c742ce7ddce1\", \"boringssl_crypto_tests\": \"bb3cc4abe183b19d426c93fb24c23112bb4ee818\", \"boringssl_ssl_tests\": \"9fd9e2780660e849358bc58c97e79c8ddfda3f7f\", \"browser_tests\": \"509bd94fb4c9dd62df03bc606a3e9b7ec7b4f026\", \"capture_unittests\": \"6c830f5d8aeb3313fbd7a60a20f9a80671b2b100\", \"cast_unittests\": \"949d526a75cd36df273dcdcf88a78462efb5924a\", \"cc_unittests\": \"4b44a499135e0098edbc79c2355e05b776a25ba3\", \"chrome_app_unittests\": \"74672a9ea7bf1ac3153c1af1ee1f3c555bc3c853\", \"chromedriver_unittests\": \"63eb6346614c39ecd8c10b3a98f7615dfdb33b29\", \"chromeos_components_unittests\": \"fd0d4e310b4a7548515bc47d66fe3784d63b989e\", \"chromeos_unittests\": \"340979de369e00b72dbba7446264a4b38ef26f8d\", \"components_browsertests\": \"6d98d6d5a0e79cb06c8c5d2565ea904d471972c9\", \"components_unittests\": \"67b6e8deb2fb5a73cfc3535da06f8fccb668f26d\", \"compositor_unittests\": \"567ef6e30af9a26d6335bf8c3b72aedb70a8eaba\", \"content_browsertests\": \"aa5dc9e14a23184c06451d8390604dee58b17a24\", \"content_unittests\": \"ad169eba53c7abc9787c4411dd4c52c0d6a96ebe\", \"crashpad_tests\": \"eff230b874e5bd7c52bd80a9cda501e5575df254\", \"crypto_unittests\": \"39ccc4424b34835c76458b23b71ce92c3d27e661\", \"dbus_unittests\": \"2c327006d74479a45b7dbf14d5de519832831c51\", \"device_unittests\": \"c31fa263e95c266adbb1a73ba6b6c98eff6fb1c2\", \"display_unittests\": \"0f533fa2be4cbae0d5559c1d0b945a4a8a88dff9\", \"events_unittests\": \"ef9590cac330aedda497d76d5bdcb71d2b48ce36\", \"exo_unittests\": \"179f553c9cc811e5a042a23ffca7faa877fae1a6\", \"extensions_browsertests\": \"3e73456f1d424de431674229b5ff495d870c520c\", \"extensions_unittests\": \"a2cd78dce0c8637430aa2d5a2424bb156f6ac6f7\", \"filesystem_service_unittests\": \"2435158e18ca6a19405c95830bc585922a134326\", \"gcm_unit_tests\": \"9905a2353b09d00bcae439bada94c34e72de8fa3\", \"gfx_unittests\": \"29e50e9f55bde1f8806f542685d35c52d8afaabf\", \"gin_unittests\": \"1de1c13573d54b86b9afbe3a142014c8bbe2246c\", \"gl_unittests_ozone\": \"18302ec11f68cae5665e94f3ae23e1a97fa3477c\", \"google_apis_unittests\": \"0c85d62604a0d0f75b54cb44e92bceb8f1d8e63f\", \"gpu_unittests\": \"08e0ba32274be77a50872e265592a87fdfaeb9aa\", \"gwp_asan_unittests\": \"a658b9e8759e3ca92284263db6c6b1db1716ecc1\", \"interactive_ui_tests\": \"64d74212147f9faedc04fbea127a1723d9a19644\", \"ipc_tests\": \"8611bfc24633f44cd5e27743b375bbb84f9441d6\", \"jingle_unittests\": \"4e3e08c6b0dc9b50b9960ecc1d99b33f01355ddf\", \"keyboard_unittests\": \"9a351b9cc921da93d20c744e0829d7e09a9a7585\", \"latency_unittests\": \"3cf67535d36a9cbe9d1541c8d9069581e9fe497a\", \"libjingle_xmpp_unittests\": \"88a7de82f58eaaa251c0c625fa13826cd3639b29\", \"liburlpattern_unittests\": \"9f41e09fe5e5fb4ab104880c2f2635e250b5cb89\", \"media_blink_unittests\": \"e02801c309b4895c5aacd30cf60207ba7820b2b3\", \"media_unittests\": \"efde85b0c36cdffec033e4a1059347a7a6e22503\", \"message_center_unittests\": \"59addaf7ac671addf5c85e2ca7eacea2fd8dfeb7\", \"midi_unittests\": \"8d5d641ccbf0a8ec6e18c0787a9cbb6b6d4de073\", \"mojo_core_unittests\": \"71f0e21a5f26e74c04911e135d97731034fce3c3\", \"mojo_unittests\": \"3caa243bf1a46ce928ca6ef695d7cf13fc390804\", \"nacl_helper_nonsfi_unittests\": \"f9b63d93674e8c439eb3dfcb84ff7345529106e5\", \"nacl_loader_unittests\": \"08e2fd90d29a63932f5931e891b021100bd2cccf\", \"native_theme_unittests\": \"7b4c8aae0ec985f3cc776dc7d5240c73b5d3f4e6\", \"net_unittests\": \"d1f8c46f3473ae52549de9a32895eb97120444e4\", \"ozone_gl_unittests\": \"a21480815044e8ccca30d6febecc08f02058db7a\", \"ozone_unittests\": \"97678e544a08bd0b1d787c44ef9d104de14f31ca\", \"ozone_x11_unittests\": \"595939dd556b62ee171e55cdbee0335e05fcccc4\", \"pdf_unittests\": \"33b211c565298ce1576b7384576e1dc6036e8c46\", \"perfetto_unittests\": \"6550f73beeaf9e16c4a8cad0bb0ae12de190b137\", \"ppapi_unittests\": \"042f1625ba5c05e8c767e66e30a41e32a5eb7f80\", \"printing_unittests\": \"e2254c93c31502b2dd5c5d28a86e0d746a53a130\", \"remoting_unittests\": \"a7773617212e2219c8c0757e79f8a950515ef080\", \"sandbox_linux_unittests\": \"6aff74a4ce7292b9a64d7069ab30470efa6814ed\", \"service_manager_unittests\": \"9320161cb1dca0d2890fcfd4b386a471752dd459\", \"services_unittests\": \"d679900a2f75ac8ded9306966011495dc0054aec\", \"shell_dialogs_unittests\": \"723978f80d4650a603786cdf2d65cc4739ff75d2\", \"shell_encryption_unittests\": \"67e3327f1c188d8f598d2ca433dc0cfc05b2fade\", \"skia_unittests\": \"fd0b4ef8e18ea329785af315337f7283409f10fc\", \"snapshot_unittests\": \"07a5dbcf1aee113cc19887154c7702da8b42164d\", \"sql_unittests\": \"26bdaa99b352bc15bb9d1301e150140a4afb4aee\", \"storage_unittests\": \"9f2b1b0d4fb23fd1a33a9fc3ab4942a7d76fc069\", \"sync_integration_tests\": \"8f00fc929d3fc172f7edd8b709070c5f230722e2\", \"traffic_annotation_auditor_unittests\": \"24dc2502c11530f73d6ce517c337ce2c117aab84\", \"ui_base_unittests\": \"b796df01bb99427e5e34e603cdd944b8ab221ce7\", \"ui_chromeos_unittests\": \"53d2caa4d04bf88630b2224566a29c0e43d90ddb\", \"ui_touch_selection_unittests\": \"6f57338a931a6943dcb0f48821de25d9a9a45ec2\", \"unit_tests\": \"9ef9e3ec5977723d665d6a8b37388b07a92d7a05\", \"url_unittests\": \"c11c80794716b8382fd7c1868362462092cfcc43\", \"usage_time_limit_unittests\": \"83e8f867253d445378044b226d9ec2bfb1ba6c68\", \"views_unittests\": \"f853715d5cff5c1f041b1e2600db0bd73e950e26\", \"viz_unittests\": \"0a1df897003c44bbd1199051a0e37e87f85fc6ac\", \"wm_unittests\": \"6807b0e698de1398c458eb0d30a5c81f49ddafe0\", \"wtf_unittests\": \"807fd24106c98117d5aafd1e8cd6422f111c099d\", \"zlib_unittests\": \"01acfc92efeb2979d911b0ead465bf544e64aea0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-east1-d-8-76-83di\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- SaveCardBubbleViewsFullFormBrowserTestWithAutofillUpstream.Upload_ClickingNoThanksClosesBubble\\n\\n- SaveCardBubbleViewsFullFormBrowserTestForManageCard.Local_ManageCardsDoneButtonClosesBubble\\n\\n- All/EcheAppIntegrationTest.WindowNonResizeableAndNonMaximizable/_Default\\n\\n- All/FileTasksBrowserTestWithMediaApp.MultiSelectDefaultHandler/Regular\\n\\n- ...178 more failure(s) (182 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614099231524059",
"status": "COMPLETED",
"status_changed_ts": "1614099231833283",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22748",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9b910fbb09ae9d195a9e034bc22025c7b4d277be",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b910fbb09ae9d195a9e034bc22025c7b4d277be",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019918220481918128",
"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/8854488158156429776/+/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:51e89f0e8b8a4a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614105204764549",
"url": "https://ci.chromium.org/b/8854488158156429776",
"utcnow_ts": "1614105205349536"
}
}
[18:33:25.357] Invocation finished in 1h42m6.107703365s with status FAILED