[21:23:42.286] New invocation is queued and will start shortly
[21:23:43.515] Starting the invocation (attempt 1)
[21:23:43.553] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:23:43.553] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:23:43.553] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030682122602189136",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8573b69e76935ca681987acb22be121d22b61709\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9030682122602189136",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/8573b69e76935ca681987acb22be121d22b61709",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8573b69e76935ca681987acb22be121d22b61709",
"gitiles_ref:refs/heads/master"
]
}
[21:23:45.133] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603833823787287",
"id": "8865252060347306896",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8573b69e76935ca681987acb22be121d22b61709\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603833824773098",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42322",
"builder:linux-chromeos-rel",
"buildset:commit/git/8573b69e76935ca681987acb22be121d22b61709",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8573b69e76935ca681987acb22be121d22b61709",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030682122602189136",
"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/8865252060347306896/+/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": "1603833824773298",
"url": "https://ci.chromium.org/b/8865252060347306896",
"utcnow_ts": "1603833825103930"
}
}
[21:23:45.133] Task URL: https://ci.chromium.org/b/8865252060347306896
[21:23:45.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:2:0) after 1m0s
[21:23:48.308] Received PubSub notification, asking Buildbucket for the build status
[21:23:48.470] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:45.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:2:0)
[21:24:45.256] Timer tick, asking Buildbucket for the build status
[21:24:45.362] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:45.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:4:0) after 1m0s
[21:25:45.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:4:0)
[21:25:45.385] Timer tick, asking Buildbucket for the build status
[21:25:45.447] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:45.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:5:0) after 1m0s
[21:26:45.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:5:0)
[21:26:45.448] Timer tick, asking Buildbucket for the build status
[21:26:46.044] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:46.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:6:0) after 1m0s
[21:27:46.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:6:0)
[21:27:46.190] Timer tick, asking Buildbucket for the build status
[21:27:46.357] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:46.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:7:0) after 1m0s
[21:28:46.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:7:0)
[21:28:46.366] Timer tick, asking Buildbucket for the build status
[21:28:46.726] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:46.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:8:0) after 1m0s
[21:29:46.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:8:0)
[21:29:46.716] Timer tick, asking Buildbucket for the build status
[21:29:46.834] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:46.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:9:0) after 1m0s
[21:30:46.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:9:0)
[21:30:46.877] Timer tick, asking Buildbucket for the build status
[21:30:46.958] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:46.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:10:0) after 1m0s
[21:31:47.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:10:0)
[21:31:47.826] Timer tick, asking Buildbucket for the build status
[21:31:48.319] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:48.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:11:0) after 1m0s
[21:32:48.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:11:0)
[21:32:48.374] Timer tick, asking Buildbucket for the build status
[21:32:48.720] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:48.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:12:0) after 1m0s
[21:33:48.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:12:0)
[21:33:48.813] Timer tick, asking Buildbucket for the build status
[21:33:48.960] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:48.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:13:0) after 1m0s
[21:34:48.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:13:0)
[21:34:48.993] Timer tick, asking Buildbucket for the build status
[21:34:49.106] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:49.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:14:0) after 1m0s
[21:35:49.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:14:0)
[21:35:49.183] Timer tick, asking Buildbucket for the build status
[21:35:49.293] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:49.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:15:0) after 1m0s
[21:36:49.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:15:0)
[21:36:49.495] Timer tick, asking Buildbucket for the build status
[21:36:49.578] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:49.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:16:0) after 1m0s
[21:37:49.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:16:0)
[21:37:49.620] Timer tick, asking Buildbucket for the build status
[21:37:50.062] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:50.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:17:0) after 1m0s
[21:38:50.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:17:0)
[21:38:50.438] Timer tick, asking Buildbucket for the build status
[21:38:50.607] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:50.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:18:0) after 1m0s
[21:39:50.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:18:0)
[21:39:50.728] Timer tick, asking Buildbucket for the build status
[21:39:50.841] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:50.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:19:0) after 1m0s
[21:40:50.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:19:0)
[21:40:50.899] Timer tick, asking Buildbucket for the build status
[21:40:50.982] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:50.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:20:0) after 1m0s
[21:41:51.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:20:0)
[21:41:51.242] Timer tick, asking Buildbucket for the build status
[21:41:51.478] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:51.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:21:0) after 1m0s
[21:42:51.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:21:0)
[21:42:51.589] Timer tick, asking Buildbucket for the build status
[21:42:52.178] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:52.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:22:0) after 1m0s
[21:43:52.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:22:0)
[21:43:52.347] Timer tick, asking Buildbucket for the build status
[21:43:52.497] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:52.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:23:0) after 1m0s
[21:44:52.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:23:0)
[21:44:52.579] Timer tick, asking Buildbucket for the build status
[21:44:52.661] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:52.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:24:0) after 1m0s
[21:45:52.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:24:0)
[21:45:52.777] Timer tick, asking Buildbucket for the build status
[21:45:52.847] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:52.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:25:0) after 1m0s
[21:46:52.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:25:0)
[21:46:52.856] Timer tick, asking Buildbucket for the build status
[21:46:53.196] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:53.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:26:0) after 1m0s
[21:47:53.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:26:0)
[21:47:53.262] Timer tick, asking Buildbucket for the build status
[21:47:53.337] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:53.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:27:0) after 1m0s
[21:48:53.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:27:0)
[21:48:53.401] Timer tick, asking Buildbucket for the build status
[21:48:53.659] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:53.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:28:0) after 1m0s
[21:49:53.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:28:0)
[21:49:53.689] Timer tick, asking Buildbucket for the build status
[21:49:53.757] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:53.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:29:0) after 1m0s
[21:50:53.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:29:0)
[21:50:53.869] Timer tick, asking Buildbucket for the build status
[21:50:53.949] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:53.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:30:0) after 1m0s
[21:51:54.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:30:0)
[21:51:54.146] Timer tick, asking Buildbucket for the build status
[21:51:54.280] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:54.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:31:0) after 1m0s
[21:52:54.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:31:0)
[21:52:54.490] Timer tick, asking Buildbucket for the build status
[21:52:54.603] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:54.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:32:0) after 1m0s
[21:53:54.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:32:0)
[21:53:54.756] Timer tick, asking Buildbucket for the build status
[21:53:55.007] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:55.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:33:0) after 1m0s
[21:54:55.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:33:0)
[21:54:55.230] Timer tick, asking Buildbucket for the build status
[21:54:55.301] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:55.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:34:0) after 1m0s
[21:55:55.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:34:0)
[21:55:55.618] Timer tick, asking Buildbucket for the build status
[21:55:55.714] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:55.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:35:0) after 1m0s
[21:56:56.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:35:0)
[21:56:56.004] Timer tick, asking Buildbucket for the build status
[21:56:56.279] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:56.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:36:0) after 1m0s
[21:57:56.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:36:0)
[21:57:56.427] Timer tick, asking Buildbucket for the build status
[21:57:56.574] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:56.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:37:0) after 1m0s
[21:58:56.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:37:0)
[21:58:56.756] Timer tick, asking Buildbucket for the build status
[21:58:56.954] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:56.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:38:0) after 1m0s
[21:59:57.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:38:0)
[21:59:57.045] Timer tick, asking Buildbucket for the build status
[21:59:57.380] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:57.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:39:0) after 1m0s
[22:00:57.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:39:0)
[22:00:57.579] Timer tick, asking Buildbucket for the build status
[22:00:58.009] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:58.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:40:0) after 1m0s
[22:01:58.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:40:0)
[22:01:58.099] Timer tick, asking Buildbucket for the build status
[22:01:58.484] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:58.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:41:0) after 1m0s
[22:02:58.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:41:0)
[22:02:58.597] Timer tick, asking Buildbucket for the build status
[22:02:59.523] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:59.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:42:0) after 1m0s
[22:03:59.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:42:0)
[22:03:59.673] Timer tick, asking Buildbucket for the build status
[22:03:59.877] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:59.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:43:0) after 1m0s
[22:04:59.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:43:0)
[22:04:59.934] Timer tick, asking Buildbucket for the build status
[22:05:00.312] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:00.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:44:0) after 1m0s
[22:06:00.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:44:0)
[22:06:00.453] Timer tick, asking Buildbucket for the build status
[22:06:00.785] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:00.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:45:0) after 1m0s
[22:07:01.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:45:0)
[22:07:01.882] Timer tick, asking Buildbucket for the build status
[22:07:01.996] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:01.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:46:0) after 1m0s
[22:08:02.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:46:0)
[22:08:02.907] Timer tick, asking Buildbucket for the build status
[22:08:03.026] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:03.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:47:0) after 1m0s
[22:09:03.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:47:0)
[22:09:03.146] Timer tick, asking Buildbucket for the build status
[22:09:04.217] Build 8865252060347306896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:04.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030682122602189136:48:0) after 1m0s
[22:09:20.788] Received PubSub notification, asking Buildbucket for the build status
[22:09:20.864] Build 8865252060347306896: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[22:09:20.864] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603836558692695",
"created_by": "project:chromium",
"created_ts": "1603833823787287",
"failure_reason": "BUILD_FAILURE",
"id": "8865252060347306896",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8573b69e76935ca681987acb22be121d22b61709\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- WorkingSetTrimmerPolicyChromeOSTest.ArcTrimOnlyIfEnabled\"}, \"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\": \"8573b69e76935ca681987acb22be121d22b61709\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-71-8jzk\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42322, \"got_angle_revision\": \"b5ba693316fdd5e680f2bb4cf1a2f9bed589d8e2\", \"got_dawn_revision\": \"6b087819dd1ea56a50e15bcc34c97ad2fa01d463\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"8573b69e76935ca681987acb22be121d22b61709\", \"got_revision_cp\": \"refs/heads/master@{#821437}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"20aa521f10950ef2db0f60fc487e68d9fa14d703\", \"got_v8_revision_cp\": \"refs/heads/8.8.190@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8573b69e76935ca681987acb22be121d22b61709\", \"swarm_hashes_refs/heads/master(at){#821437}_without_patch\": {\"absl_hardening_tests\": \"f041c30210719c2b75fcab30a183235b12c5dd53\", \"accessibility_unittests\": \"818069d387c088ac1ec6062ce21140c46cc435c5\", \"angle_unittests\": \"4414dc3f42ec0a06127901dee18babad6129be4f\", \"app_list_unittests\": \"1d45f5629a09dc74c51b9b852f95f4a6ed185be6\", \"app_shell_unittests\": \"b04eaab73c8c827f4e7f5cd39387cbeef22f0d5a\", \"ash_unittests\": \"fc46904808736aeaf92bc659df76013bc329a1db\", \"aura_unittests\": \"fe2faaabc8c9cc61b0ba2955b7745a925e925a33\", \"base_unittests\": \"aeab6310027d6ee3d68d352b60792e56bd8e4ef9\", \"base_util_unittests\": \"061d7e033ff298913ce41de31ba594964fa51a96\", \"blink_common_unittests\": \"022fd7aebd3fd7f4e2948a47a33bd068853dcbde\", \"blink_fuzzer_unittests\": \"40172a42cdb12d9fe938735f2d5c60292cbbec72\", \"blink_heap_unittests\": \"291212ce002dd41c9f65baa1fb3ba9088c076792\", \"blink_platform_unittests\": \"4e712e65a86b8d5f7b7d7623d4cba128f12fa266\", \"blink_unittests\": \"08a288ca6d68f79c216afbb8ddc0ceae5757ca7c\", \"boringssl_crypto_tests\": \"e0a906bedb95c79cd854fe9d989fba31081cd4f6\", \"boringssl_ssl_tests\": \"440a27b27369ef7f2357ffd00ada5cad55ba9f76\", \"browser_tests\": \"5af4c86023f68ddf5cb5bc0c8be8a58d0e837257\", \"capture_unittests\": \"63a31e36d5a88816ec0f7cfeaa0e8dd84af7fd30\", \"cast_unittests\": \"d4b64faad7c8263765873fc60bc62bed931fd5d1\", \"cc_unittests\": \"c64945dec35e33ab8c846b60062afa337de5d25e\", \"chrome_app_unittests\": \"ffcb8f1192d6f0f1d8cb751044242f33c6aeda69\", \"chromedriver_unittests\": \"b7fc763722ceccd869a8e3889a27e3482f4f9190\", \"chromeos_components_unittests\": \"213bd1f9aea88a7932cca893a73d2ab6855669b9\", \"chromeos_unittests\": \"bd76cb15f8aa9d71577c78cb0362690c32edf627\", \"components_browsertests\": \"7860f2a3fdab2063288f83c3036a090d277690ed\", \"components_unittests\": \"f2fec44a955919b5aab45ce34828c5dff347e3e9\", \"compositor_unittests\": \"0e42dbe5049df7e9a379e578a85d56f798565089\", \"content_browsertests\": \"0c952ea904b500ae6b0dab055a84d0c9c5032426\", \"content_unittests\": \"4e2fc3ab9d854d54ac6e83090487d83be8d51c48\", \"crypto_unittests\": \"0aa8abaa8c8131db5579996cd009135ff7eb128f\", \"dbus_unittests\": \"8fc14604b9ab31afb94999979e675856d460ba64\", \"device_unittests\": \"d4fde7bb852e6d854fa9133745dd412f67147ee2\", \"display_unittests\": \"4ca5e7cc7cc8be8dda9556f7fee87960d6a28161\", \"events_unittests\": \"cd1a7e84df536ebbe228e79230d5f1e833d375da\", \"exo_unittests\": \"7f0842acc61577a20035a99d9414870f091ce7a9\", \"extensions_browsertests\": \"f6e0ab97ad083bf56b5519704f9fd6ea91046aff\", \"extensions_unittests\": \"390eedc3b689aad19307f614509d95680fa2484f\", \"filesystem_service_unittests\": \"1bd445675bbce06adf0adbf239887d7bc3892179\", \"gcm_unit_tests\": \"16414fd86130e21a160ef8b6ee4938030b9ff792\", \"gfx_unittests\": \"c0a1ff9276327990e3f7d196beaaa776b5a1dcf3\", \"gin_unittests\": \"9a192e0030aa9049934f72695e717b1c35811e77\", \"gl_unittests_ozone\": \"e28562edb9cbeb9ffd27eed394d37c3494b82f91\", \"google_apis_unittests\": \"87acd5a4a454af97add71cd72c0b099aab3469ca\", \"gpu_unittests\": \"6032876a7315a27e4b6d0e45e7d79e454f98c159\", \"gwp_asan_unittests\": \"72cf43bc5059bedc6302558edd38817a28bbecb7\", \"interactive_ui_tests\": \"cf10f321c5722c568b716fac1238fc0ac3207ed0\", \"ipc_tests\": \"fe30d433d8028843b4dd5d9e7740912445931ad2\", \"jingle_unittests\": \"2ac0187345cd07492d1910db8948f724365b5d07\", \"keyboard_unittests\": \"2cb65695f7a4bd324a68bb44efb776860a63d630\", \"latency_unittests\": \"285b926cfc347b0a83530139b89d0ad84e9c3c23\", \"libjingle_xmpp_unittests\": \"767b2bf52bd84286dcd8bccaaf9164e0985a50f0\", \"media_blink_unittests\": \"fbcb55944c2d59140c401ea1a3f8be0ec66e8bf7\", \"media_unittests\": \"9ac86c4bc4e91250eeaf965f748ef1eb27bdfb63\", \"message_center_unittests\": \"e3fbade0a492945e68441e60dca70597eb1b2110\", \"midi_unittests\": \"993d032b4f4d79245bfbd359a550cfb8d96cd2f2\", \"mojo_core_unittests\": \"fde66b995bf1eaee402112130f7221880a74fe4d\", \"mojo_unittests\": \"77564675eadcfc7b7b25e662f83b2523d99f2729\", \"nacl_helper_nonsfi_unittests\": \"528ea151bf3c49e65fc668cedbe1c9c8cdc10d3f\", \"nacl_loader_unittests\": \"917a40791d2c094cdbb9380860565f1c6e737be0\", \"native_theme_unittests\": \"3fa286ccecbb1b8a09d164f646298744d2a70baf\", \"net_unittests\": \"654b243c163a4a145b7cca4c94cad0739dcfd518\", \"ozone_gl_unittests\": \"df3aec4bccdf59e99515fffec4e6519cfb210dce\", \"ozone_unittests\": \"d016aa7f3706dfe826cbc1d93afbb4420a417e5f\", \"ozone_x11_unittests\": \"bd5f610c04011bc44817c71964937b0aeecaa765\", \"pdf_unittests\": \"9b0b1d6dc618396ce88eb761cb1f733398d0c253\", \"perfetto_unittests\": \"5f3dd3d94f67ec371fb766510bb9f9f5d0451598\", \"ppapi_unittests\": \"52f33d94fcfb03cb6d8d01970b491f0e947f528b\", \"printing_unittests\": \"49aac0dd23a81a6764d0746bc65f026eaef0e3a9\", \"remoting_unittests\": \"f011df6e55ff3e82d94fca9dc8fd9c0ec5d207be\", \"sandbox_linux_unittests\": \"8dfbfefafc8734e95ae16409e466f2abc29f72de\", \"service_manager_unittests\": \"2bcc9855d6fb0c1f3ff3a6a26f89321e14eed18d\", \"services_unittests\": \"ff8996493a771a6a758e11678c192ae8000ec985\", \"shell_dialogs_unittests\": \"1b821ba092d654fd050913092d67cce42e37af0a\", \"skia_unittests\": \"be29d09f783bf6d8f48a9f6d9e4d53d89c40d199\", \"snapshot_unittests\": \"63867c09b9df16824d1ad33210219494c6f13315\", \"sql_unittests\": \"1f5f0a65e4bfad7faaa144c7ddc5325faf76346f\", \"storage_unittests\": \"89a85731b8279472680dbf3eb193219f34469ac7\", \"sync_integration_tests\": \"b6a7a2163ca8d91b13c134393a4cf08c07c7b82d\", \"traffic_annotation_auditor_unittests\": \"f9775afa15e28d30793354d0490cd2d60ca37bd3\", \"ui_base_unittests\": \"4a6ac931d67ebbc3b1821c18334201b5ab44660b\", \"ui_chromeos_unittests\": \"a1386b44154a94be0327413b22e0b5fc41fa0d90\", \"ui_touch_selection_unittests\": \"950b24eab0e0966d2824e26c7aec5835fd48d293\", \"unit_tests\": \"36177a15408622270ba75160f0ecf5a67efc09d6\", \"url_unittests\": \"fd1ae726c16cb65334df7cd63051db6c5cb3a1dc\", \"usage_time_limit_unittests\": \"4b1e3f2366b51909ffdbe94fd29414fcf38e8db7\", \"views_unittests\": \"f9e6602c295200a711bb8c04fc276e73c82309a7\", \"viz_unittests\": \"bf6c89d5b4d02e45b88ee0ffdc35b84f8e0e10d0\", \"wayland_client_perftests\": \"8fdd4d7a123677eb318d514a478739f451a67ddf\", \"wm_unittests\": \"4f4ab096898fa2f9eb0692ea3869eb98f38408d5\", \"wtf_unittests\": \"c495b7557a4d63572a39a4d9886243baca3d87f2\", \"zlib_unittests\": \"ee28b915f0347a8bd817962d6716d24fff25721b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-71-8jzk\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5613-2fddb4d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- WorkingSetTrimmerPolicyChromeOSTest.ArcTrimOnlyIfEnabled\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603833827512680",
"status": "COMPLETED",
"status_changed_ts": "1603833827806104",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42322",
"builder:linux-chromeos-rel",
"buildset:commit/git/8573b69e76935ca681987acb22be121d22b61709",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8573b69e76935ca681987acb22be121d22b61709",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030682122602189136",
"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/8865252060347306896/+/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:4f84c396a3a6ea10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603836560267772",
"url": "https://ci.chromium.org/b/8865252060347306896",
"utcnow_ts": "1603836560855838"
}
}
[22:09:20.864] Invocation finished in 45m38.611897907s with status FAILED