[00:10:36.541] New invocation is queued and will start shortly
[00:10:37.628] Starting the invocation (attempt 1)
[00:10:37.679] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:10:37.679] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:10:37.679] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026957146254734560",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a7be590db7d3f4ab87d67fc77eee49c964107a19\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9026957146254734560",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/a7be590db7d3f4ab87d67fc77eee49c964107a19",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a7be590db7d3f4ab87d67fc77eee49c964107a19",
"gitiles_ref:refs/heads/master"
]
}
[00:10:38.484] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1607386237810834",
"id": "8861527084260475920",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a7be590db7d3f4ab87d67fc77eee49c964107a19\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607386238312818",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21649",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a7be590db7d3f4ab87d67fc77eee49c964107a19",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a7be590db7d3f4ab87d67fc77eee49c964107a19",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026957146254734560",
"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/8861527084260475920/+/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": "1607386238312986",
"url": "https://ci.chromium.org/b/8861527084260475920",
"utcnow_ts": "1607386238477209"
}
}
[00:10:38.484] Task URL: https://ci.chromium.org/b/8861527084260475920
[00:10:38.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:2:0) after 1m0s
[00:11:38.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:2:0)
[00:11:38.547] Timer tick, asking Buildbucket for the build status
[00:11:38.672] Build 8861527084260475920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:38.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:3:0) after 1m0s
[00:12:38.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:3:0)
[00:12:38.766] Timer tick, asking Buildbucket for the build status
[00:12:38.832] Build 8861527084260475920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:38.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:4:0) after 1m0s
[00:13:13.635] Received PubSub notification, asking Buildbucket for the build status
[00:13:13.725] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:38.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:4:0)
[00:13:38.877] Timer tick, asking Buildbucket for the build status
[00:13:38.987] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:38.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:6:0) after 1m0s
[00:14:39.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:6:0)
[00:14:39.036] Timer tick, asking Buildbucket for the build status
[00:14:39.136] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:39.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:7:0) after 1m0s
[00:15:39.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:7:0)
[00:15:39.143] Timer tick, asking Buildbucket for the build status
[00:15:39.222] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:39.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:8:0) after 1m0s
[00:16:39.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:8:0)
[00:16:39.272] Timer tick, asking Buildbucket for the build status
[00:16:39.533] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:39.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:9:0) after 1m0s
[00:17:39.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:9:0)
[00:17:39.537] Timer tick, asking Buildbucket for the build status
[00:17:39.811] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:39.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:10:0) after 1m0s
[00:18:39.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:10:0)
[00:18:39.840] Timer tick, asking Buildbucket for the build status
[00:18:40.010] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:40.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:11:0) after 1m0s
[00:19:40.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:11:0)
[00:19:40.028] Timer tick, asking Buildbucket for the build status
[00:19:40.212] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:40.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:12:0) after 1m0s
[00:20:40.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:12:0)
[00:20:40.304] Timer tick, asking Buildbucket for the build status
[00:20:40.420] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:40.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:13:0) after 1m0s
[00:21:40.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:13:0)
[00:21:40.487] Timer tick, asking Buildbucket for the build status
[00:21:40.598] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:40.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:14:0) after 1m0s
[00:22:40.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:14:0)
[00:22:40.624] Timer tick, asking Buildbucket for the build status
[00:22:40.705] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:40.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:15:0) after 1m0s
[00:23:40.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:15:0)
[00:23:40.695] Timer tick, asking Buildbucket for the build status
[00:23:40.784] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:40.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:16:0) after 1m0s
[00:24:40.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:16:0)
[00:24:40.806] Timer tick, asking Buildbucket for the build status
[00:24:40.868] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:40.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:17:0) after 1m0s
[00:25:40.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:17:0)
[00:25:40.938] Timer tick, asking Buildbucket for the build status
[00:25:41.026] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:41.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:18:0) after 1m0s
[00:26:41.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:18:0)
[00:26:41.052] Timer tick, asking Buildbucket for the build status
[00:26:41.159] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:41.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:19:0) after 1m0s
[00:27:41.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:19:0)
[00:27:41.190] Timer tick, asking Buildbucket for the build status
[00:27:41.276] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:41.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:20:0) after 1m0s
[00:28:41.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:20:0)
[00:28:41.297] Timer tick, asking Buildbucket for the build status
[00:28:41.366] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:41.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:21:0) after 1m0s
[00:29:41.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:21:0)
[00:29:41.399] Timer tick, asking Buildbucket for the build status
[00:29:41.789] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:41.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:22:0) after 1m0s
[00:30:41.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:22:0)
[00:30:41.815] Timer tick, asking Buildbucket for the build status
[00:30:41.890] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:41.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:23:0) after 1m0s
[00:31:41.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:23:0)
[00:31:41.974] Timer tick, asking Buildbucket for the build status
[00:31:42.072] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:42.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:24:0) after 1m0s
[00:32:42.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:24:0)
[00:32:42.080] Timer tick, asking Buildbucket for the build status
[00:32:42.195] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:42.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:25:0) after 1m0s
[00:33:42.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:25:0)
[00:33:42.289] Timer tick, asking Buildbucket for the build status
[00:33:42.351] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:42.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:26:0) after 1m0s
[00:34:42.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:26:0)
[00:34:42.460] Timer tick, asking Buildbucket for the build status
[00:34:43.045] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:43.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:27:0) after 1m0s
[00:35:43.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:27:0)
[00:35:43.026] Timer tick, asking Buildbucket for the build status
[00:35:43.462] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:43.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:28:0) after 1m0s
[00:36:43.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:28:0)
[00:36:43.484] Timer tick, asking Buildbucket for the build status
[00:36:43.679] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:43.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:29:0) after 1m0s
[00:37:43.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:29:0)
[00:37:43.760] Timer tick, asking Buildbucket for the build status
[00:37:43.943] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:43.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:30:0) after 1m0s
[00:38:43.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:30:0)
[00:38:43.942] Timer tick, asking Buildbucket for the build status
[00:38:44.010] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:44.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:31:0) after 1m0s
[00:39:44.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:31:0)
[00:39:44.026] Timer tick, asking Buildbucket for the build status
[00:39:44.102] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:44.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:32:0) after 1m0s
[00:40:44.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:32:0)
[00:40:44.159] Timer tick, asking Buildbucket for the build status
[00:40:44.552] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:44.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:33:0) after 1m0s
[00:41:44.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:33:0)
[00:41:44.672] Timer tick, asking Buildbucket for the build status
[00:41:44.923] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:44.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:34:0) after 1m0s
[00:42:45.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:34:0)
[00:42:45.078] Timer tick, asking Buildbucket for the build status
[00:42:45.285] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:45.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:35:0) after 1m0s
[00:43:45.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:35:0)
[00:43:45.373] Timer tick, asking Buildbucket for the build status
[00:43:45.632] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:45.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:36:0) after 1m0s
[00:44:45.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:36:0)
[00:44:45.792] Timer tick, asking Buildbucket for the build status
[00:44:45.859] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:45.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:37:0) after 1m0s
[00:45:46.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:37:0)
[00:45:46.040] Timer tick, asking Buildbucket for the build status
[00:45:46.207] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:46.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:38:0) after 1m0s
[00:46:46.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:38:0)
[00:46:46.334] Timer tick, asking Buildbucket for the build status
[00:46:46.695] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:46.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:39:0) after 1m0s
[00:47:46.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:39:0)
[00:47:46.909] Timer tick, asking Buildbucket for the build status
[00:47:47.008] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:47.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:40:0) after 1m0s
[00:48:47.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:40:0)
[00:48:47.025] Timer tick, asking Buildbucket for the build status
[00:48:47.090] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:47.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:41:0) after 1m0s
[00:49:47.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:41:0)
[00:49:47.183] Timer tick, asking Buildbucket for the build status
[00:49:47.234] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:47.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:42:0) after 1m0s
[00:50:47.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:42:0)
[00:50:47.318] Timer tick, asking Buildbucket for the build status
[00:50:47.634] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:47.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:43:0) after 1m0s
[00:51:47.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:43:0)
[00:51:47.675] Timer tick, asking Buildbucket for the build status
[00:51:47.729] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:47.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:44:0) after 1m0s
[00:52:48.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:44:0)
[00:52:48.003] Timer tick, asking Buildbucket for the build status
[00:52:48.067] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:48.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:45:0) after 1m0s
[00:53:48.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:45:0)
[00:53:48.265] Timer tick, asking Buildbucket for the build status
[00:53:48.361] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:48.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:46:0) after 1m0s
[00:54:48.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:46:0)
[00:54:48.521] Timer tick, asking Buildbucket for the build status
[00:54:48.588] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:48.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:47:0) after 1m0s
[00:55:48.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:47:0)
[00:55:48.693] Timer tick, asking Buildbucket for the build status
[00:55:48.789] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:48.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:48:0) after 1m0s
[00:56:48.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:48:0)
[00:56:48.881] Timer tick, asking Buildbucket for the build status
[00:56:48.951] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:48.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:49:0) after 1m0s
[00:57:49.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:49:0)
[00:57:49.043] Timer tick, asking Buildbucket for the build status
[00:57:49.219] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:49.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:50:0) after 1m0s
[00:58:49.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:50:0)
[00:58:49.204] Timer tick, asking Buildbucket for the build status
[00:58:49.442] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:49.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:51:0) after 1m0s
[00:59:49.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:51:0)
[00:59:49.530] Timer tick, asking Buildbucket for the build status
[00:59:49.592] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:49.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:52:0) after 1m0s
[01:00:49.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:52:0)
[01:00:49.615] Timer tick, asking Buildbucket for the build status
[01:00:50.093] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:50.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:53:0) after 1m0s
[01:01:50.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:53:0)
[01:01:50.117] Timer tick, asking Buildbucket for the build status
[01:01:50.319] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:50.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:54:0) after 1m0s
[01:02:50.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:54:0)
[01:02:50.349] Timer tick, asking Buildbucket for the build status
[01:02:53.653] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:53.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:55:0) after 1m0s
[01:03:53.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:55:0)
[01:03:53.682] Timer tick, asking Buildbucket for the build status
[01:03:53.785] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:53.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:56:0) after 1m0s
[01:04:53.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:56:0)
[01:04:53.767] Timer tick, asking Buildbucket for the build status
[01:04:53.852] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:53.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:57:0) after 1m0s
[01:05:53.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:57:0)
[01:05:53.928] Timer tick, asking Buildbucket for the build status
[01:05:54.075] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:54.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:58:0) after 1m0s
[01:06:54.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:58:0)
[01:06:54.172] Timer tick, asking Buildbucket for the build status
[01:06:54.408] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:54.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:59:0) after 1m0s
[01:07:54.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:59:0)
[01:07:54.492] Timer tick, asking Buildbucket for the build status
[01:07:54.721] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:54.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:60:0) after 1m0s
[01:08:54.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:60:0)
[01:08:54.778] Timer tick, asking Buildbucket for the build status
[01:08:54.890] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:54.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:61:0) after 1m0s
[01:09:54.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:61:0)
[01:09:54.897] Timer tick, asking Buildbucket for the build status
[01:09:55.079] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:55.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:62:0) after 1m0s
[01:10:55.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:62:0)
[01:10:55.202] Timer tick, asking Buildbucket for the build status
[01:10:55.430] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:55.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:63:0) after 1m0s
[01:11:55.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:63:0)
[01:11:55.500] Timer tick, asking Buildbucket for the build status
[01:11:55.746] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:55.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:64:0) after 1m0s
[01:12:55.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:64:0)
[01:12:55.888] Timer tick, asking Buildbucket for the build status
[01:12:56.006] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:56.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:65:0) after 1m0s
[01:13:56.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:65:0)
[01:13:56.065] Timer tick, asking Buildbucket for the build status
[01:13:56.427] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:56.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:66:0) after 1m0s
[01:14:56.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:66:0)
[01:14:56.469] Timer tick, asking Buildbucket for the build status
[01:14:56.544] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:56.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:67:0) after 1m0s
[01:15:56.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:67:0)
[01:15:56.644] Timer tick, asking Buildbucket for the build status
[01:15:57.050] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:57.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:68:0) after 1m0s
[01:16:57.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:68:0)
[01:16:57.146] Timer tick, asking Buildbucket for the build status
[01:16:57.531] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:57.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:69:0) after 1m0s
[01:17:57.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:69:0)
[01:17:57.707] Timer tick, asking Buildbucket for the build status
[01:17:58.146] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:58.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:70:0) after 1m0s
[01:18:58.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:70:0)
[01:18:58.207] Timer tick, asking Buildbucket for the build status
[01:18:58.296] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:58.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:71:0) after 1m0s
[01:19:58.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:71:0)
[01:19:58.369] Timer tick, asking Buildbucket for the build status
[01:19:58.497] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:58.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:72:0) after 1m0s
[01:20:58.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:72:0)
[01:20:58.618] Timer tick, asking Buildbucket for the build status
[01:20:58.723] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:58.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:73:0) after 1m0s
[01:21:58.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:73:0)
[01:21:58.734] Timer tick, asking Buildbucket for the build status
[01:21:58.942] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:58.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:74:0) after 1m0s
[01:22:59.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:74:0)
[01:22:59.368] Timer tick, asking Buildbucket for the build status
[01:22:59.534] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:59.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:75:0) after 1m0s
[01:23:59.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:75:0)
[01:23:59.576] Timer tick, asking Buildbucket for the build status
[01:23:59.694] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:59.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:76:0) after 1m0s
[01:24:59.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:76:0)
[01:24:59.694] Timer tick, asking Buildbucket for the build status
[01:25:00.233] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:00.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:77:0) after 1m0s
[01:26:00.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:77:0)
[01:26:00.613] Timer tick, asking Buildbucket for the build status
[01:26:00.838] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:00.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:78:0) after 1m0s
[01:27:00.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:78:0)
[01:27:00.929] Timer tick, asking Buildbucket for the build status
[01:27:01.049] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:01.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:79:0) after 1m0s
[01:28:01.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:79:0)
[01:28:01.251] Timer tick, asking Buildbucket for the build status
[01:28:01.744] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:01.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:80:0) after 1m0s
[01:29:01.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:80:0)
[01:29:01.942] Timer tick, asking Buildbucket for the build status
[01:29:02.074] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:02.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:81:0) after 1m0s
[01:30:02.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:81:0)
[01:30:02.099] Timer tick, asking Buildbucket for the build status
[01:30:02.200] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:02.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:82:0) after 1m0s
[01:31:02.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:82:0)
[01:31:02.246] Timer tick, asking Buildbucket for the build status
[01:31:02.419] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:02.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:83:0) after 1m0s
[01:32:02.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:83:0)
[01:32:02.508] Timer tick, asking Buildbucket for the build status
[01:32:02.578] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:02.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:84:0) after 1m0s
[01:33:02.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:84:0)
[01:33:02.671] Timer tick, asking Buildbucket for the build status
[01:33:02.976] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:02.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:85:0) after 1m0s
[01:34:03.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:85:0)
[01:34:03.057] Timer tick, asking Buildbucket for the build status
[01:34:03.116] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:03.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:86:0) after 1m0s
[01:35:03.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:86:0)
[01:35:03.309] Timer tick, asking Buildbucket for the build status
[01:35:03.419] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:03.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:87:0) after 1m0s
[01:36:03.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:87:0)
[01:36:03.441] Timer tick, asking Buildbucket for the build status
[01:36:03.617] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:03.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:88:0) after 1m0s
[01:37:03.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:88:0)
[01:37:03.665] Timer tick, asking Buildbucket for the build status
[01:37:03.725] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:03.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:89:0) after 1m0s
[01:38:03.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:89:0)
[01:38:03.757] Timer tick, asking Buildbucket for the build status
[01:38:03.845] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:03.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:90:0) after 1m0s
[01:39:03.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:90:0)
[01:39:03.872] Timer tick, asking Buildbucket for the build status
[01:39:03.957] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:03.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:91:0) after 1m0s
[01:40:03.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:91:0)
[01:40:03.976] Timer tick, asking Buildbucket for the build status
[01:40:04.103] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:04.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:92:0) after 1m0s
[01:41:04.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:92:0)
[01:41:04.156] Timer tick, asking Buildbucket for the build status
[01:41:04.329] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:04.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:93:0) after 1m0s
[01:42:04.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:93:0)
[01:42:04.349] Timer tick, asking Buildbucket for the build status
[01:42:04.756] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:04.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:94:0) after 1m0s
[01:43:04.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:94:0)
[01:43:04.779] Timer tick, asking Buildbucket for the build status
[01:43:04.965] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:04.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:95:0) after 1m0s
[01:44:05.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:95:0)
[01:44:05.023] Timer tick, asking Buildbucket for the build status
[01:44:05.556] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:05.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:96:0) after 1m0s
[01:45:05.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:96:0)
[01:45:05.641] Timer tick, asking Buildbucket for the build status
[01:45:06.331] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:06.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:97:0) after 1m0s
[01:46:06.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:97:0)
[01:46:06.352] Timer tick, asking Buildbucket for the build status
[01:46:06.800] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:06.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:98:0) after 1m0s
[01:47:06.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:98:0)
[01:47:06.851] Timer tick, asking Buildbucket for the build status
[01:47:07.172] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:07.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:99:0) after 1m0s
[01:48:07.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:99:0)
[01:48:07.183] Timer tick, asking Buildbucket for the build status
[01:48:07.282] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:07.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:100:0) after 1m0s
[01:49:07.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:100:0)
[01:49:07.308] Timer tick, asking Buildbucket for the build status
[01:49:07.445] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:07.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:101:0) after 1m0s
[01:50:07.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:101:0)
[01:50:07.533] Timer tick, asking Buildbucket for the build status
[01:50:07.618] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:07.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:102:0) after 1m0s
[01:51:07.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:102:0)
[01:51:07.701] Timer tick, asking Buildbucket for the build status
[01:51:07.805] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:07.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:103:0) after 1m0s
[01:52:07.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:103:0)
[01:52:07.806] Timer tick, asking Buildbucket for the build status
[01:52:07.890] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:07.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:104:0) after 1m0s
[01:53:07.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:104:0)
[01:53:07.934] Timer tick, asking Buildbucket for the build status
[01:53:08.014] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:08.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:105:0) after 1m0s
[01:54:08.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:105:0)
[01:54:08.043] Timer tick, asking Buildbucket for the build status
[01:54:08.164] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:08.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:106:0) after 1m0s
[01:55:08.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:106:0)
[01:55:08.189] Timer tick, asking Buildbucket for the build status
[01:55:08.280] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:08.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:107:0) after 1m0s
[01:56:08.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:107:0)
[01:56:08.300] Timer tick, asking Buildbucket for the build status
[01:56:08.419] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:08.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:108:0) after 1m0s
[01:57:08.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:108:0)
[01:57:08.471] Timer tick, asking Buildbucket for the build status
[01:57:09.783] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:09.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:109:0) after 1m0s
[01:58:09.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:109:0)
[01:58:09.895] Timer tick, asking Buildbucket for the build status
[01:58:10.076] Build 8861527084260475920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:10.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026957146254734560:110:0) after 1m0s
[01:58:10.443] Received PubSub notification, asking Buildbucket for the build status
[01:58:10.603] Build 8861527084260475920: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[01:58:10.603] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1607392689683609",
"created_by": "project:chromium",
"created_ts": "1607386237810834",
"failure_reason": "BUILD_FAILURE",
"id": "8861527084260475920",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a7be590db7d3f4ab87d67fc77eee49c964107a19\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**interactive_ui_tests** failed because of:\\n\\n- NewTabPageDoodleShareDialogFocusTest.All\\n\\n- NewTabPageMostVisitedFocusTest.All\\n\\n- NewTabPageCustomizeDialogFocusTest.All\\n\\n**browser_tests** failed because of:\\n\\n- NewTabPageCustomizeDialogTest.All\\n\\n- NewTabPageModulesModuleWrapperTest.All\\n\\n- NewTabPageFakeboxTest.All\\n\\n- NewTabPageCustomizeShortcutsTest.All\\n\\n- ...16 more failure(s) (20 total)...\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"a7be590db7d3f4ab87d67fc77eee49c964107a19\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-67-7xnt\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21649, \"got_angle_revision\": \"dea86294537c612e1f0d72d9b29b7ecb1a76dbd3\", \"got_dawn_revision\": \"042184128efea90552495d5054c3ae17b84cb3c3\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"a7be590db7d3f4ab87d67fc77eee49c964107a19\", \"got_revision_cp\": \"refs/heads/master@{#834464}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"7bcd79eccf28007fe7a60ed50251d91ea4e65674\", \"got_v8_revision\": \"1c9380eba0e26de8661d3b1c69778082b4771b2b\", \"got_v8_revision_cp\": \"refs/heads/8.9.118@{#1}\", \"got_webrtc_revision\": \"bb1a28de3cf17476142e9de8ee12fe6c567d06c1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32789}\", \"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\": \"a7be590db7d3f4ab87d67fc77eee49c964107a19\", \"swarm_hashes_refs/heads/master(at){#834464}_without_patch\": {\"absl_hardening_tests\": \"de45fcb557a42618f4b3d1d36f619c6cafd3027a\", \"accessibility_unittests\": \"67be73806b9ce8ebf9178bfe6318bdd9d5e29e7d\", \"angle_unittests\": \"99be4b89d81363ddb82f4eba25d91026b076d4b4\", \"app_list_unittests\": \"2b8a6513cf4f7e33cb628f9c78ca926c33bde97f\", \"app_shell_unittests\": \"24b1e56825793f13032e1e759b513910b0b24229\", \"ash_unittests\": \"4dee6170f6375cb150462b9cdfc679871019e1e0\", \"aura_unittests\": \"3613de8dd89e220d95ad034394718169fcade4cb\", \"base_unittests\": \"4aadfbe4e0322fef5542d15d3962fe61362461bc\", \"base_util_unittests\": \"86e15e1a4a82c7b8abfb55ffb01f86236bc48d1e\", \"blink_common_unittests\": \"c4ab72b39a51e50b683ce5b23077d07048b1978c\", \"blink_fuzzer_unittests\": \"e73b7038b49605994b64d58902b60041c1874a64\", \"blink_heap_unittests\": \"344c35ab83928021b06fd75d17e081689838dbb9\", \"blink_platform_unittests\": \"d9c3f955d6fa44014bba91e3ad96a49b945245e0\", \"blink_unittests\": \"28e20da98541af8625a41d990065e4154c8176b5\", \"boringssl_crypto_tests\": \"c3713a1a381d3e0c9daf6a9f21d1bee5b886fb6f\", \"boringssl_ssl_tests\": \"16afb6254c07d83eba4e7b539a4e891ac90ad7fd\", \"browser_tests\": \"d8aa075bf6aa81a4e6518cef85a0596155cff00f\", \"capture_unittests\": \"2a0b85892d3b06f8124d5cc5d2c151924f138dfe\", \"cast_unittests\": \"a9baefe1ab222e85f7ca33c9393ca83299fac86e\", \"cc_unittests\": \"e196bbc36160f9dcde67c87cc799161f8eec5e85\", \"chrome_app_unittests\": \"a26685dc628c71d46cd2ff4aaf130bc1b1e5a53e\", \"chromedriver_unittests\": \"57f11cb1e2f1612d47e76a5069de5fdddec22f19\", \"chromeos_components_unittests\": \"cb5f71da4385ee7976de94bd843a78fa63e0ca63\", \"chromeos_unittests\": \"39c010b45d5074f7dae18a1b328e9667d7a9c7b4\", \"components_browsertests\": \"930c05da838d7e0c08cd83e4740ca5fc9704ec8a\", \"components_unittests\": \"1aa0d0c2123b312423699c76f9f4fd837b78c700\", \"compositor_unittests\": \"8996117eb58127d772257f00826e19191277fb82\", \"content_browsertests\": \"f33ca04897aa1553aafe25678ee4093b0faa9eb8\", \"content_unittests\": \"f07b120cb67584e76d5ce6514fe43e5992b772f4\", \"crashpad_tests\": \"4c33124c16dec97b7129ef20f02daf07a2524371\", \"crypto_unittests\": \"850380aa0440cd92816364b1b4a4ecce49a8fe57\", \"dbus_unittests\": \"202b09a90929917c290db6228dd9c8c5e749626c\", \"device_unittests\": \"e4569293e311ba14e91426e3bb1eadd75e631307\", \"display_unittests\": \"e6f03f6da79d72f41c2b0ef7787328726b238b8d\", \"events_unittests\": \"3997ceea130c934e800cd421eb23afb2aeebcee4\", \"exo_unittests\": \"ee64f011c1cba3329a8286f5fab6db12ce29f3f7\", \"extensions_browsertests\": \"3d0aabe15779a7fb16e2bb14a708624f4bf2eece\", \"extensions_unittests\": \"7d5fbefae8cdb1389667c0df203085285d846da2\", \"filesystem_service_unittests\": \"f62c91d15277c72f4d5578d23486b4d6a0885ec2\", \"gcm_unit_tests\": \"6a0621593c760d22f02c371e82f70fb17cc0da5a\", \"gfx_unittests\": \"022d333f517ca4cffcef9aa4108a4be18bc1b9d5\", \"gin_unittests\": \"326fb7b1adecd20ca429dcfb0de70e5ad2110439\", \"gl_unittests_ozone\": \"ba641c56dc276a5a1900ac35c5bc7919d3afa32a\", \"google_apis_unittests\": \"da8368683ffbee8703596e923355f0a9e4e4bf0e\", \"gpu_unittests\": \"2d9aaaab6443c04f2fb60f6ab79abd820cb28682\", \"gwp_asan_unittests\": \"e4fb8614b4dfe435ceba216d03f0051bbb136592\", \"interactive_ui_tests\": \"cf18f5846f6533a57ffa7db2fe37d1cb5c2a8e45\", \"ipc_tests\": \"e12b4befc238eef1c7d7f5556e87389040d570d1\", \"jingle_unittests\": \"329d63e74cccafc2a73efce65492adcc23f54651\", \"keyboard_unittests\": \"a580abf8cc45153bcbe4afc3ce886fa41d7efd84\", \"latency_unittests\": \"169377c9c64c07cfa8dde79fc36b7d565d914e24\", \"libjingle_xmpp_unittests\": \"bb3f087cc17472d2ad6e0c0a2131e553a24a63ff\", \"liburlpattern_unittests\": \"26df8234d12cb8bff2c75849f33525f339b4c25c\", \"media_blink_unittests\": \"838b5913722b46e3136b20fe219a49ca0f0b3c36\", \"media_unittests\": \"dd56c745a105613b1c2a27e3d3a37a6e20252ed3\", \"message_center_unittests\": \"0cd9e365c1c3b60c55f6cecbda9030054072757f\", \"midi_unittests\": \"9d269a3b37e944fe9943d55c3ac453bde077fbb6\", \"mojo_core_unittests\": \"033e8dfe285d04a3dcff751b3298ca318b9ed3fa\", \"mojo_unittests\": \"8b72af296865df67c12bbcf8e37c3ae6d2ad78d4\", \"nacl_helper_nonsfi_unittests\": \"90d2e04738f0af6b51962eb90b0f5d54ec82709c\", \"nacl_loader_unittests\": \"f2815fb7b9a0ca7953614658f83ae2e7de4c0981\", \"native_theme_unittests\": \"755be543dd85040cefa6bb303835409e441013a7\", \"net_unittests\": \"4ff8402036bf119ebf41e7baae91e40b8861ba3e\", \"ozone_gl_unittests\": \"1fb001dbc446b40a033af7dfe05055a2af00afd9\", \"ozone_unittests\": \"921906c02b744f51dfad954506d65f7e514fe55f\", \"ozone_x11_unittests\": \"d0cb8e44a49762bdbf83a9fc4fb685b5da71b15c\", \"pdf_unittests\": \"e09583601ba0e82f78efd34873ac93758e72eca5\", \"perfetto_unittests\": \"0bb4788ab54ad379bb1f1c93007428f8735c0c34\", \"ppapi_unittests\": \"95afc80cbc0aa29c51ad945f9b859d3462be7cef\", \"printing_unittests\": \"78a16c167573de02aa4ffc1fa2174be447c940d8\", \"remoting_unittests\": \"374351742b4ed0114887f86ea1e8076fa0c45934\", \"sandbox_linux_unittests\": \"45a76c60d07e567b89d9e3479bfde7488d5ad6ad\", \"service_manager_unittests\": \"abf4dca81c596d2afb33a29ad104f3f11f487243\", \"services_unittests\": \"e197f31f3f4189ff53a93a86de3e679893973158\", \"shell_dialogs_unittests\": \"58b8fae03cbb81e252b82469a16bd28c581068d6\", \"shell_encryption_unittests\": \"042562848d30ad40af00d6ce25cc9c9dbc7ff2f1\", \"skia_unittests\": \"e0a6c1e5dead1e83a52bcfc69d51612f4ce31e53\", \"snapshot_unittests\": \"892ef65dbdc275bbd693566a6d01ba859bd5d833\", \"sql_unittests\": \"466b2b1f2c795a8f059916eb393d6d403386b35a\", \"storage_unittests\": \"8dbd6297ec2d483ee9a805e5244d749baccbeb9c\", \"sync_integration_tests\": \"0aa744d2a9168fdfa318f17360f57289b6f9f786\", \"traffic_annotation_auditor_unittests\": \"ef2ae64814d834f74f79eacbf0f94a238c6cc7a8\", \"ui_base_unittests\": \"0051fb6981900c7ff3d4a3ded3da67b6ebd57947\", \"ui_chromeos_unittests\": \"4e1b145030f89a71315d36b94289d3408c8a544c\", \"ui_touch_selection_unittests\": \"2ddc0925c18806637c6b690cd03a32c9720706f1\", \"unit_tests\": \"64b5fe7fd7cb18e93598a515daecf8e1f582fa76\", \"url_unittests\": \"35f9fd55be885a0d78fce2c9447ab948bf5fc546\", \"usage_time_limit_unittests\": \"146cfdd0b8e2e357dec356f263f87185fd1c6b7d\", \"views_unittests\": \"00312d8b4e379f7cd64e0a410c0d69f21be736b4\", \"viz_unittests\": \"d920fc3896b48ab56a58f8236a2cc139abdfa3fa\", \"wm_unittests\": \"863ba4813824bbb3b84e092a869943c5aa49dfcc\", \"wtf_unittests\": \"223b92758ec95bb9ece9f8ce93629cab59f5b3c3\", \"zlib_unittests\": \"7ec9bd5889187891b67a890db32a67069e67aa8a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_12fe258969bd458c0c491cc8ec8a110de21b19ba6d4540c003334ed929b828ba_v2\", \"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_683151a13e11b6ef159b21e9ff1210b7a016189cdbfd66586ebc7bd6db856ba2_v2\", \"builder_7ddc1ece4c938056809d45345930c5d8ea6799936d2255389af4f16219f397ac_v2\", \"builder_9efb94071a208cb32f222f9589b2bf8c6e9d4ebc7884b1b49bd19cd2b21dc48e_v2\", \"builder_a1c3d05f1886c3c1a4b693e8245da857a9c63a0cda58ad280c9a386162f50760_v2\", \"builder_ea4e7feff896b82ff6619a3b9c5371d5e74ebdd508befd295e2f5ab02f5eefaf_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-67-7xnt\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**interactive_ui_tests** failed because of:\\n\\n- NewTabPageDoodleShareDialogFocusTest.All\\n\\n- NewTabPageMostVisitedFocusTest.All\\n\\n- NewTabPageCustomizeDialogFocusTest.All\\n\\n**browser_tests** failed because of:\\n\\n- NewTabPageCustomizeDialogTest.All\\n\\n- NewTabPageModulesModuleWrapperTest.All\\n\\n- NewTabPageFakeboxTest.All\\n\\n- NewTabPageCustomizeShortcutsTest.All\\n\\n- ...16 more failure(s) (20 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607386391173007",
"status": "COMPLETED",
"status_changed_ts": "1607386393160543",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21649",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a7be590db7d3f4ab87d67fc77eee49c964107a19",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a7be590db7d3f4ab87d67fc77eee49c964107a19",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026957146254734560",
"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/8861527084260475920/+/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:5058811dc92a5c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1607392689996517",
"url": "https://ci.chromium.org/b/8861527084260475920",
"utcnow_ts": "1607392690582528"
}
}
[01:58:10.603] Invocation finished in 1h47m34.078132096s with status FAILED