[18:43:48.776] New invocation is queued and will start shortly
[18:43:49.897] Starting the invocation (attempt 1)
[18:43:49.941] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:43:49.941] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:43:49.941] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019186367376747840",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d4bff0cfbf80231bba95d1a976b6192811283d4e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019186367376747840",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/d4bff0cfbf80231bba95d1a976b6192811283d4e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d4bff0cfbf80231bba95d1a976b6192811283d4e",
"gitiles_ref:refs/heads/master"
]
}
[18:43:50.630] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614797030035963",
"id": "8853756305392774688",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d4bff0cfbf80231bba95d1a976b6192811283d4e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614797030453074",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22850",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d4bff0cfbf80231bba95d1a976b6192811283d4e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d4bff0cfbf80231bba95d1a976b6192811283d4e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019186367376747840",
"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/8853756305392774688/+/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": "1614797030453254",
"url": "https://ci.chromium.org/b/8853756305392774688",
"utcnow_ts": "1614797030624243"
}
}
[18:43:50.630] Task URL: https://ci.chromium.org/b/8853756305392774688
[18:43:50.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:2:0) after 1m0s
[18:44:50.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:2:0)
[18:44:50.687] Timer tick, asking Buildbucket for the build status
[18:44:50.763] Build 8853756305392774688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:44:50.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:3:0) after 1m0s
[18:45:50.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:3:0)
[18:45:50.888] Timer tick, asking Buildbucket for the build status
[18:45:51.065] Build 8853756305392774688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:45:51.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:4:0) after 1m0s
[18:46:51.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:4:0)
[18:46:51.226] Timer tick, asking Buildbucket for the build status
[18:46:51.346] Build 8853756305392774688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:46:51.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:5:0) after 1m0s
[18:47:07.960] Received PubSub notification, asking Buildbucket for the build status
[18:47:08.487] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:51.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:5:0)
[18:47:51.420] Timer tick, asking Buildbucket for the build status
[18:47:51.493] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:51.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:7:0) after 1m0s
[18:48:51.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:7:0)
[18:48:51.580] Timer tick, asking Buildbucket for the build status
[18:48:51.712] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:51.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:8:0) after 1m0s
[18:49:51.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:8:0)
[18:49:51.832] Timer tick, asking Buildbucket for the build status
[18:49:51.899] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:51.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:9:0) after 1m0s
[18:50:51.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:9:0)
[18:50:51.977] Timer tick, asking Buildbucket for the build status
[18:50:52.261] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:52.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:10:0) after 1m0s
[18:51:52.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:10:0)
[18:51:52.495] Timer tick, asking Buildbucket for the build status
[18:51:52.560] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:52.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:11:0) after 1m0s
[18:52:52.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:11:0)
[18:52:52.686] Timer tick, asking Buildbucket for the build status
[18:52:52.754] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:52.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:12:0) after 1m0s
[18:53:52.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:12:0)
[18:53:52.822] Timer tick, asking Buildbucket for the build status
[18:53:53.021] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:53.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:13:0) after 1m0s
[18:54:53.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:13:0)
[18:54:53.195] Timer tick, asking Buildbucket for the build status
[18:54:53.347] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:53.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:14:0) after 1m0s
[18:55:53.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:14:0)
[18:55:53.415] Timer tick, asking Buildbucket for the build status
[18:55:53.623] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:53.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:15:0) after 1m0s
[18:56:53.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:15:0)
[18:56:53.717] Timer tick, asking Buildbucket for the build status
[18:56:53.780] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:53.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:16:0) after 1m0s
[18:57:53.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:16:0)
[18:57:53.840] Timer tick, asking Buildbucket for the build status
[18:57:53.945] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:53.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:17:0) after 1m0s
[18:58:53.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:17:0)
[18:58:53.975] Timer tick, asking Buildbucket for the build status
[18:58:54.082] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:54.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:18:0) after 1m0s
[18:59:54.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:18:0)
[18:59:54.209] Timer tick, asking Buildbucket for the build status
[18:59:54.279] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:54.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:19:0) after 1m0s
[19:00:54.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:19:0)
[19:00:54.402] Timer tick, asking Buildbucket for the build status
[19:00:54.576] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:54.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:20:0) after 1m0s
[19:01:54.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:20:0)
[19:01:54.622] Timer tick, asking Buildbucket for the build status
[19:01:54.745] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:54.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:21:0) after 1m0s
[19:02:54.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:21:0)
[19:02:54.913] Timer tick, asking Buildbucket for the build status
[19:02:55.040] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:55.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:22:0) after 1m0s
[19:03:55.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:22:0)
[19:03:55.278] Timer tick, asking Buildbucket for the build status
[19:03:55.364] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:55.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:23:0) after 1m0s
[19:04:56.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:23:0)
[19:04:56.653] Timer tick, asking Buildbucket for the build status
[19:04:56.754] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:56.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:24:0) after 1m0s
[19:05:57.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:24:0)
[19:05:57.961] Timer tick, asking Buildbucket for the build status
[19:05:58.174] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:58.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:25:0) after 1m0s
[19:06:59.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:25:0)
[19:06:59.094] Timer tick, asking Buildbucket for the build status
[19:06:59.651] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:59.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:26:0) after 1m0s
[19:07:59.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:26:0)
[19:07:59.702] Timer tick, asking Buildbucket for the build status
[19:07:59.976] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:59.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:27:0) after 1m0s
[19:09:00.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:27:0)
[19:09:00.071] Timer tick, asking Buildbucket for the build status
[19:09:00.392] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:00.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:28:0) after 1m0s
[19:10:00.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:28:0)
[19:10:00.812] Timer tick, asking Buildbucket for the build status
[19:10:00.904] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:00.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:29:0) after 1m0s
[19:11:00.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:29:0)
[19:11:00.960] Timer tick, asking Buildbucket for the build status
[19:11:01.133] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:01.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:30:0) after 1m0s
[19:12:01.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:30:0)
[19:12:01.163] Timer tick, asking Buildbucket for the build status
[19:12:01.294] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:01.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:31:0) after 1m0s
[19:13:01.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:31:0)
[19:13:01.812] Timer tick, asking Buildbucket for the build status
[19:13:02.114] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:02.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:32:0) after 1m0s
[19:14:02.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:32:0)
[19:14:02.131] Timer tick, asking Buildbucket for the build status
[19:14:02.297] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:02.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:33:0) after 1m0s
[19:15:02.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:33:0)
[19:15:02.317] Timer tick, asking Buildbucket for the build status
[19:15:02.629] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:02.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:34:0) after 1m0s
[19:16:02.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:34:0)
[19:16:02.667] Timer tick, asking Buildbucket for the build status
[19:16:02.899] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:02.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:35:0) after 1m0s
[19:17:02.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:35:0)
[19:17:02.916] Timer tick, asking Buildbucket for the build status
[19:17:02.988] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:02.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:36:0) after 1m0s
[19:18:03.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:36:0)
[19:18:03.139] Timer tick, asking Buildbucket for the build status
[19:18:03.382] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:03.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:37:0) after 1m0s
[19:19:03.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:37:0)
[19:19:03.402] Timer tick, asking Buildbucket for the build status
[19:19:03.681] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:03.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:38:0) after 1m0s
[19:20:03.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:38:0)
[19:20:03.986] Timer tick, asking Buildbucket for the build status
[19:20:04.258] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:04.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:39:0) after 1m0s
[19:21:04.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:39:0)
[19:21:04.384] Timer tick, asking Buildbucket for the build status
[19:21:04.535] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:04.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:40:0) after 1m0s
[19:22:04.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:40:0)
[19:22:04.980] Timer tick, asking Buildbucket for the build status
[19:22:05.121] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:05.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:41:0) after 1m0s
[19:23:05.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:41:0)
[19:23:05.335] Timer tick, asking Buildbucket for the build status
[19:23:05.748] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:05.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:42:0) after 1m0s
[19:24:05.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:42:0)
[19:24:05.897] Timer tick, asking Buildbucket for the build status
[19:24:06.159] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:06.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:43:0) after 1m0s
[19:25:06.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:43:0)
[19:25:06.173] Timer tick, asking Buildbucket for the build status
[19:25:06.459] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:06.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:44:0) after 1m0s
[19:26:06.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:44:0)
[19:26:06.536] Timer tick, asking Buildbucket for the build status
[19:26:06.593] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:06.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:45:0) after 1m0s
[19:27:06.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:45:0)
[19:27:06.612] Timer tick, asking Buildbucket for the build status
[19:27:06.735] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:06.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:46:0) after 1m0s
[19:28:06.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:46:0)
[19:28:06.832] Timer tick, asking Buildbucket for the build status
[19:28:07.847] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:07.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:47:0) after 1m0s
[19:29:07.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:47:0)
[19:29:07.934] Timer tick, asking Buildbucket for the build status
[19:29:08.175] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:08.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:48:0) after 1m0s
[19:30:08.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:48:0)
[19:30:08.226] Timer tick, asking Buildbucket for the build status
[19:30:08.698] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:08.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:49:0) after 1m0s
[19:31:08.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:49:0)
[19:31:08.753] Timer tick, asking Buildbucket for the build status
[19:31:08.827] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:08.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:50:0) after 1m0s
[19:32:08.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:50:0)
[19:32:08.945] Timer tick, asking Buildbucket for the build status
[19:32:09.071] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:09.071] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:51:0) after 1m0s
[19:33:09.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:51:0)
[19:33:09.119] Timer tick, asking Buildbucket for the build status
[19:33:09.203] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:09.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:52:0) after 1m0s
[19:34:09.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:52:0)
[19:34:09.581] Timer tick, asking Buildbucket for the build status
[19:34:09.718] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:09.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:53:0) after 1m0s
[19:35:10.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:53:0)
[19:35:10.093] Timer tick, asking Buildbucket for the build status
[19:35:10.225] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:10.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:54:0) after 1m0s
[19:36:10.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:54:0)
[19:36:10.421] Timer tick, asking Buildbucket for the build status
[19:36:10.532] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:10.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:55:0) after 1m0s
[19:37:10.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:55:0)
[19:37:10.823] Timer tick, asking Buildbucket for the build status
[19:37:11.424] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:11.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:56:0) after 1m0s
[19:38:11.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:56:0)
[19:38:11.590] Timer tick, asking Buildbucket for the build status
[19:38:11.705] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:11.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:57:0) after 1m0s
[19:39:11.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:57:0)
[19:39:11.859] Timer tick, asking Buildbucket for the build status
[19:39:12.246] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:12.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:58:0) after 1m0s
[19:40:12.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:58:0)
[19:40:12.279] Timer tick, asking Buildbucket for the build status
[19:40:12.387] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:12.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:59:0) after 1m0s
[19:41:12.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:59:0)
[19:41:12.438] Timer tick, asking Buildbucket for the build status
[19:41:12.537] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:12.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:60:0) after 1m0s
[19:42:12.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:60:0)
[19:42:12.606] Timer tick, asking Buildbucket for the build status
[19:42:12.682] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:12.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:61:0) after 1m0s
[19:43:12.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:61:0)
[19:43:12.760] Timer tick, asking Buildbucket for the build status
[19:43:12.931] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:12.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:62:0) after 1m0s
[19:44:12.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:62:0)
[19:44:12.951] Timer tick, asking Buildbucket for the build status
[19:44:13.050] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:13.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:63:0) after 1m0s
[19:45:13.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:63:0)
[19:45:13.159] Timer tick, asking Buildbucket for the build status
[19:45:13.270] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:13.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:64:0) after 1m0s
[19:46:13.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:64:0)
[19:46:13.309] Timer tick, asking Buildbucket for the build status
[19:46:13.543] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:13.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:65:0) after 1m0s
[19:47:13.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:65:0)
[19:47:13.613] Timer tick, asking Buildbucket for the build status
[19:47:13.701] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:13.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:66:0) after 1m0s
[19:48:13.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:66:0)
[19:48:13.754] Timer tick, asking Buildbucket for the build status
[19:48:14.281] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:14.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:67:0) after 1m0s
[19:49:14.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:67:0)
[19:49:14.269] Timer tick, asking Buildbucket for the build status
[19:49:14.372] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:14.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:68:0) after 1m0s
[19:50:14.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:68:0)
[19:50:14.478] Timer tick, asking Buildbucket for the build status
[19:50:15.428] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:15.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:69:0) after 1m0s
[19:51:15.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:69:0)
[19:51:15.494] Timer tick, asking Buildbucket for the build status
[19:51:15.943] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:15.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:70:0) after 1m0s
[19:52:15.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:70:0)
[19:52:15.964] Timer tick, asking Buildbucket for the build status
[19:52:16.401] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:16.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:71:0) after 1m0s
[19:53:16.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:71:0)
[19:53:16.426] Timer tick, asking Buildbucket for the build status
[19:53:16.647] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:16.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:72:0) after 1m0s
[19:54:16.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:72:0)
[19:54:16.676] Timer tick, asking Buildbucket for the build status
[19:54:16.849] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:16.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:73:0) after 1m0s
[19:55:16.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:73:0)
[19:55:16.893] Timer tick, asking Buildbucket for the build status
[19:55:17.401] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:17.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:74:0) after 1m0s
[19:56:17.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:74:0)
[19:56:17.470] Timer tick, asking Buildbucket for the build status
[19:56:17.986] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:17.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:75:0) after 1m0s
[19:57:17.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:75:0)
[19:57:17.964] Timer tick, asking Buildbucket for the build status
[19:57:18.044] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:18.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:76:0) after 1m0s
[19:58:18.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:76:0)
[19:58:18.140] Timer tick, asking Buildbucket for the build status
[19:58:18.218] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:18.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:77:0) after 1m0s
[19:59:18.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:77:0)
[19:59:18.297] Timer tick, asking Buildbucket for the build status
[19:59:18.426] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:18.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:78:0) after 1m0s
[20:00:18.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:78:0)
[20:00:18.777] Timer tick, asking Buildbucket for the build status
[20:00:18.863] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:18.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:79:0) after 1m0s
[20:01:19.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:79:0)
[20:01:19.215] Timer tick, asking Buildbucket for the build status
[20:01:19.359] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:19.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:80:0) after 1m0s
[20:02:19.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:80:0)
[20:02:19.815] Timer tick, asking Buildbucket for the build status
[20:02:19.927] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:19.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:81:0) after 1m0s
[20:03:20.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:81:0)
[20:03:20.403] Timer tick, asking Buildbucket for the build status
[20:03:20.485] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:20.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:82:0) after 1m0s
[20:04:20.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:82:0)
[20:04:20.580] Timer tick, asking Buildbucket for the build status
[20:04:20.940] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:20.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:83:0) after 1m0s
[20:05:21.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:83:0)
[20:05:21.009] Timer tick, asking Buildbucket for the build status
[20:05:21.086] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:21.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:84:0) after 1m0s
[20:06:21.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:84:0)
[20:06:21.105] Timer tick, asking Buildbucket for the build status
[20:06:21.668] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:21.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:85:0) after 1m0s
[20:07:21.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:85:0)
[20:07:21.730] Timer tick, asking Buildbucket for the build status
[20:07:21.820] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:21.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:86:0) after 1m0s
[20:08:21.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:86:0)
[20:08:21.827] Timer tick, asking Buildbucket for the build status
[20:08:21.919] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:21.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:87:0) after 1m0s
[20:09:22.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:87:0)
[20:09:22.010] Timer tick, asking Buildbucket for the build status
[20:09:22.164] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:22.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:88:0) after 1m0s
[20:10:22.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:88:0)
[20:10:22.182] Timer tick, asking Buildbucket for the build status
[20:10:22.297] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:22.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:89:0) after 1m0s
[20:11:22.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:89:0)
[20:11:22.327] Timer tick, asking Buildbucket for the build status
[20:11:22.563] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:22.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:90:0) after 1m0s
[20:12:22.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:90:0)
[20:12:22.654] Timer tick, asking Buildbucket for the build status
[20:12:23.093] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:23.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:91:0) after 1m0s
[20:13:23.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:91:0)
[20:13:23.370] Timer tick, asking Buildbucket for the build status
[20:13:23.500] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:23.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:92:0) after 1m0s
[20:14:23.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:92:0)
[20:14:23.651] Timer tick, asking Buildbucket for the build status
[20:14:24.409] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:24.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:93:0) after 1m0s
[20:15:24.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:93:0)
[20:15:24.685] Timer tick, asking Buildbucket for the build status
[20:15:25.416] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:25.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:94:0) after 1m0s
[20:16:25.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:94:0)
[20:16:25.489] Timer tick, asking Buildbucket for the build status
[20:16:26.269] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:26.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:95:0) after 1m0s
[20:17:26.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:95:0)
[20:17:26.495] Timer tick, asking Buildbucket for the build status
[20:17:26.623] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:26.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:96:0) after 1m0s
[20:18:26.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:96:0)
[20:18:26.705] Timer tick, asking Buildbucket for the build status
[20:18:26.801] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:26.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:97:0) after 1m0s
[20:19:26.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:97:0)
[20:19:26.822] Timer tick, asking Buildbucket for the build status
[20:19:26.900] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:26.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:98:0) after 1m0s
[20:20:26.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:98:0)
[20:20:26.917] Timer tick, asking Buildbucket for the build status
[20:20:27.063] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:27.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:99:0) after 1m0s
[20:21:27.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:99:0)
[20:21:27.109] Timer tick, asking Buildbucket for the build status
[20:21:27.193] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:27.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:100:0) after 1m0s
[20:22:27.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:100:0)
[20:22:27.269] Timer tick, asking Buildbucket for the build status
[20:22:27.354] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:27.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:101:0) after 1m0s
[20:23:27.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:101:0)
[20:23:27.377] Timer tick, asking Buildbucket for the build status
[20:23:27.470] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:27.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:102:0) after 1m0s
[20:24:27.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:102:0)
[20:24:27.502] Timer tick, asking Buildbucket for the build status
[20:24:27.625] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:27.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:103:0) after 1m0s
[20:25:27.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:103:0)
[20:25:27.727] Timer tick, asking Buildbucket for the build status
[20:25:27.920] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:27.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:104:0) after 1m0s
[20:26:27.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:104:0)
[20:26:27.938] Timer tick, asking Buildbucket for the build status
[20:26:28.032] Build 8853756305392774688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:28.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019186367376747840:105:0) after 1m0s
[20:27:13.986] Received PubSub notification, asking Buildbucket for the build status
[20:27:14.200] Build 8853756305392774688: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:27:14.200] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614803233650292",
"created_by": "project:chromium",
"created_ts": "1614797030035963",
"failure_reason": "BUILD_FAILURE",
"id": "8853756305392774688",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d4bff0cfbf80231bba95d1a976b6192811283d4e\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- All/AppLaunchHandlerSystemWebAppsBrowserTest.LaunchSWA/_Default\"}, \"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\": \"d4bff0cfbf80231bba95d1a976b6192811283d4e\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-43-612k\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22850, \"got_angle_revision\": \"1de8b5a697e731c03083bda16b2df67c1d7a4c47\", \"got_dawn_revision\": \"9b5f442c78cb642b18bc4f18ab672f1b4426c934\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"d4bff0cfbf80231bba95d1a976b6192811283d4e\", \"got_revision_cp\": \"refs/heads/master@{#859464}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"1bf9a25b8165c205ba4ed305e8e84bc4a8e54fbc\", \"got_v8_revision_cp\": \"refs/heads/9.1.31@{#1}\", \"got_webrtc_revision\": \"07d83c8a9af02a0afc473503f75f150f23e3e0ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33366}\", \"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\": \"d4bff0cfbf80231bba95d1a976b6192811283d4e\", \"swarm_hashes_refs/heads/master(at){#859464}_without_patch\": {\"absl_hardening_tests\": \"20d2acaba2694a189ff196306faf8cb291124ab3\", \"accessibility_unittests\": \"c4131cd3edc954e9c4a06b0e9714d734e327a2c4\", \"angle_unittests\": \"6e6a565230975867b056a55bb968dfd24a88c8de\", \"app_list_unittests\": \"95d336285f66bc4c7f91490e14e67b2fbcaf4f23\", \"app_shell_unittests\": \"bc57c59fef0712dc4ff9fc0814f8e30838839e81\", \"ash_unittests\": \"95f77d6b4ff57dc39ce92832427fa4a87c7f9c95\", \"aura_unittests\": \"bdfbbcd38a19ac224f41bc19e23e923f34f58e76\", \"base_unittests\": \"323797dddf6d7fd9912c8c5c22b33ff50d331170\", \"base_util_unittests\": \"dc065db5907fb3cdfb50a626dae20d2e71ac9d96\", \"blink_common_unittests\": \"1a2088ed163d4d278ac25d487304f26f76bcb622\", \"blink_fuzzer_unittests\": \"47d9a262cc93e39e61f8e323427f137cab49f476\", \"blink_heap_unittests\": \"e7302c4de33f31260d762168250175b5d3ff9a3a\", \"blink_platform_unittests\": \"9a9350833f9466c9b49be6e6f06566755d976454\", \"blink_unittests\": \"e449539f9a848651b62aefac58f6cd6c5cf0a0d9\", \"boringssl_crypto_tests\": \"a1e5a92fe29eda8a6c4038b777a852c9da158b68\", \"boringssl_ssl_tests\": \"54b931b3549d4e237ae8ef27ddee90872ab4d3f7\", \"browser_tests\": \"035a70e313c7e3f4d458588d418a36e01c1e9d91\", \"capture_unittests\": \"5ba8eb6c6cb32c6178515a46f11e44dd61fe05ac\", \"cast_unittests\": \"df9a9ed8fedec8f4b23c34fdd9b47a491499d881\", \"cc_unittests\": \"4860c087496ae9e44b175886c879565def063fc2\", \"chrome_app_unittests\": \"5d97e54a3ce236c5de3e9b4fbda80705a0c7ec7c\", \"chromedriver_unittests\": \"67dc49f4003bfb48b9fa2f7e53feb38dd10a55cf\", \"chromeos_components_unittests\": \"5525fba005c750f79701c84751eae5cbf3de6fdf\", \"chromeos_unittests\": \"fd9d724f29dea631a266dcfc5279f326cd0f2acf\", \"color_unittests\": \"6af025d6417d277d519004af5516bf185b72abdf\", \"components_browsertests\": \"bafb396c102cc05a838b9e526ca1fd007de80481\", \"components_unittests\": \"c34b512ce0db5ac5d4309a00824c97611209dbb8\", \"compositor_unittests\": \"d241e1429ea7ee992bf51a91eb2d8db9dd9f749c\", \"content_browsertests\": \"2d290629b93044de2dc15bcdd433c839efb39129\", \"content_unittests\": \"ca9c45dc710291ba688b1592b0c778dea3d5c5a6\", \"crashpad_tests\": \"68c34b47a950babe7996d795020471bb2fa69038\", \"crypto_unittests\": \"122ac3c814444a2a98cd01dc9e9fc897cb285044\", \"dbus_unittests\": \"9a5835f87e25042625c63ab45f21eb7e6dc081bc\", \"device_unittests\": \"e6077c766812d58773623a0a912b10603a93345d\", \"display_unittests\": \"029857b5e27440435610c306128ed0b89c2d323c\", \"events_unittests\": \"eb805b19e36c1b9b1c0595a4491cdedddda02815\", \"exo_unittests\": \"187b868b593449cfb028028cf7fe4a657b1a5fa4\", \"extensions_browsertests\": \"6fa68f3df3f541b9555bfdf60d0a039ce84ef0cd\", \"extensions_unittests\": \"f157f34c8c1d00e7e1e3353ec7ce5f175f7b2ec7\", \"filesystem_service_unittests\": \"7d67a4c8209cc83e04d82419e855a7f0a14599a4\", \"gcm_unit_tests\": \"9ca3b00add7fdbab127096351c1cfec2de7fee3b\", \"gfx_unittests\": \"6ea9afe72f039cc4e62d24802509198d2da16e6d\", \"gin_unittests\": \"b024e41b3bb26e3cfaea67ebdfa0382c8da1d0ca\", \"gl_unittests_ozone\": \"59ceeea388fc325d4f0e9350c9e3b2be26b54618\", \"google_apis_unittests\": \"d5dbc8745433a4b694da1f0d616f6a5ba40e4e9b\", \"gpu_unittests\": \"099b95c41982e20ed6dc963cc14e67d43af25d4e\", \"gwp_asan_unittests\": \"79d822dbc62570fe540a14bedb8ff23a5ebd5a50\", \"interactive_ui_tests\": \"2c6f93a47fe7775f39520809143f1db3403b207f\", \"ipc_tests\": \"26723a4a4912466120d748c494020458b80c681c\", \"jingle_unittests\": \"bd2fff2941fc421c75cd93e0bd13d22abf77b7b5\", \"keyboard_unittests\": \"a2554b8c61b67088642dacf83601af2fa96b99b2\", \"latency_unittests\": \"ab70bb2eb63853114cb713aaea01c54edb614cee\", \"libjingle_xmpp_unittests\": \"050a56e4ee030e92b5237d6e13b6c656ad7779f4\", \"liburlpattern_unittests\": \"71bbd75b5de503e19574daf702a06ff5df05708d\", \"media_blink_unittests\": \"b5bb9e17db390006f85d44da37435316ad58080d\", \"media_unittests\": \"edddeef8577742045fa68f835877e25791f10fec\", \"message_center_unittests\": \"77fa4d55827bb06fef20693a24df7b1173923a83\", \"midi_unittests\": \"dabaaea62e57c8278e078e3083f8771c03fff050\", \"mojo_core_unittests\": \"17f8da57a5073c4e0398004efcd434e261c4ccc6\", \"mojo_unittests\": \"4f88b01b153febec79b58bfa538c0be5576a78b0\", \"nacl_helper_nonsfi_unittests\": \"8e03e4b84da8a660c27710141f92b110061a3fe3\", \"nacl_loader_unittests\": \"2af7d371de40202bdbab4680502327488142d24d\", \"native_theme_unittests\": \"e454aee9348742f597b9417425f06de3d88fcd8a\", \"net_unittests\": \"3fd780c33faf5376555ff9b6fc276842b2c6feae\", \"ozone_gl_unittests\": \"ad0051744931b7a7d7b6af592e5604026c1c222a\", \"ozone_unittests\": \"0b41e89d8072e90b28736610bcef73ce18834cfe\", \"ozone_x11_unittests\": \"61d42d3152b21a08ea62604bd4bed3c1fbcabf29\", \"pdf_unittests\": \"118b75c1b99bee2edae02adc7c76288a90ce8ac7\", \"perfetto_unittests\": \"edd0ba4ddaf5414608d99bada8ff513a4fe353c4\", \"ppapi_unittests\": \"1954f1dc5fe86205c9e566b9f67f7b15d0ddeef5\", \"printing_unittests\": \"c2c9e7435e3fb1c7e2f25572c2377befae2a3f7c\", \"remoting_unittests\": \"89a2998fd19d668a907732cfbd216e3f54f84949\", \"sandbox_linux_unittests\": \"46d9a1207c32aae432e1817f73cd21e37c9cf33f\", \"service_manager_unittests\": \"eb4ccf3f84f7d05208b5e023f92badf513245645\", \"services_unittests\": \"27eba30dbb829f5bb5859610507f44341dcae3af\", \"shell_dialogs_unittests\": \"97f9569c6945a02db46a00d88c3af77b43d317af\", \"shell_encryption_unittests\": \"35919f27616929bcca2d95d8d9ad4171d1d84c8f\", \"skia_unittests\": \"e6a1af643c6817939becb06d590816e40289a98c\", \"snapshot_unittests\": \"32de6c0649ffae60775f4303abb4f207a728561b\", \"sql_unittests\": \"40bf8fec4d92151a88a2f44f4643498009adf959\", \"storage_unittests\": \"e4c18d284f91e1e8ddb17cd407fb08070a75ea38\", \"sync_integration_tests\": \"35371bd0ef12b0a33134d68a68699175cad0f43e\", \"traffic_annotation_auditor_unittests\": \"9b4a3d439423a09eb0243f58ffed23dacbcc914f\", \"ui_base_unittests\": \"4053bfeed894f2d3f88a62c916a898f6f992d32e\", \"ui_chromeos_unittests\": \"7c9a28675f2173aedadeae15ada4f3944a05bda0\", \"ui_touch_selection_unittests\": \"c7a593d4314e0eec0e51db1286ec1ef621a28990\", \"unit_tests\": \"05e2ffd7e7b3dbd1323203f2904efc39c892b7a6\", \"url_unittests\": \"e2a055ccbb1d7ef545253c9935ad1bd9f5ee2e60\", \"usage_time_limit_unittests\": \"d33f93cb8aa36bb5c09382a72e8012bce734ba5d\", \"views_unittests\": \"c069a9c74e6fb8d8b0e9213ca0e7e8736a4fdfb5\", \"viz_unittests\": \"a31337dc47e3440d18b1daed90d8ea5990bfbcf0\", \"wayland_client_tests\": \"e57df9c74b778a35cfe4929c2a9636ef152af3e7\", \"wm_unittests\": \"81e0ff0944a76d53b231b7cae526c3f9e91b5d38\", \"wtf_unittests\": \"6ed70dfc232c14d357ba27bd5daccd606ec86cb0\", \"zlib_unittests\": \"05bce34ff055820ec1a600725989207dbb705805\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02b94346fc981ed3c3847ac0524bcc084571ef426302b2a255781857b227612a_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_8083860191ac1707bdac6310382d6ca226876fc8f88202f45d8d07453f74f5a4_v2\", \"builder_a2d0deb167035deb42f2d46ec8df60bd17682f54960fd7d9f79bcb4fddee3411_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-43-612k\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- All/AppLaunchHandlerSystemWebAppsBrowserTest.LaunchSWA/_Default\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614797226207339",
"status": "COMPLETED",
"status_changed_ts": "1614797227663851",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22850",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d4bff0cfbf80231bba95d1a976b6192811283d4e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d4bff0cfbf80231bba95d1a976b6192811283d4e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019186367376747840",
"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/8853756305392774688/+/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:521238cd8cb51b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614803233650651",
"url": "https://ci.chromium.org/b/8853756305392774688",
"utcnow_ts": "1614803234179656"
}
}
[20:27:14.200] Invocation finished in 1h43m25.441113975s with status FAILED