[01:50:24.512] New invocation is queued and will start shortly
[01:50:25.648] Starting the invocation (attempt 1)
[01:50:25.691] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:50:25.691] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:50:25.691] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9064548608471535312",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1bd1b58ee30c1c3df257f5cb89b675ff0f9889b1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9064548608471535312",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/1bd1b58ee30c1c3df257f5cb89b675ff0f9889b1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1bd1b58ee30c1c3df257f5cb89b675ff0f9889b1",
"gitiles_ref:refs/heads/master"
]
}
[01:50:26.652] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1571536225940963",
"id": "8899118546307177456",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1bd1b58ee30c1c3df257f5cb89b675ff0f9889b1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1571536226488038",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/30405",
"builder:linux-chromeos-rel",
"buildset:commit/git/1bd1b58ee30c1c3df257f5cb89b675ff0f9889b1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1bd1b58ee30c1c3df257f5cb89b675ff0f9889b1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064548608471535312",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8899118546307177456/+/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": "1571536226488171",
"url": "https://ci.chromium.org/b/8899118546307177456",
"utcnow_ts": "1571536226644519"
}
}
[01:50:26.652] Task URL: https://ci.chromium.org/b/8899118546307177456
[01:50:26.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:2:0) after 1m0s
[01:50:55.123] Received PubSub notification, asking Buildbucket for the build status
[01:50:57.286] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:28.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:2:0)
[01:51:28.193] Timer tick, asking Buildbucket for the build status
[01:51:28.398] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:28.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:4:0) after 1m0s
[01:52:28.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:4:0)
[01:52:28.420] Timer tick, asking Buildbucket for the build status
[01:52:28.623] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:28.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:5:0) after 1m0s
[01:53:28.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:5:0)
[01:53:28.821] Timer tick, asking Buildbucket for the build status
[01:53:29.059] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:29.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:6:0) after 1m0s
[01:54:29.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:6:0)
[01:54:29.114] Timer tick, asking Buildbucket for the build status
[01:54:29.915] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:29.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:7:0) after 1m0s
[01:55:29.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:7:0)
[01:55:29.939] Timer tick, asking Buildbucket for the build status
[01:55:30.215] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:30.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:8:0) after 1m0s
[01:56:30.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:8:0)
[01:56:30.297] Timer tick, asking Buildbucket for the build status
[01:56:31.293] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:31.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:9:0) after 1m0s
[01:57:31.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:9:0)
[01:57:31.320] Timer tick, asking Buildbucket for the build status
[01:57:31.918] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:31.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:10:0) after 1m0s
[01:58:32.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:10:0)
[01:58:32.097] Timer tick, asking Buildbucket for the build status
[01:58:32.324] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:32.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:11:0) after 1m0s
[01:59:32.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:11:0)
[01:59:32.466] Timer tick, asking Buildbucket for the build status
[01:59:32.914] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:32.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:12:0) after 1m0s
[02:00:32.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:12:0)
[02:00:32.938] Timer tick, asking Buildbucket for the build status
[02:00:34.145] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:34.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:13:0) after 1m0s
[02:01:34.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:13:0)
[02:01:34.175] Timer tick, asking Buildbucket for the build status
[02:01:36.899] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:36.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:14:0) after 1m0s
[02:02:36.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:14:0)
[02:02:36.950] Timer tick, asking Buildbucket for the build status
[02:02:37.276] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:37.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:15:0) after 1m0s
[02:03:37.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:15:0)
[02:03:37.314] Timer tick, asking Buildbucket for the build status
[02:03:38.928] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:38.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:16:0) after 1m0s
[02:04:38.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:16:0)
[02:04:38.949] Timer tick, asking Buildbucket for the build status
[02:04:39.332] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:39.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:17:0) after 1m0s
[02:05:39.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:17:0)
[02:05:39.410] Timer tick, asking Buildbucket for the build status
[02:05:39.933] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:39.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:18:0) after 1m0s
[02:06:40.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:18:0)
[02:06:40.004] Timer tick, asking Buildbucket for the build status
[02:06:40.180] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:40.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:19:0) after 1m0s
[02:07:40.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:19:0)
[02:07:40.316] Timer tick, asking Buildbucket for the build status
[02:07:41.289] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:41.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:20:0) after 1m0s
[02:08:41.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:20:0)
[02:08:41.338] Timer tick, asking Buildbucket for the build status
[02:08:42.730] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:42.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:21:0) after 1m0s
[02:09:42.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:21:0)
[02:09:42.763] Timer tick, asking Buildbucket for the build status
[02:09:43.614] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:43.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:22:0) after 1m0s
[02:10:43.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:22:0)
[02:10:43.641] Timer tick, asking Buildbucket for the build status
[02:10:44.806] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:44.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:23:0) after 1m0s
[02:11:44.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:23:0)
[02:11:44.918] Timer tick, asking Buildbucket for the build status
[02:11:45.125] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:45.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:24:0) after 1m0s
[02:12:45.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:24:0)
[02:12:45.235] Timer tick, asking Buildbucket for the build status
[02:12:45.906] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:45.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:25:0) after 1m0s
[02:13:45.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:25:0)
[02:13:45.937] Timer tick, asking Buildbucket for the build status
[02:13:47.724] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:47.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:26:0) after 1m0s
[02:14:47.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:26:0)
[02:14:47.857] Timer tick, asking Buildbucket for the build status
[02:14:48.062] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:48.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:27:0) after 1m0s
[02:15:48.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:27:0)
[02:15:48.094] Timer tick, asking Buildbucket for the build status
[02:15:49.645] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:49.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:28:0) after 1m0s
[02:16:49.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:28:0)
[02:16:49.666] Timer tick, asking Buildbucket for the build status
[02:16:50.287] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:50.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:29:0) after 1m0s
[02:17:50.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:29:0)
[02:17:50.309] Timer tick, asking Buildbucket for the build status
[02:17:50.921] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:50.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:30:0) after 1m0s
[02:18:50.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:30:0)
[02:18:50.978] Timer tick, asking Buildbucket for the build status
[02:18:51.731] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:51.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:31:0) after 1m0s
[02:19:51.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:31:0)
[02:19:51.813] Timer tick, asking Buildbucket for the build status
[02:19:52.188] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:52.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:32:0) after 1m0s
[02:20:52.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:32:0)
[02:20:52.280] Timer tick, asking Buildbucket for the build status
[02:20:55.302] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:55.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:33:0) after 1m0s
[02:21:55.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:33:0)
[02:21:55.367] Timer tick, asking Buildbucket for the build status
[02:21:55.533] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:55.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:34:0) after 1m0s
[02:22:55.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:34:0)
[02:22:55.564] Timer tick, asking Buildbucket for the build status
[02:22:56.062] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:56.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:35:0) after 1m0s
[02:23:56.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:35:0)
[02:23:56.234] Timer tick, asking Buildbucket for the build status
[02:23:56.439] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:56.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:36:0) after 1m0s
[02:24:56.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:36:0)
[02:24:56.466] Timer tick, asking Buildbucket for the build status
[02:24:57.174] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:57.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:37:0) after 1m0s
[02:25:57.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:37:0)
[02:25:57.254] Timer tick, asking Buildbucket for the build status
[02:25:57.617] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:57.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:38:0) after 1m0s
[02:26:57.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:38:0)
[02:26:57.697] Timer tick, asking Buildbucket for the build status
[02:27:00.313] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:00.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:39:0) after 1m0s
[02:28:00.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:39:0)
[02:28:00.377] Timer tick, asking Buildbucket for the build status
[02:28:01.792] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:01.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:40:0) after 1m0s
[02:29:01.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:40:0)
[02:29:01.823] Timer tick, asking Buildbucket for the build status
[02:29:02.361] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:02.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:41:0) after 1m0s
[02:30:02.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:41:0)
[02:30:02.364] Timer tick, asking Buildbucket for the build status
[02:30:02.547] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:02.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:42:0) after 1m0s
[02:31:02.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:42:0)
[02:31:02.579] Timer tick, asking Buildbucket for the build status
[02:31:02.824] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:02.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:43:0) after 1m0s
[02:32:02.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:43:0)
[02:32:02.907] Timer tick, asking Buildbucket for the build status
[02:32:03.933] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:03.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:44:0) after 1m0s
[02:33:03.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:44:0)
[02:33:03.995] Timer tick, asking Buildbucket for the build status
[02:33:04.545] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:04.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:45:0) after 1m0s
[02:34:04.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:45:0)
[02:34:04.570] Timer tick, asking Buildbucket for the build status
[02:34:04.843] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:04.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:46:0) after 1m0s
[02:35:04.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:46:0)
[02:35:04.903] Timer tick, asking Buildbucket for the build status
[02:35:05.152] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:05.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:47:0) after 1m0s
[02:36:05.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:47:0)
[02:36:05.158] Timer tick, asking Buildbucket for the build status
[02:36:05.640] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:05.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:48:0) after 1m0s
[02:37:05.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:48:0)
[02:37:05.668] Timer tick, asking Buildbucket for the build status
[02:37:05.858] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:05.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:49:0) after 1m0s
[02:38:05.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:49:0)
[02:38:05.843] Timer tick, asking Buildbucket for the build status
[02:38:06.580] Build 8899118546307177456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:06.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9064548608471535312:50:0) after 1m0s
[02:38:32.092] Received PubSub notification, asking Buildbucket for the build status
[02:38:32.778] Build 8899118546307177456: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:38:32.778] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1571539110251225",
"created_by": "project:chromium",
"created_ts": "1571536225940963",
"failure_reason": "BUILD_FAILURE",
"id": "8899118546307177456",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1bd1b58ee30c1c3df257f5cb89b675ff0f9889b1\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**non_viz_content_browsertests** failed because of:\\n\\n- SignedExchangeRequestHandlerBrowserTest.VariantMatch/3\"}, \"properties\": {\"$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-77-d0b5\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 30405, \"got_angle_revision\": \"2bf23ea84e4f071c18f01b94748f3be7dccc4019\", \"got_dawn_revision\": \"8d000e0cc230663dbeae86f59aaa16fc91b1eac1\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"1bd1b58ee30c1c3df257f5cb89b675ff0f9889b1\", \"got_revision_cp\": \"refs/heads/master@{#707662}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"11e5ee3a8e919a0f6a3c518bf124952fe6995e18\", \"got_v8_revision_cp\": \"refs/heads/8.0.2@{#1}\", \"got_webrtc_revision\": \"3663ed3ad67893746efd86267a936a7295031ab1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29548}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1bd1b58ee30c1c3df257f5cb89b675ff0f9889b1\", \"swarm_hashes\": {\"accessibility_unittests\": \"4c031c1ebf14f2583a1a26bda033fbbeca2dc0b4\", \"angle_unittests\": \"e84747e82e4d7fcbd5dbe7be2d315131905faa55\", \"app_list_unittests\": \"aaf4f990d00b93de1906e922f69130ae4da102a8\", \"app_shell_unittests\": \"7f734c46121e5a00ccff6fc698ef0c7d8df46a64\", \"ash_unittests\": \"10a0fb865bd2ab12d1e031cfbb3d96b2cf616e6f\", \"aura_unittests\": \"a1e1c207b2b9dd352a88790be9bb8de2469dc316\", \"base_unittests\": \"7db5bc6698a2b39be8926d61c6be1bf18a238cff\", \"base_util_unittests\": \"1f5e206a982f854ed92de22a29620bf19dcbc458\", \"blink_common_unittests\": \"31bb64f72256f76e76e619eaea2f20a213539f55\", \"blink_fuzzer_unittests\": \"265eaf2c13906cd57819e147307ecede47676982\", \"blink_heap_unittests\": \"ef87c133db3bc9c4ca90fe0f3889b00776e63cf0\", \"blink_platform_unittests\": \"bdb29851df81fed772a198ea6b5ae0a6312b63a1\", \"blink_unittests\": \"b989072241ae2c8d267191753e5ec50a680c2255\", \"boringssl_crypto_tests\": \"c047fecde166769d3d496624899db0c2d3a32a09\", \"boringssl_ssl_tests\": \"5bd6577aff8bab9a5acb2e1e6eb545c7380e9eb2\", \"browser_tests\": \"18f705982329a12cc21d2a33d58ed79754734a5d\", \"cacheinvalidation_unittests\": \"24b999be6d5aa7a6e036433fba186ba4ba2c9d8c\", \"capture_unittests\": \"eaf3e2ef76189d95a49c63570877ffb11a7f6ec0\", \"cast_unittests\": \"882fba2bb7fce279a016b676d139e6e692a12c30\", \"cc_unittests\": \"76d2223187b406a4f842455b4afff9d7c94efd04\", \"chrome_app_unittests\": \"378beb5c9c75656b85801a34d6936e195597646b\", \"chromedriver_unittests\": \"17d4df4c1c87952a0ae75726aef0dc6ae099d52f\", \"chromeos_components_unittests\": \"c3cd52c6125aa4983854737f676bef6279b3129b\", \"chromeos_unittests\": \"a1f502329144e305133c7a7ce0560ef432301b04\", \"color_unittests\": \"ce3e6a133fb8cc0850fceb3b1c74d125ea56ba00\", \"components_browsertests\": \"dee7b813f5e7a5f9785fa56a668c0277f44c32b5\", \"components_unittests\": \"f6c3c8ac90711077de5a4a515a8c0e6b68c016af\", \"compositor_unittests\": \"ce842d4b6ba559da3df7cbd53f2b92b2a5f2effe\", \"content_browsertests\": \"a4c2d33fca9624440f6a674c69123142cb4b565f\", \"content_unittests\": \"ee14936769a6da2c098f18f48f52eea08ed4c9f4\", \"crypto_unittests\": \"681e53e388148bc43c96b20b1f89c1692b205aa4\", \"dbus_unittests\": \"e57ea0c95edcc194a7bc9db758056d3782f4d30e\", \"device_unittests\": \"29931e7f76aabb2ebc83d666b3db1e094ef0b970\", \"display_unittests\": \"006042bf04d3e498043f244f711c4f80a6e6c5e1\", \"events_unittests\": \"ba7e19dc3fc8c0e44e32c88f186b4bcd4d40545d\", \"exo_unittests\": \"53cc642e791e8a539cb277ab5bb617af32dfda5a\", \"extensions_browsertests\": \"2da41419b64dec306a0899f4f6586c976d88711a\", \"extensions_unittests\": \"bbb78e3394a7c896b8bb3996e6177a20fa63c325\", \"filesystem_service_unittests\": \"323fa9f7805c2f5ae20aa4ad1304085cc7baca96\", \"gcm_unit_tests\": \"8e8a35ef5264340438de7141027add5f6f4a14a6\", \"gfx_unittests\": \"4935553207381c0d95b03ccf049fe3d2bc052348\", \"gin_unittests\": \"606302aaeca88185efbcecac65eb3abcfa1adc34\", \"gl_unittests_ozone\": \"98d74621cf2e5c5eb3a659bc451d3179f2a1f11e\", \"google_apis_unittests\": \"5ff6938353102fc1bc8f3df9b33a756b76ccaf26\", \"gpu_unittests\": \"6cd23f014a2abf7c707953548f8403892d932d8f\", \"gwp_asan_unittests\": \"693d0a1116a428ba161efecf66baed0a3906845f\", \"interactive_ui_tests\": \"3ad252cf56f49bac9d2bd0d66ca6976b5193031c\", \"ipc_tests\": \"4af221b552e0c9410084ea8ac5329a1baf32bc43\", \"jingle_unittests\": \"28cb6c8c8cb308695eca163ad67464df48832233\", \"keyboard_unittests\": \"9eef47fb79e1d08a55e941310039c7124437cbd2\", \"latency_unittests\": \"fd6e37ece05fbb083ab89f955bbabb38a75b4565\", \"libjingle_xmpp_unittests\": \"ea676af3226f0f562d7e0928c6c9e1a0125d6152\", \"media_blink_unittests\": \"de64418746881488d5b3bf9d0a59f359ec5b610c\", \"media_service_unittests\": \"f9f23fdd6c66ca0d0b3dd5a5efa2bc29648a7ae3\", \"media_unittests\": \"39c37278b0dad8572cd3ad438894ab6ecd42e02b\", \"message_center_unittests\": \"dd21ebfa91056b5b622f0ef501efc9fee0a4764c\", \"midi_unittests\": \"995ef46b9e03991fc75f307817f5f360a6d64da2\", \"mojo_core_unittests\": \"5f8fe221019400ec5deec062a44bd199357aa21b\", \"mojo_unittests\": \"08598068490c2ccaab867e7a3d71e35c0468b1d8\", \"nacl_helper_nonsfi_unittests\": \"7276e5419599fc8bdeeee597e1d9ce7547880c7b\", \"nacl_loader_unittests\": \"ffe017a30586cf38aa877363626091cbc2b08942\", \"native_theme_unittests\": \"40f71699b28172d71433c640699e0bdc210c58ad\", \"net_unittests\": \"3ea28b73623cd6635fc41c9d8726cfcc044a1ed4\", \"ozone_gl_unittests\": \"3cff29c28be527cbb020ca60d0754ace0360521e\", \"ozone_unittests\": \"9f385fc6d5b9f2785f81657a5595d51c94b1d66c\", \"ozone_x11_unittests\": \"faf8a54555848775829477474f48a890493a8066\", \"pdf_unittests\": \"00a3d5b81440da5adbfa7b24aacd61d33b34d104\", \"perfetto_unittests\": \"40fb4aabd75f1f56f9b990589841a7f1a4dee26f\", \"ppapi_unittests\": \"23bbf38659dcabb94b30b5ef8d03d285505b24a1\", \"printing_unittests\": \"24e732c7ea77ee32d1499923a03963f045249fcb\", \"remoting_unittests\": \"692c7bd40e2590f6227f43ec58b7dd7fbf353f45\", \"sandbox_linux_unittests\": \"297120f6ec1afed5a3f86e89eefcbda4838126db\", \"service_manager_unittests\": \"3d32c0d89c329b3b1b1e4efce79b3c9aae35cf83\", \"services_unittests\": \"790b6f441afab144593e33d365f2f9c7f663551f\", \"shell_dialogs_unittests\": \"d56f2d6b065eb6626470cf5864aa41ade66cd9ff\", \"skia_unittests\": \"e036e5a70ec54b99d543fa28d2243aa4bf55ee9b\", \"snapshot_unittests\": \"8054b4452813176193d2b5e21913e27176834322\", \"sql_unittests\": \"feff1f73044dffd3ad41ee04bf776595bdef0c4a\", \"storage_unittests\": \"20a4f0bf34e54db1ed88d6f5589fce8f6f592d8f\", \"sync_integration_tests\": \"921677b524d62bfee6cba86a4feb9deacb1fdefc\", \"traffic_annotation_auditor_unittests\": \"00344a616c4f187aabc8ee7d44bf49da5ca07d87\", \"ui_base_unittests\": \"c8568ac976347bbb43a23f89d27a7e69c27ef2cd\", \"ui_chromeos_unittests\": \"8045af8269b9396a950f1ec6a26cc195d2d3f0d5\", \"ui_touch_selection_unittests\": \"bdd16dd7556e965eb05e102550ea2787caf0806f\", \"unit_tests\": \"deb1eb46dd53960537ca12dc31ba504b9930076f\", \"url_unittests\": \"6b3d7bbe88e612c63dec9317037da50cec7bc489\", \"usage_time_limit_unittests\": \"12e3fc72a3ec036d9b0a14910e6a083f8d2c7c90\", \"views_unittests\": \"9936f6bc987630dc64f492ceb30641407719e462\", \"viz_unittests\": \"2e65bec61a965ea0dc93f851f723360f78f5471e\", \"wayland_client_perftests\": \"1a0d5998e61c88dd499f15ba8face19ff0b67953\", \"wm_unittests\": \"9db3d6d6aa33fc15a6f05c1a0a4cb18c916c027f\", \"wtf_unittests\": \"d140b1c015b6016189fe187dda3740f6943f54eb\"}, \"swarm_hashes_refs/heads/master(at){#707662}_without_patch\": {\"accessibility_unittests\": \"4c031c1ebf14f2583a1a26bda033fbbeca2dc0b4\", \"angle_unittests\": \"e84747e82e4d7fcbd5dbe7be2d315131905faa55\", \"app_list_unittests\": \"aaf4f990d00b93de1906e922f69130ae4da102a8\", \"app_shell_unittests\": \"7f734c46121e5a00ccff6fc698ef0c7d8df46a64\", \"ash_unittests\": \"10a0fb865bd2ab12d1e031cfbb3d96b2cf616e6f\", \"aura_unittests\": \"a1e1c207b2b9dd352a88790be9bb8de2469dc316\", \"base_unittests\": \"7db5bc6698a2b39be8926d61c6be1bf18a238cff\", \"base_util_unittests\": \"1f5e206a982f854ed92de22a29620bf19dcbc458\", \"blink_common_unittests\": \"31bb64f72256f76e76e619eaea2f20a213539f55\", \"blink_fuzzer_unittests\": \"265eaf2c13906cd57819e147307ecede47676982\", \"blink_heap_unittests\": \"ef87c133db3bc9c4ca90fe0f3889b00776e63cf0\", \"blink_platform_unittests\": \"bdb29851df81fed772a198ea6b5ae0a6312b63a1\", \"blink_unittests\": \"b989072241ae2c8d267191753e5ec50a680c2255\", \"boringssl_crypto_tests\": \"c047fecde166769d3d496624899db0c2d3a32a09\", \"boringssl_ssl_tests\": \"5bd6577aff8bab9a5acb2e1e6eb545c7380e9eb2\", \"browser_tests\": \"18f705982329a12cc21d2a33d58ed79754734a5d\", \"cacheinvalidation_unittests\": \"24b999be6d5aa7a6e036433fba186ba4ba2c9d8c\", \"capture_unittests\": \"eaf3e2ef76189d95a49c63570877ffb11a7f6ec0\", \"cast_unittests\": \"882fba2bb7fce279a016b676d139e6e692a12c30\", \"cc_unittests\": \"76d2223187b406a4f842455b4afff9d7c94efd04\", \"chrome_app_unittests\": \"378beb5c9c75656b85801a34d6936e195597646b\", \"chromedriver_unittests\": \"17d4df4c1c87952a0ae75726aef0dc6ae099d52f\", \"chromeos_components_unittests\": \"c3cd52c6125aa4983854737f676bef6279b3129b\", \"chromeos_unittests\": \"a1f502329144e305133c7a7ce0560ef432301b04\", \"color_unittests\": \"ce3e6a133fb8cc0850fceb3b1c74d125ea56ba00\", \"components_browsertests\": \"dee7b813f5e7a5f9785fa56a668c0277f44c32b5\", \"components_unittests\": \"f6c3c8ac90711077de5a4a515a8c0e6b68c016af\", \"compositor_unittests\": \"ce842d4b6ba559da3df7cbd53f2b92b2a5f2effe\", \"content_browsertests\": \"a4c2d33fca9624440f6a674c69123142cb4b565f\", \"content_unittests\": \"ee14936769a6da2c098f18f48f52eea08ed4c9f4\", \"crypto_unittests\": \"681e53e388148bc43c96b20b1f89c1692b205aa4\", \"dbus_unittests\": \"e57ea0c95edcc194a7bc9db758056d3782f4d30e\", \"device_unittests\": \"29931e7f76aabb2ebc83d666b3db1e094ef0b970\", \"display_unittests\": \"006042bf04d3e498043f244f711c4f80a6e6c5e1\", \"events_unittests\": \"ba7e19dc3fc8c0e44e32c88f186b4bcd4d40545d\", \"exo_unittests\": \"53cc642e791e8a539cb277ab5bb617af32dfda5a\", \"extensions_browsertests\": \"2da41419b64dec306a0899f4f6586c976d88711a\", \"extensions_unittests\": \"bbb78e3394a7c896b8bb3996e6177a20fa63c325\", \"filesystem_service_unittests\": \"323fa9f7805c2f5ae20aa4ad1304085cc7baca96\", \"gcm_unit_tests\": \"8e8a35ef5264340438de7141027add5f6f4a14a6\", \"gfx_unittests\": \"4935553207381c0d95b03ccf049fe3d2bc052348\", \"gin_unittests\": \"606302aaeca88185efbcecac65eb3abcfa1adc34\", \"gl_unittests_ozone\": \"98d74621cf2e5c5eb3a659bc451d3179f2a1f11e\", \"google_apis_unittests\": \"5ff6938353102fc1bc8f3df9b33a756b76ccaf26\", \"gpu_unittests\": \"6cd23f014a2abf7c707953548f8403892d932d8f\", \"gwp_asan_unittests\": \"693d0a1116a428ba161efecf66baed0a3906845f\", \"interactive_ui_tests\": \"3ad252cf56f49bac9d2bd0d66ca6976b5193031c\", \"ipc_tests\": \"4af221b552e0c9410084ea8ac5329a1baf32bc43\", \"jingle_unittests\": \"28cb6c8c8cb308695eca163ad67464df48832233\", \"keyboard_unittests\": \"9eef47fb79e1d08a55e941310039c7124437cbd2\", \"latency_unittests\": \"fd6e37ece05fbb083ab89f955bbabb38a75b4565\", \"libjingle_xmpp_unittests\": \"ea676af3226f0f562d7e0928c6c9e1a0125d6152\", \"media_blink_unittests\": \"de64418746881488d5b3bf9d0a59f359ec5b610c\", \"media_service_unittests\": \"f9f23fdd6c66ca0d0b3dd5a5efa2bc29648a7ae3\", \"media_unittests\": \"39c37278b0dad8572cd3ad438894ab6ecd42e02b\", \"message_center_unittests\": \"dd21ebfa91056b5b622f0ef501efc9fee0a4764c\", \"midi_unittests\": \"995ef46b9e03991fc75f307817f5f360a6d64da2\", \"mojo_core_unittests\": \"5f8fe221019400ec5deec062a44bd199357aa21b\", \"mojo_unittests\": \"08598068490c2ccaab867e7a3d71e35c0468b1d8\", \"nacl_helper_nonsfi_unittests\": \"7276e5419599fc8bdeeee597e1d9ce7547880c7b\", \"nacl_loader_unittests\": \"ffe017a30586cf38aa877363626091cbc2b08942\", \"native_theme_unittests\": \"40f71699b28172d71433c640699e0bdc210c58ad\", \"net_unittests\": \"3ea28b73623cd6635fc41c9d8726cfcc044a1ed4\", \"ozone_gl_unittests\": \"3cff29c28be527cbb020ca60d0754ace0360521e\", \"ozone_unittests\": \"9f385fc6d5b9f2785f81657a5595d51c94b1d66c\", \"ozone_x11_unittests\": \"faf8a54555848775829477474f48a890493a8066\", \"pdf_unittests\": \"00a3d5b81440da5adbfa7b24aacd61d33b34d104\", \"perfetto_unittests\": \"40fb4aabd75f1f56f9b990589841a7f1a4dee26f\", \"ppapi_unittests\": \"23bbf38659dcabb94b30b5ef8d03d285505b24a1\", \"printing_unittests\": \"24e732c7ea77ee32d1499923a03963f045249fcb\", \"remoting_unittests\": \"692c7bd40e2590f6227f43ec58b7dd7fbf353f45\", \"sandbox_linux_unittests\": \"297120f6ec1afed5a3f86e89eefcbda4838126db\", \"service_manager_unittests\": \"3d32c0d89c329b3b1b1e4efce79b3c9aae35cf83\", \"services_unittests\": \"790b6f441afab144593e33d365f2f9c7f663551f\", \"shell_dialogs_unittests\": \"d56f2d6b065eb6626470cf5864aa41ade66cd9ff\", \"skia_unittests\": \"e036e5a70ec54b99d543fa28d2243aa4bf55ee9b\", \"snapshot_unittests\": \"8054b4452813176193d2b5e21913e27176834322\", \"sql_unittests\": \"feff1f73044dffd3ad41ee04bf776595bdef0c4a\", \"storage_unittests\": \"20a4f0bf34e54db1ed88d6f5589fce8f6f592d8f\", \"sync_integration_tests\": \"921677b524d62bfee6cba86a4feb9deacb1fdefc\", \"traffic_annotation_auditor_unittests\": \"00344a616c4f187aabc8ee7d44bf49da5ca07d87\", \"ui_base_unittests\": \"c8568ac976347bbb43a23f89d27a7e69c27ef2cd\", \"ui_chromeos_unittests\": \"8045af8269b9396a950f1ec6a26cc195d2d3f0d5\", \"ui_touch_selection_unittests\": \"bdd16dd7556e965eb05e102550ea2787caf0806f\", \"unit_tests\": \"deb1eb46dd53960537ca12dc31ba504b9930076f\", \"url_unittests\": \"6b3d7bbe88e612c63dec9317037da50cec7bc489\", \"usage_time_limit_unittests\": \"12e3fc72a3ec036d9b0a14910e6a083f8d2c7c90\", \"views_unittests\": \"9936f6bc987630dc64f492ceb30641407719e462\", \"viz_unittests\": \"2e65bec61a965ea0dc93f851f723360f78f5471e\", \"wayland_client_perftests\": \"1a0d5998e61c88dd499f15ba8face19ff0b67953\", \"wm_unittests\": \"9db3d6d6aa33fc15a6f05c1a0a4cb18c916c027f\", \"wtf_unittests\": \"d140b1c015b6016189fe187dda3740f6943f54eb\"}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**non_viz_content_browsertests** failed because of:\\n\\n- SignedExchangeRequestHandlerBrowserTest.VariantMatch/3\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1571536254044959",
"status": "COMPLETED",
"status_changed_ts": "1571536226488038",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/30405",
"builder:linux-chromeos-rel",
"buildset:commit/git/1bd1b58ee30c1c3df257f5cb89b675ff0f9889b1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1bd1b58ee30c1c3df257f5cb89b675ff0f9889b1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064548608471535312",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8899118546307177456/+/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:47ffad552c1cec10",
"user_agent:luci-scheduler"
],
"updated_ts": "1571539111711828",
"url": "https://ci.chromium.org/b/8899118546307177456",
"utcnow_ts": "1571539112761151"
}
}
[02:38:32.778] Invocation finished in 48m8.28573285s with status FAILED