[19:07:16.678] New invocation is queued and will start shortly
[19:07:20.061] Starting the invocation (attempt 1)
[19:07:20.101] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:07:20.102] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:07:20.102] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023442948504006368",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9e0bf445f0cad42dd69989ad09493130e27c9eac\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9023442948504006368",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/9e0bf445f0cad42dd69989ad09493130e27c9eac",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9e0bf445f0cad42dd69989ad09493130e27c9eac",
"gitiles_ref:refs/heads/master"
]
}
[19:07:21.674] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610737640219900",
"id": "8858012884127973392",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9e0bf445f0cad42dd69989ad09493130e27c9eac\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610737641344352",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22217",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9e0bf445f0cad42dd69989ad09493130e27c9eac",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9e0bf445f0cad42dd69989ad09493130e27c9eac",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023442948504006368",
"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/8858012884127973392/+/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": "1610737641344468",
"url": "https://ci.chromium.org/b/8858012884127973392",
"utcnow_ts": "1610737641654940"
}
}
[19:07:21.674] Task URL: https://ci.chromium.org/b/8858012884127973392
[19:07:21.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:2:0) after 1m0s
[19:08:21.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:2:0)
[19:08:21.786] Timer tick, asking Buildbucket for the build status
[19:08:22.387] Build 8858012884127973392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:08:22.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:3:0) after 1m0s
[19:08:55.586] Received PubSub notification, asking Buildbucket for the build status
[19:08:55.671] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:22.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:3:0)
[19:09:22.484] Timer tick, asking Buildbucket for the build status
[19:09:22.845] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:22.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:5:0) after 1m0s
[19:10:22.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:5:0)
[19:10:22.972] Timer tick, asking Buildbucket for the build status
[19:10:23.132] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:23.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:6:0) after 1m0s
[19:11:23.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:6:0)
[19:11:23.205] Timer tick, asking Buildbucket for the build status
[19:11:23.270] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:23.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:7:0) after 1m0s
[19:12:23.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:7:0)
[19:12:23.611] Timer tick, asking Buildbucket for the build status
[19:12:23.797] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:23.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:8:0) after 1m0s
[19:13:23.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:8:0)
[19:13:23.846] Timer tick, asking Buildbucket for the build status
[19:13:23.966] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:23.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:9:0) after 1m0s
[19:14:23.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:9:0)
[19:14:23.987] Timer tick, asking Buildbucket for the build status
[19:14:24.112] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:24.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:10:0) after 1m0s
[19:15:24.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:10:0)
[19:15:24.244] Timer tick, asking Buildbucket for the build status
[19:15:24.575] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:24.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:11:0) after 1m0s
[19:16:24.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:11:0)
[19:16:24.623] Timer tick, asking Buildbucket for the build status
[19:16:24.715] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:24.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:12:0) after 1m0s
[19:17:24.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:12:0)
[19:17:24.802] Timer tick, asking Buildbucket for the build status
[19:17:24.926] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:24.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:13:0) after 1m0s
[19:18:24.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:13:0)
[19:18:24.993] Timer tick, asking Buildbucket for the build status
[19:18:25.217] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:25.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:14:0) after 1m0s
[19:19:25.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:14:0)
[19:19:25.221] Timer tick, asking Buildbucket for the build status
[19:19:25.325] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:25.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:15:0) after 1m0s
[19:20:25.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:15:0)
[19:20:25.308] Timer tick, asking Buildbucket for the build status
[19:20:25.387] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:25.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:16:0) after 1m0s
[19:21:25.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:16:0)
[19:21:25.416] Timer tick, asking Buildbucket for the build status
[19:21:25.572] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:25.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:17:0) after 1m0s
[19:22:25.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:17:0)
[19:22:25.602] Timer tick, asking Buildbucket for the build status
[19:22:26.161] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:26.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:18:0) after 1m0s
[19:23:26.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:18:0)
[19:23:26.212] Timer tick, asking Buildbucket for the build status
[19:23:26.300] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:26.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:19:0) after 1m0s
[19:24:26.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:19:0)
[19:24:26.325] Timer tick, asking Buildbucket for the build status
[19:24:26.501] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:26.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:20:0) after 1m0s
[19:25:26.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:20:0)
[19:25:26.511] Timer tick, asking Buildbucket for the build status
[19:25:26.672] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:26.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:21:0) after 1m0s
[19:26:26.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:21:0)
[19:26:26.716] Timer tick, asking Buildbucket for the build status
[19:26:26.777] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:26.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:22:0) after 1m0s
[19:27:26.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:22:0)
[19:27:26.851] Timer tick, asking Buildbucket for the build status
[19:27:27.329] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:27.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:23:0) after 1m0s
[19:28:27.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:23:0)
[19:28:27.370] Timer tick, asking Buildbucket for the build status
[19:28:27.458] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:27.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:24:0) after 1m0s
[19:29:27.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:24:0)
[19:29:27.473] Timer tick, asking Buildbucket for the build status
[19:29:27.556] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:27.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:25:0) after 1m0s
[19:30:27.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:25:0)
[19:30:27.641] Timer tick, asking Buildbucket for the build status
[19:30:27.717] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:27.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:26:0) after 1m0s
[19:31:27.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:26:0)
[19:31:27.794] Timer tick, asking Buildbucket for the build status
[19:31:27.864] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:27.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:27:0) after 1m0s
[19:32:27.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:27:0)
[19:32:27.960] Timer tick, asking Buildbucket for the build status
[19:32:28.456] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:28.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:28:0) after 1m0s
[19:33:28.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:28:0)
[19:33:28.523] Timer tick, asking Buildbucket for the build status
[19:33:28.630] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:28.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:29:0) after 1m0s
[19:34:28.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:29:0)
[19:34:28.717] Timer tick, asking Buildbucket for the build status
[19:34:28.801] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:28.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:30:0) after 1m0s
[19:35:28.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:30:0)
[19:35:28.873] Timer tick, asking Buildbucket for the build status
[19:35:28.946] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:28.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:31:0) after 1m0s
[19:36:29.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:31:0)
[19:36:29.052] Timer tick, asking Buildbucket for the build status
[19:36:29.129] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:29.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:32:0) after 1m0s
[19:37:29.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:32:0)
[19:37:29.342] Timer tick, asking Buildbucket for the build status
[19:37:29.448] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:29.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:33:0) after 1m0s
[19:38:29.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:33:0)
[19:38:29.501] Timer tick, asking Buildbucket for the build status
[19:38:29.576] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:29.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:34:0) after 1m0s
[19:39:29.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:34:0)
[19:39:29.632] Timer tick, asking Buildbucket for the build status
[19:39:29.693] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:29.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:35:0) after 1m0s
[19:40:29.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:35:0)
[19:40:29.730] Timer tick, asking Buildbucket for the build status
[19:40:29.871] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:29.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:36:0) after 1m0s
[19:41:29.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:36:0)
[19:41:29.967] Timer tick, asking Buildbucket for the build status
[19:41:30.158] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:30.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:37:0) after 1m0s
[19:42:30.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:37:0)
[19:42:30.237] Timer tick, asking Buildbucket for the build status
[19:42:30.588] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:30.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:38:0) after 1m0s
[19:43:30.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:38:0)
[19:43:30.768] Timer tick, asking Buildbucket for the build status
[19:43:30.901] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:30.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:39:0) after 1m0s
[19:44:30.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:39:0)
[19:44:30.888] Timer tick, asking Buildbucket for the build status
[19:44:30.961] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:30.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:40:0) after 1m0s
[19:45:31.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:40:0)
[19:45:31.031] Timer tick, asking Buildbucket for the build status
[19:45:31.099] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:31.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:41:0) after 1m0s
[19:46:31.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:41:0)
[19:46:31.204] Timer tick, asking Buildbucket for the build status
[19:46:31.273] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:31.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:42:0) after 1m0s
[19:47:31.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:42:0)
[19:47:31.423] Timer tick, asking Buildbucket for the build status
[19:47:31.534] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:31.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:43:0) after 1m0s
[19:48:31.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:43:0)
[19:48:31.539] Timer tick, asking Buildbucket for the build status
[19:48:32.138] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:32.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:44:0) after 1m0s
[19:49:32.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:44:0)
[19:49:32.201] Timer tick, asking Buildbucket for the build status
[19:49:32.337] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:32.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:45:0) after 1m0s
[19:50:32.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:45:0)
[19:50:32.403] Timer tick, asking Buildbucket for the build status
[19:50:32.845] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:32.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:46:0) after 1m0s
[19:51:34.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:46:0)
[19:51:34.067] Timer tick, asking Buildbucket for the build status
[19:51:34.277] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:34.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:47:0) after 1m0s
[19:52:34.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:47:0)
[19:52:34.330] Timer tick, asking Buildbucket for the build status
[19:52:34.480] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:34.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:48:0) after 1m0s
[19:53:34.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:48:0)
[19:53:34.532] Timer tick, asking Buildbucket for the build status
[19:53:34.690] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:34.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:49:0) after 1m0s
[19:54:34.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:49:0)
[19:54:34.691] Timer tick, asking Buildbucket for the build status
[19:54:34.789] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:34.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:50:0) after 1m0s
[19:55:35.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:50:0)
[19:55:35.109] Timer tick, asking Buildbucket for the build status
[19:55:35.810] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:35.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:51:0) after 1m0s
[19:56:35.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:51:0)
[19:56:35.875] Timer tick, asking Buildbucket for the build status
[19:56:35.993] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:35.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:52:0) after 1m0s
[19:57:36.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:52:0)
[19:57:36.037] Timer tick, asking Buildbucket for the build status
[19:57:36.218] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:36.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:53:0) after 1m0s
[19:58:36.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:53:0)
[19:58:36.291] Timer tick, asking Buildbucket for the build status
[19:58:36.394] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:36.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:54:0) after 1m0s
[19:59:36.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:54:0)
[19:59:36.439] Timer tick, asking Buildbucket for the build status
[19:59:36.623] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:36.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:55:0) after 1m0s
[20:00:36.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:55:0)
[20:00:36.675] Timer tick, asking Buildbucket for the build status
[20:00:36.817] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:36.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:56:0) after 1m0s
[20:01:36.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:56:0)
[20:01:36.895] Timer tick, asking Buildbucket for the build status
[20:01:37.021] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:37.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:57:0) after 1m0s
[20:02:37.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:57:0)
[20:02:37.041] Timer tick, asking Buildbucket for the build status
[20:02:37.513] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:37.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:58:0) after 1m0s
[20:03:37.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:58:0)
[20:03:37.638] Timer tick, asking Buildbucket for the build status
[20:03:37.713] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:37.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:59:0) after 1m0s
[20:04:37.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:59:0)
[20:04:37.743] Timer tick, asking Buildbucket for the build status
[20:04:38.020] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:38.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:60:0) after 1m0s
[20:05:38.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:60:0)
[20:05:38.069] Timer tick, asking Buildbucket for the build status
[20:05:38.381] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:38.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:61:0) after 1m0s
[20:06:38.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:61:0)
[20:06:38.432] Timer tick, asking Buildbucket for the build status
[20:06:38.564] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:38.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:62:0) after 1m0s
[20:07:38.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:62:0)
[20:07:38.616] Timer tick, asking Buildbucket for the build status
[20:07:38.748] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:38.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:63:0) after 1m0s
[20:08:38.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:63:0)
[20:08:38.795] Timer tick, asking Buildbucket for the build status
[20:08:38.972] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:38.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:64:0) after 1m0s
[20:09:39.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:64:0)
[20:09:39.040] Timer tick, asking Buildbucket for the build status
[20:09:39.124] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:39.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:65:0) after 1m0s
[20:10:39.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:65:0)
[20:10:39.168] Timer tick, asking Buildbucket for the build status
[20:10:39.341] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:39.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:66:0) after 1m0s
[20:11:39.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:66:0)
[20:11:39.335] Timer tick, asking Buildbucket for the build status
[20:11:39.509] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:39.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:67:0) after 1m0s
[20:12:39.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:67:0)
[20:12:39.570] Timer tick, asking Buildbucket for the build status
[20:12:39.685] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:39.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:68:0) after 1m0s
[20:13:39.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:68:0)
[20:13:39.838] Timer tick, asking Buildbucket for the build status
[20:13:40.014] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:40.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:69:0) after 1m0s
[20:14:40.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:69:0)
[20:14:40.111] Timer tick, asking Buildbucket for the build status
[20:14:40.205] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:40.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:70:0) after 1m0s
[20:15:40.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:70:0)
[20:15:40.554] Timer tick, asking Buildbucket for the build status
[20:15:40.647] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:40.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:71:0) after 1m0s
[20:16:40.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:71:0)
[20:16:40.707] Timer tick, asking Buildbucket for the build status
[20:16:40.787] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:40.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:72:0) after 1m0s
[20:17:40.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:72:0)
[20:17:40.857] Timer tick, asking Buildbucket for the build status
[20:17:40.981] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:40.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:73:0) after 1m0s
[20:18:41.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:73:0)
[20:18:41.010] Timer tick, asking Buildbucket for the build status
[20:18:41.104] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:41.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:74:0) after 1m0s
[20:19:41.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:74:0)
[20:19:41.132] Timer tick, asking Buildbucket for the build status
[20:19:41.456] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:41.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:75:0) after 1m0s
[20:20:41.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:75:0)
[20:20:41.549] Timer tick, asking Buildbucket for the build status
[20:20:41.768] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:41.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:76:0) after 1m0s
[20:21:41.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:76:0)
[20:21:41.813] Timer tick, asking Buildbucket for the build status
[20:21:42.427] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:42.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:77:0) after 1m0s
[20:22:42.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:77:0)
[20:22:42.489] Timer tick, asking Buildbucket for the build status
[20:22:43.427] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:43.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:78:0) after 1m0s
[20:23:43.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:78:0)
[20:23:43.478] Timer tick, asking Buildbucket for the build status
[20:23:43.555] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:43.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:79:0) after 1m0s
[20:24:43.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:79:0)
[20:24:43.609] Timer tick, asking Buildbucket for the build status
[20:24:43.840] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:43.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:80:0) after 1m0s
[20:25:43.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:80:0)
[20:25:43.843] Timer tick, asking Buildbucket for the build status
[20:25:44.148] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:44.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:81:0) after 1m0s
[20:26:44.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:81:0)
[20:26:44.200] Timer tick, asking Buildbucket for the build status
[20:26:44.518] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:44.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:82:0) after 1m0s
[20:27:44.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:82:0)
[20:27:44.609] Timer tick, asking Buildbucket for the build status
[20:27:44.718] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:44.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:83:0) after 1m0s
[20:28:45.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:83:0)
[20:28:45.055] Timer tick, asking Buildbucket for the build status
[20:28:45.646] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:45.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:84:0) after 1m0s
[20:29:45.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:84:0)
[20:29:45.908] Timer tick, asking Buildbucket for the build status
[20:29:45.994] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:45.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:85:0) after 1m0s
[20:30:46.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:85:0)
[20:30:46.103] Timer tick, asking Buildbucket for the build status
[20:30:46.194] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:46.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:86:0) after 1m0s
[20:31:46.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:86:0)
[20:31:46.312] Timer tick, asking Buildbucket for the build status
[20:31:46.396] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:46.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:87:0) after 1m0s
[20:32:46.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:87:0)
[20:32:46.479] Timer tick, asking Buildbucket for the build status
[20:32:46.660] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:46.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:88:0) after 1m0s
[20:33:46.861] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:88:0)
[20:33:46.861] Timer tick, asking Buildbucket for the build status
[20:33:46.956] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:46.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:89:0) after 1m0s
[20:34:46.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:89:0)
[20:34:46.980] Timer tick, asking Buildbucket for the build status
[20:34:47.103] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:47.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:90:0) after 1m0s
[20:35:47.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:90:0)
[20:35:47.089] Timer tick, asking Buildbucket for the build status
[20:35:47.175] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:47.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:91:0) after 1m0s
[20:36:47.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:91:0)
[20:36:47.236] Timer tick, asking Buildbucket for the build status
[20:36:47.338] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:47.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:92:0) after 1m0s
[20:37:47.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:92:0)
[20:37:47.343] Timer tick, asking Buildbucket for the build status
[20:37:47.696] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:47.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:93:0) after 1m0s
[20:38:47.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:93:0)
[20:38:47.730] Timer tick, asking Buildbucket for the build status
[20:38:47.834] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:47.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:94:0) after 1m0s
[20:39:47.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:94:0)
[20:39:47.838] Timer tick, asking Buildbucket for the build status
[20:39:47.920] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:47.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:95:0) after 1m0s
[20:40:47.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:95:0)
[20:40:47.943] Timer tick, asking Buildbucket for the build status
[20:40:48.139] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:48.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:96:0) after 1m0s
[20:41:48.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:96:0)
[20:41:48.153] Timer tick, asking Buildbucket for the build status
[20:41:48.247] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:48.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:97:0) after 1m0s
[20:42:48.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:97:0)
[20:42:48.340] Timer tick, asking Buildbucket for the build status
[20:42:48.820] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:48.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:98:0) after 1m0s
[20:43:48.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:98:0)
[20:43:48.904] Timer tick, asking Buildbucket for the build status
[20:43:49.044] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:49.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:99:0) after 1m0s
[20:44:49.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:99:0)
[20:44:49.074] Timer tick, asking Buildbucket for the build status
[20:44:49.237] Build 8858012884127973392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:49.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023442948504006368:100:0) after 1m0s
[20:44:56.405] Received PubSub notification, asking Buildbucket for the build status
[20:44:56.481] Build 8858012884127973392: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:44:56.481] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610743495524265",
"created_by": "project:chromium",
"created_ts": "1610737640219900",
"failure_reason": "BUILD_FAILURE",
"id": "8858012884127973392",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9e0bf445f0cad42dd69989ad09493130e27c9eac\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- AutomationApiTest.TextareaAppendPerf\"}, \"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\": \"9e0bf445f0cad42dd69989ad09493130e27c9eac\", \"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-192-cztd\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22217, \"got_angle_revision\": \"d2e76b73efc2c16d7c4a2cddbef4965deeb2f1c9\", \"got_dawn_revision\": \"54449966dd2eaa9a04449855f67af4bb29d52239\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"9e0bf445f0cad42dd69989ad09493130e27c9eac\", \"got_revision_cp\": \"refs/heads/master@{#844169}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"aedd133cd85f40f92c304776d240a8a3503d1d71\", \"got_v8_revision\": \"16b9bbbd581c25391981aa03180b76aa60463a3e\", \"got_v8_revision_cp\": \"refs/heads/8.9.255@{#1}\", \"got_webrtc_revision\": \"7acc2d9fe3a6e3c4d8881d2bdfc9b8968a724cd5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32986}\", \"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\": \"9e0bf445f0cad42dd69989ad09493130e27c9eac\", \"swarm_hashes_refs/heads/master(at){#844169}_without_patch\": {\"absl_hardening_tests\": \"246ce669e18d3acef1bddbc9e72fa94da205784f\", \"accessibility_unittests\": \"fe0b327bc9f4147dc0e271f99956a088175dd4d6\", \"angle_unittests\": \"adb43e81e2e26dde8f1e2f240c4dec2f9139fa9f\", \"app_list_unittests\": \"61ce8dac2d30e5cd8329b55057685991d599f3ad\", \"app_shell_unittests\": \"ae52f38d018bcb3fc925392a20268d6793d22587\", \"ash_unittests\": \"f8ad456e951d72ea028b51fab4e4a78d1d75bbbb\", \"aura_unittests\": \"e890e02fb53d3eb34848065f4318993f8940bc66\", \"base_unittests\": \"307ed0261d91dd0d370b40484d43a718548dc480\", \"base_util_unittests\": \"6ddd0291ab13bde1e71d0ce0c07779f7029b40bd\", \"blink_common_unittests\": \"19a32a989894ffe9b44705a2cb85573ba2a983ed\", \"blink_fuzzer_unittests\": \"684344dfa2ee819bab80a62ef4362ba2272e192f\", \"blink_heap_unittests\": \"5d95281a5794693db5f676fa6076944d3cdc636b\", \"blink_platform_unittests\": \"c7e781b8742f5e8dfcf257d6b1c54abbc37d77ad\", \"blink_unittests\": \"43cef0564cd7c251c1d6d188cfcf68512959370a\", \"boringssl_crypto_tests\": \"c6f46b55a3efca98d9e1ecf16cb0896d182fc70b\", \"boringssl_ssl_tests\": \"36ed44dcd8cb75e4a69a85ba32a55a6435348f98\", \"browser_tests\": \"04b5c0b62121e9429c416eb8a51045082cb1322b\", \"capture_unittests\": \"9ce159497ef0c09bddd177ac0dd3132c7f601577\", \"cast_unittests\": \"6a809a5852984a83bca856a3a8e2434dfc4f1d16\", \"cc_unittests\": \"1ca60deda59c4a391a01f3fd59b6fbdae70d75ca\", \"chrome_app_unittests\": \"935654df053e26577224c902f652f235c323b8c2\", \"chromedriver_unittests\": \"0f6673f8797cfe47f7d393a5cca5c835fb6f0e7b\", \"chromeos_components_unittests\": \"259ee437688c26a35178c7c5baec6e9ddc753aa8\", \"chromeos_unittests\": \"4f80e8e1ceea380213b852c86a4205bd85f1d7b6\", \"components_browsertests\": \"d67886449b027ce89e40710c90e3303dbbb547ec\", \"components_unittests\": \"62dbca9c6ca4570303133cbbb76b70d19887f1f3\", \"compositor_unittests\": \"7b06a28c9ce3c7617cb32ab844aa5bebf280f37b\", \"content_browsertests\": \"c3160ada8decae1c959d978ba286bbba4262c4f7\", \"content_unittests\": \"5fddc78d67fbee6fe465a80ee208c066bc7c7b48\", \"crashpad_tests\": \"0819e05e8ebfbb2a812052c75a5c4bf5955b24b0\", \"crypto_unittests\": \"46ba08b4bdf9a80a9165d8436c539c5425904870\", \"dbus_unittests\": \"816845c0f68a5910bce830ee9da6a2a7d6f5d64d\", \"device_unittests\": \"c509cb4bc99733e10cd5113ee08fcc9028478cfb\", \"display_unittests\": \"3f9c472e0ca3964ef2605dd92f69dfea6d3c48ae\", \"events_unittests\": \"5d49b2e80e79b179c4e24848a4ed69d10dc74075\", \"exo_unittests\": \"c3750ab047bd44f2b64d8c7c5bb47166519361e9\", \"extensions_browsertests\": \"c4f444027d36df10541c1c9b52d39a7f80b24a67\", \"extensions_unittests\": \"09e46f95119d7b4b93e2d157c4653811858c8f86\", \"filesystem_service_unittests\": \"02063e706a7699c772e7b0b4da880ce0c81b13d7\", \"gcm_unit_tests\": \"9b676814a807d100a2a2ba70789d629d7f984dab\", \"gfx_unittests\": \"d2d074100165681df9c13ff61198a4113dc5db12\", \"gin_unittests\": \"f04adfb3ada50c7f62f464d5f1ea3f7d8250a4fc\", \"gl_unittests_ozone\": \"faafee83572059ed8cab178a25926ba934620e3f\", \"google_apis_unittests\": \"1c3caa5d88c077a955762a4a39457eab05dadc92\", \"gpu_unittests\": \"872b88a392d42b7a20b39277eaa771018f4dd0e8\", \"gwp_asan_unittests\": \"180f122fa8e4a3fa477b22b8224c1d0888d20ec7\", \"interactive_ui_tests\": \"e777b111a34477d974522a7e49d7dbdcd60412bd\", \"ipc_tests\": \"61b99ebaf2225c8baceefe36a82e1600a6759cbe\", \"jingle_unittests\": \"80333e8012faf2ef63f70a502e2029fce3bf000c\", \"keyboard_unittests\": \"026adca8c6209c6d0127ac908476f0b985e9e33f\", \"latency_unittests\": \"5dad9b1857386f79cd4a94b1a503427f39060510\", \"libjingle_xmpp_unittests\": \"c7989e71bb3a1a235f58292aff571880b7ab3a0f\", \"liburlpattern_unittests\": \"8a2b7b26306443017420a1ce3a4c2bdc8e2cb408\", \"media_blink_unittests\": \"8c6b42565ce6b9131d58fb5e8c7d559af5863a9a\", \"media_unittests\": \"4a20e402f69f35806e37fdc13c7044c5617f350c\", \"message_center_unittests\": \"dc5a4129d1492521db23f383c9274b42fb798d45\", \"midi_unittests\": \"e145d20681fe717feb45612165b8115e93c8dc9f\", \"mojo_core_unittests\": \"0f9bd7ef088f7c5cfc7c3823f03d23f692b9e6ef\", \"mojo_unittests\": \"220e3e099e3f291a799fefe85d0bbec467790f5b\", \"nacl_helper_nonsfi_unittests\": \"186b74996c59fd42597021039ffc618546ff481d\", \"nacl_loader_unittests\": \"6f60488e27fc5b057cb0313e107be83228394aea\", \"native_theme_unittests\": \"677cdfef67c7afbe8c4ac74b27f3f879a6a68ded\", \"net_unittests\": \"5914f0bfccada0a155bee8a5d21404be8e11212b\", \"ozone_gl_unittests\": \"1868f6d75cc13dcfd06df6312023bb7a95791b0d\", \"ozone_unittests\": \"319aa16f7bf918974b2b178878983aeaad68f9b8\", \"ozone_x11_unittests\": \"7bf44fa46244dff9d45ce07e87a0b76dece9aed7\", \"pdf_unittests\": \"32af8f6198cb7b3afee24e3a7a2f2c0ec4717563\", \"perfetto_unittests\": \"56224527de75fe1adb7f3d9e74686cfa77a1ad06\", \"ppapi_unittests\": \"15fc1d46718d6e9ddf57e95ef41854805402cbfc\", \"printing_unittests\": \"cc562790802c0f030322fed3bad6d35f9f087cf3\", \"remoting_unittests\": \"155779f49756413e85cf56e3855d1342a938c1a3\", \"sandbox_linux_unittests\": \"b09923a382f7e5cb0eec0e9d78986a91a54a6cb7\", \"service_manager_unittests\": \"b42074f4b5d6a084a7656667af6dc4787a9bd777\", \"services_unittests\": \"f53740b280d4bd2e8d83b90da24f33e28b7cc1ab\", \"shell_dialogs_unittests\": \"a6093ca4803daae8aba95f19ead1c9c5b5d4b39e\", \"shell_encryption_unittests\": \"39782db45d39eca530b3f3fb193c33724eb005d4\", \"skia_unittests\": \"013c54cbcbacf0b37611e38dd0523a486a043031\", \"snapshot_unittests\": \"9d7fe79ffc9225ef8e80645e3e79ba0f0d58b19f\", \"sql_unittests\": \"3478b5c2560dc055c19005d667c88f57ad55bbdc\", \"storage_unittests\": \"3d03102533c4bdeb79a4172c1aa044a854b69cdb\", \"sync_integration_tests\": \"8b883d3e64e9a4e2fa77b282c76cb50ac864cfd5\", \"traffic_annotation_auditor_unittests\": \"d2604e342f960ae9382efd66a69627362c3ee13d\", \"ui_base_unittests\": \"6e90e2eaf6bf010a32e8065040fdfdeec3f637fa\", \"ui_chromeos_unittests\": \"6ba73455ef29dc4452b4b1cb1743b14cee6928c9\", \"ui_touch_selection_unittests\": \"b73822b501ba02f658bbbcad1639dd36415f7485\", \"unit_tests\": \"5883c67c19f018728e091a65d25eb3aac439225b\", \"url_unittests\": \"8613536c157e46d9de5779647609fd9ebc9ab3e9\", \"usage_time_limit_unittests\": \"b5768b563b26ea1f5149e5ac77d44f44bb942b25\", \"views_unittests\": \"e97efe715cf3c4ed024f502c02a8b1ae4809e700\", \"viz_unittests\": \"a5284bea3fe6c0c9e492d24bca3ca94354ffd392\", \"wm_unittests\": \"9e10f37e2c1b4888163a73bcf004ccec9c262fe2\", \"wtf_unittests\": \"5c7fa6bbefc4d761c51085cb75520c7d704c31f7\", \"zlib_unittests\": \"18311d48e5b178dc3febb794bf8524e6b1dd9dc4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_057d00cc9cf4bf141513fc3b802f5b4dacb7566e9fed03d4c1bbb1efa2ee2ffd_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_53152dde8708cc1c92dc2a2f2f0a881296f06b0680dba39a3a26c20421417c3e_v2\", \"builder_d6c402558de63915dde657133f192d995a5b729212ea1587a5d59fbce371e332_v2\", \"builder_e4464922e5c60bddfcc3d01cfc511ef7f4a711bded636fa98c66f03a573264ee_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-192-cztd\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"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\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- AutomationApiTest.TextareaAppendPerf\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610737732502920",
"status": "COMPLETED",
"status_changed_ts": "1610737732991038",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22217",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9e0bf445f0cad42dd69989ad09493130e27c9eac",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9e0bf445f0cad42dd69989ad09493130e27c9eac",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023442948504006368",
"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/8858012884127973392/+/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:512043791d054a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610743495986310",
"url": "https://ci.chromium.org/b/8858012884127973392",
"utcnow_ts": "1610743496472044"
}
}
[20:44:56.481] Invocation finished in 1h37m39.818843183s with status FAILED