[05:12:38.816] New invocation is queued and will start shortly
[05:12:39.991] Starting the invocation (attempt 1)
[05:12:40.025] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:12:40.025] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:12:40.025] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019962177261183568",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f168f5947698e50545b9b8a296d14d32e88c0264\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9019962177261183568",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/f168f5947698e50545b9b8a296d14d32e88c0264",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f168f5947698e50545b9b8a296d14d32e88c0264",
"gitiles_ref:refs/heads/master"
]
}
[05:12:41.262] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614057160119862",
"id": "8854532115229835136",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f168f5947698e50545b9b8a296d14d32e88c0264\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614057161054858",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45649",
"builder:linux-chromeos-rel",
"buildset:commit/git/f168f5947698e50545b9b8a296d14d32e88c0264",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f168f5947698e50545b9b8a296d14d32e88c0264",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019962177261183568",
"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/8854532115229835136/+/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": "1614057161054973",
"url": "https://ci.chromium.org/b/8854532115229835136",
"utcnow_ts": "1614057161254493"
}
}
[05:12:41.262] Task URL: https://ci.chromium.org/b/8854532115229835136
[05:12:41.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:2:0) after 1m0s
[05:13:18.353] Received PubSub notification, asking Buildbucket for the build status
[05:13:19.561] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:41.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:2:0)
[05:13:41.375] Timer tick, asking Buildbucket for the build status
[05:13:41.726] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:41.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:4:0) after 1m0s
[05:14:41.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:4:0)
[05:14:41.837] Timer tick, asking Buildbucket for the build status
[05:14:41.915] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:41.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:5:0) after 1m0s
[05:15:42.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:5:0)
[05:15:42.064] Timer tick, asking Buildbucket for the build status
[05:15:42.479] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:42.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:6:0) after 1m0s
[05:16:42.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:6:0)
[05:16:42.651] Timer tick, asking Buildbucket for the build status
[05:16:43.111] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:43.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:7:0) after 1m0s
[05:17:43.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:7:0)
[05:17:43.199] Timer tick, asking Buildbucket for the build status
[05:17:43.314] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:43.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:8:0) after 1m0s
[05:18:43.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:8:0)
[05:18:43.412] Timer tick, asking Buildbucket for the build status
[05:18:43.846] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:43.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:9:0) after 1m0s
[05:19:43.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:9:0)
[05:19:43.999] Timer tick, asking Buildbucket for the build status
[05:19:44.227] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:44.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:10:0) after 1m0s
[05:20:44.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:10:0)
[05:20:44.351] Timer tick, asking Buildbucket for the build status
[05:20:44.500] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:44.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:11:0) after 1m0s
[05:21:44.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:11:0)
[05:21:44.587] Timer tick, asking Buildbucket for the build status
[05:21:44.668] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:44.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:12:0) after 1m0s
[05:22:44.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:12:0)
[05:22:44.730] Timer tick, asking Buildbucket for the build status
[05:22:44.838] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:44.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:13:0) after 1m0s
[05:23:44.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:13:0)
[05:23:44.986] Timer tick, asking Buildbucket for the build status
[05:23:45.205] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:45.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:14:0) after 1m0s
[05:24:45.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:14:0)
[05:24:45.290] Timer tick, asking Buildbucket for the build status
[05:24:45.608] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:45.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:15:0) after 1m0s
[05:25:45.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:15:0)
[05:25:45.667] Timer tick, asking Buildbucket for the build status
[05:25:45.753] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:45.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:16:0) after 1m0s
[05:26:45.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:16:0)
[05:26:45.775] Timer tick, asking Buildbucket for the build status
[05:26:45.896] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:45.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:17:0) after 1m0s
[05:27:45.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:17:0)
[05:27:45.909] Timer tick, asking Buildbucket for the build status
[05:27:46.042] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:46.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:18:0) after 1m0s
[05:28:46.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:18:0)
[05:28:46.073] Timer tick, asking Buildbucket for the build status
[05:28:46.423] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:46.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:19:0) after 1m0s
[05:29:46.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:19:0)
[05:29:46.441] Timer tick, asking Buildbucket for the build status
[05:29:46.693] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:46.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:20:0) after 1m0s
[05:30:46.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:20:0)
[05:30:46.718] Timer tick, asking Buildbucket for the build status
[05:30:47.019] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:47.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:21:0) after 1m0s
[05:31:47.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:21:0)
[05:31:47.031] Timer tick, asking Buildbucket for the build status
[05:31:47.112] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:47.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:22:0) after 1m0s
[05:32:47.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:22:0)
[05:32:47.144] Timer tick, asking Buildbucket for the build status
[05:32:47.390] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:47.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:23:0) after 1m0s
[05:33:47.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:23:0)
[05:33:47.493] Timer tick, asking Buildbucket for the build status
[05:33:47.570] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:47.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:24:0) after 1m0s
[05:34:47.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:24:0)
[05:34:47.595] Timer tick, asking Buildbucket for the build status
[05:34:47.671] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:47.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:25:0) after 1m0s
[05:35:47.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:25:0)
[05:35:47.689] Timer tick, asking Buildbucket for the build status
[05:35:48.018] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:48.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:26:0) after 1m0s
[05:36:48.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:26:0)
[05:36:48.045] Timer tick, asking Buildbucket for the build status
[05:36:48.134] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:48.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:27:0) after 1m0s
[05:37:48.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:27:0)
[05:37:48.217] Timer tick, asking Buildbucket for the build status
[05:37:48.342] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:48.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:28:0) after 1m0s
[05:38:48.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:28:0)
[05:38:48.359] Timer tick, asking Buildbucket for the build status
[05:38:48.460] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:48.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:29:0) after 1m0s
[05:39:48.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:29:0)
[05:39:48.494] Timer tick, asking Buildbucket for the build status
[05:39:48.576] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:48.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:30:0) after 1m0s
[05:40:48.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:30:0)
[05:40:48.591] Timer tick, asking Buildbucket for the build status
[05:40:48.927] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:48.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:31:0) after 1m0s
[05:41:48.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:31:0)
[05:41:48.967] Timer tick, asking Buildbucket for the build status
[05:41:49.092] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:49.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:32:0) after 1m0s
[05:42:49.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:32:0)
[05:42:49.183] Timer tick, asking Buildbucket for the build status
[05:42:49.352] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:49.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:33:0) after 1m0s
[05:43:49.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:33:0)
[05:43:49.404] Timer tick, asking Buildbucket for the build status
[05:43:49.868] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:49.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:34:0) after 1m0s
[05:44:49.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:34:0)
[05:44:49.895] Timer tick, asking Buildbucket for the build status
[05:44:49.967] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:49.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:35:0) after 1m0s
[05:45:50.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:35:0)
[05:45:50.071] Timer tick, asking Buildbucket for the build status
[05:45:50.303] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:50.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:36:0) after 1m0s
[05:46:50.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:36:0)
[05:46:50.362] Timer tick, asking Buildbucket for the build status
[05:46:50.534] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:50.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:37:0) after 1m0s
[05:47:50.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:37:0)
[05:47:50.622] Timer tick, asking Buildbucket for the build status
[05:47:50.928] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:50.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:38:0) after 1m0s
[05:48:50.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:38:0)
[05:48:50.972] Timer tick, asking Buildbucket for the build status
[05:48:51.289] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:51.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:39:0) after 1m0s
[05:49:51.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:39:0)
[05:49:51.325] Timer tick, asking Buildbucket for the build status
[05:49:51.389] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:51.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:40:0) after 1m0s
[05:50:51.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:40:0)
[05:50:51.440] Timer tick, asking Buildbucket for the build status
[05:50:51.549] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:51.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:41:0) after 1m0s
[05:51:51.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:41:0)
[05:51:51.550] Timer tick, asking Buildbucket for the build status
[05:51:51.895] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:51.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:42:0) after 1m0s
[05:52:51.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:42:0)
[05:52:51.981] Timer tick, asking Buildbucket for the build status
[05:52:52.070] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:52.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:43:0) after 1m0s
[05:53:52.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:43:0)
[05:53:52.075] Timer tick, asking Buildbucket for the build status
[05:53:52.340] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:52.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:44:0) after 1m0s
[05:54:52.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:44:0)
[05:54:52.383] Timer tick, asking Buildbucket for the build status
[05:54:52.477] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:52.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:45:0) after 1m0s
[05:55:52.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:45:0)
[05:55:52.480] Timer tick, asking Buildbucket for the build status
[05:55:52.568] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:52.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:46:0) after 1m0s
[05:56:52.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:46:0)
[05:56:52.622] Timer tick, asking Buildbucket for the build status
[05:56:53.091] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:53.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:47:0) after 1m0s
[05:57:53.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:47:0)
[05:57:53.345] Timer tick, asking Buildbucket for the build status
[05:57:53.498] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:53.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:48:0) after 1m0s
[05:58:53.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:48:0)
[05:58:53.732] Timer tick, asking Buildbucket for the build status
[05:58:54.045] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:54.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:49:0) after 1m0s
[05:59:54.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:49:0)
[05:59:54.373] Timer tick, asking Buildbucket for the build status
[05:59:54.704] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:54.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:50:0) after 1m0s
[06:00:54.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:50:0)
[06:00:54.742] Timer tick, asking Buildbucket for the build status
[06:00:54.833] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:54.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:51:0) after 1m0s
[06:01:54.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:51:0)
[06:01:54.893] Timer tick, asking Buildbucket for the build status
[06:01:55.340] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:55.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:52:0) after 1m0s
[06:02:55.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:52:0)
[06:02:55.316] Timer tick, asking Buildbucket for the build status
[06:02:55.409] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:55.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:53:0) after 1m0s
[06:03:55.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:53:0)
[06:03:55.480] Timer tick, asking Buildbucket for the build status
[06:03:55.736] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:55.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:54:0) after 1m0s
[06:04:55.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:54:0)
[06:04:55.787] Timer tick, asking Buildbucket for the build status
[06:04:55.962] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:55.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:55:0) after 1m0s
[06:05:56.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:55:0)
[06:05:56.007] Timer tick, asking Buildbucket for the build status
[06:05:56.098] Build 8854532115229835136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:56.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019962177261183568:56:0) after 1m0s
[06:06:26.776] Received PubSub notification, asking Buildbucket for the build status
[06:06:27.057] Build 8854532115229835136: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[06:06:27.057] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614060385941363",
"created_by": "project:chromium",
"created_ts": "1614057160119862",
"failure_reason": "BUILD_FAILURE",
"id": "8854532115229835136",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f168f5947698e50545b9b8a296d14d32e88c0264\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**content_browsertests** failed because of:\\n\\n- IndexedDBBrowserTest.VersionChangeCrashResilience\"}, \"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\": \"f168f5947698e50545b9b8a296d14d32e88c0264\", \"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-27-2b5k\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45649, \"got_angle_revision\": \"4a95488c0edfb4590c808ee01079069da5a6b2b1\", \"got_dawn_revision\": \"2d3c2e355337037dfa6873536bfb3e3a558bf9ed\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"f168f5947698e50545b9b8a296d14d32e88c0264\", \"got_revision_cp\": \"refs/heads/master@{#856572}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"22186f076bf3bbe1a818792bde93b297e3773f7e\", \"got_v8_revision\": \"4120b5f2509821e8dd460b1d033708397520750a\", \"got_v8_revision_cp\": \"refs/heads/9.0.238@{#1}\", \"got_webrtc_revision\": \"6fe3fa14c6686ba9c51095b97ad2e6833a9b03e5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33319}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f168f5947698e50545b9b8a296d14d32e88c0264\", \"swarm_hashes_refs/heads/master(at){#856572}_without_patch\": {\"absl_hardening_tests\": \"3c9dd4826c8c4ccb318415964985f914e5ce86cb\", \"accessibility_unittests\": \"f276914ee696616cf1796d84fe85b558e9ce2ba4\", \"angle_unittests\": \"66ddb5f95106e1aa167e9360ab01a2c5c30141b0\", \"app_list_unittests\": \"a6570ed4d411e2f0c62cec4bc30a70d2b0db8354\", \"app_shell_unittests\": \"8c5206e6299ff820e3a46450af4a42ec9e6ac2dd\", \"ash_unittests\": \"8897c65d1679c903799773274451a2685faa16ca\", \"aura_unittests\": \"c8c3635d68a45132b57f7c3f1ad69b1f020465db\", \"base_unittests\": \"0671dbcf0e7fe8421803a70a82d5076f2c30ecc7\", \"base_util_unittests\": \"593fe48f705ac661ab4a13573c98851530f796b1\", \"blink_common_unittests\": \"2ce28d3b1414b36128d524b72649f3defb59ab0c\", \"blink_fuzzer_unittests\": \"ddcc3ca9158fc54c4a44293f1e52acb3b9ce0afc\", \"blink_heap_unittests\": \"9760b1e8c906106f592201415f9866a3136d45df\", \"blink_platform_unittests\": \"08d9e7828d495d965981ccef7de6efba6f2318d7\", \"blink_unittests\": \"f908710a06e0eb8f6dfc6958db442c5b5ff14a13\", \"boringssl_crypto_tests\": \"daa0263a682720a16b6b10fe8a47c9d059576e02\", \"boringssl_ssl_tests\": \"ab4d22d30a37855f9635bd40ced5d0b3495acbb1\", \"browser_tests\": \"b587dc36982033d5f8be9e1136d33300128ae694\", \"capture_unittests\": \"5f3a7f34b5bf4c213401fd1c941962c9e9e56d2a\", \"cast_unittests\": \"8d9346636dc8fe0674824b0a81c1d77fa6817bb7\", \"cc_unittests\": \"645c03fbc595d8276f41115d72cd02652ece8492\", \"chrome_app_unittests\": \"350a7c4076fe10a870ba87ef9ebf5df7200d8d2f\", \"chromedriver_unittests\": \"c4cee4d6554e66b33317ddc05bfda2bfdcc53ebc\", \"chromeos_components_unittests\": \"bc9fc86f0dc686c41dcee8cb1fc7ff4ac3fe2a39\", \"chromeos_unittests\": \"a5acead7a15601ee9e47cbba738d9626066a3c4d\", \"components_browsertests\": \"18b74840b930b91c279895178eabd23399107d44\", \"components_unittests\": \"14fb8360850fa165ea798f702a47b708b33aa7ab\", \"compositor_unittests\": \"7ed9628ba610db1c65951c483e5405aee066099c\", \"content_browsertests\": \"04bf254fab2d0ef7ed952e2b40d4a8d587200296\", \"content_unittests\": \"1f0236b9df1ea9ec26642924488a1de1b5d679f0\", \"crashpad_tests\": \"bea33522882e4ec4252b663002a1dfd539dae484\", \"crypto_unittests\": \"c0314ba79acac3e4652c583b8d3dab341c18a1ba\", \"dbus_unittests\": \"c27090b5f95da29d2ec8d6962aba6e5c249d9b87\", \"device_unittests\": \"9bf819dfa726437675e3b1e2adb363fa398e2354\", \"display_unittests\": \"a89c843100ecb85b9ebff92a5cae27244507df4c\", \"events_unittests\": \"ae312f286e614cf4b0146c78d131443ee1f2a5d9\", \"exo_unittests\": \"0f62a763551c329ffc8cf671034ea1d0c7239683\", \"extensions_browsertests\": \"d344a3cee0fcf4dcaab28bda19bc0a848cb18e8f\", \"extensions_unittests\": \"45f7ce9a12e55972882ba7c34747c04f0447be63\", \"filesystem_service_unittests\": \"830e213a3820d9f0a6153ce897687646c7f81ae6\", \"gcm_unit_tests\": \"866c95a669c64b81bf62c35636425f5a16e2949f\", \"gfx_unittests\": \"480f01d2df2f13c796a84a0b6045bd1ccede5b62\", \"gin_unittests\": \"6513a35925a005af0f91aa23dcc93cad9c44c3f6\", \"gl_unittests_ozone\": \"fac01a2d4b0b57c3bf895ae234236ab0e166a272\", \"google_apis_unittests\": \"84f293e57552f420dd7e60c874ab8be719ffc275\", \"gpu_unittests\": \"9dc43e537739ec754095412e97e5f2cf952e81eb\", \"gwp_asan_unittests\": \"e8a94ef5a40dd3c759ac6545388811454e7cef06\", \"interactive_ui_tests\": \"3f61a1f621d617a27a79ea3e1f353fb02e9f66c7\", \"ipc_tests\": \"b20e2e061e97b1cdce8f09cd4cb5d4bebef89070\", \"jingle_unittests\": \"dd8e500e545515960e7809c6a6e0db2703e38313\", \"keyboard_unittests\": \"25f2dc32cac959af24174d042a7648ffb6a633ca\", \"latency_unittests\": \"bffc4462db039d14327559776b46e3817cdf0089\", \"libjingle_xmpp_unittests\": \"1fc05fce2e990c5180f0679ba6ee3eebccf8c792\", \"liburlpattern_unittests\": \"358bb1e5b18275939432edb50ce11cad0ad58b40\", \"media_blink_unittests\": \"cf3508b789babb0ecaaf6e9742067c30f21cfb3c\", \"media_unittests\": \"16ae979810bfa4a9768c0df9a0cc30630268ca2f\", \"message_center_unittests\": \"1acf232a994706422ded97c6aa68f5f5a2547f12\", \"midi_unittests\": \"a3c82d016dbf6c3cd295ab9ca9170f10dc288ad6\", \"mojo_core_unittests\": \"4a81f675a7f3a1a63659d59092b795ac2e63fe55\", \"mojo_unittests\": \"7046b0039a80f41ef219e65cc9cb0f2023f7ce5a\", \"nacl_helper_nonsfi_unittests\": \"1e7eba67fcbfe09ec0a881e17811fc58b0b19747\", \"nacl_loader_unittests\": \"fb34369a1d8f46c03dd0ccfe57685a71728a5a83\", \"native_theme_unittests\": \"45c0dc1bc6da17ae23a80dda66b9d984e43776b3\", \"net_unittests\": \"028421173dac454a15c9206b0543da6a5d5a312f\", \"ozone_gl_unittests\": \"eb9836d2c0b7fcf3f13914f966655074d364d2c4\", \"ozone_unittests\": \"08f8aba01ed5779fe65e3b0ab2b2e6fa67daaf87\", \"ozone_x11_unittests\": \"eddeb1fba0e381a88b71ef59f505bd5361946a85\", \"pdf_unittests\": \"8d4b661bb601896a5de9e7ec06a0ac416ddc53ef\", \"perfetto_unittests\": \"f62ba088519aff6ecacfe02237deba4c0f39d895\", \"ppapi_unittests\": \"18518c5867055f49589df75ce4882f609ce77618\", \"printing_unittests\": \"4199624771c85c63cad77617f88c94ff98c9d4e4\", \"remoting_unittests\": \"4fb582cedeca2f88defdc5031f4a29c770ad218d\", \"sandbox_linux_unittests\": \"c95c343c6a88804b0704598c5e4e545c3968a25a\", \"service_manager_unittests\": \"11c00d5ec9bf3615141237bf0020b81c2f098abd\", \"services_unittests\": \"9bc9c8ed6bfa19e992d44d97e40b4680b99c0dbb\", \"shell_dialogs_unittests\": \"9530f7bd615f2a69c71bc82a220c6bcb075e0ad2\", \"shell_encryption_unittests\": \"38b00278a809a9cb555d94d7ab8c1fc3b77296db\", \"skia_unittests\": \"1c970bda4bbe72e2bae337d95c77a24e1cf31bb7\", \"snapshot_unittests\": \"5a8d760f695ecaaef0342902654f9f22cff29e07\", \"sql_unittests\": \"443fd91f92e078c1ff3632b7d27c97f0560c6309\", \"storage_unittests\": \"78ae624e8cb1cc396bcdf8a2ade8d6f3613b574c\", \"sync_integration_tests\": \"f1ad84e50fa219075565072ae05f89298c855377\", \"traffic_annotation_auditor_unittests\": \"aaba71a42646076fdd3ea146c3f4e0888dd54016\", \"ui_base_unittests\": \"fd06a914341f50710247238135f4c856e1103539\", \"ui_chromeos_unittests\": \"b4984a952579d3ef94648b188a6894baafe28155\", \"ui_touch_selection_unittests\": \"bc3a3fc0b481852f7de23b025ed09329431e1581\", \"unit_tests\": \"a582d6c3f29b4e3ee129fea57773d5b0d098d216\", \"url_unittests\": \"e409c10b884e7f63dc85da7544444632cf538a93\", \"usage_time_limit_unittests\": \"c872d4fa4a5ec619054f3417424a5a3d22573e20\", \"views_unittests\": \"d672bc922fb4a351c39ac00c5decf945820b5e9b\", \"viz_unittests\": \"3ac425b14d63fa1e486f52650f33a9fe3459886b\", \"wayland_client_perftests\": \"72be8425ac6ddede26d4facd58ca062814dfab98\", \"wm_unittests\": \"51660535619e4c7d419cbea05baae4c5e8b899a0\", \"wtf_unittests\": \"5edf53ac7b302b21a2cab323f2fc223f2844ef7f\", \"zlib_unittests\": \"b24526bc66621bcd565d889fb7c11a0bf703f430\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1143bf8a0c86d96d189f99a4f0f749b4f3d1e46c849c82cdd2c6ebe168938b3a_v2\", \"builder_554b324272771ff5af13275cc9c865b3499df108d1c4d159c356d5c678bf725c_v2\", \"builder_573c606f18492d6cde6d25a02b12203725732038b1c2909b0b80126d2afb25c2_v2\", \"builder_609b54f795c46f6da98bce3e3c3edeb2c2e2d72c7759cc5040a86edccd734c7c_v2\", \"builder_7e0fd5fb59bce9eac4ec1dec14c7ab059c08dcb0c6471580f0ba0fe000c8167b_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a805855f4ac8de7768c87aef010c4dbf266d6f852a36787503910d065c8041d1_v2\", \"builder_bcc6b3e5c0858529730294da730af8ea17f2c5c79b8b0dc7af4e722a8412ac73_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-27-2b5k\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**content_browsertests** failed because of:\\n\\n- IndexedDBBrowserTest.VersionChangeCrashResilience\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614057197064499",
"status": "COMPLETED",
"status_changed_ts": "1614057197574636",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45649",
"builder:linux-chromeos-rel",
"buildset:commit/git/f168f5947698e50545b9b8a296d14d32e88c0264",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f168f5947698e50545b9b8a296d14d32e88c0264",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019962177261183568",
"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/8854532115229835136/+/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:51e61f4b6ad3c510",
"user_agent:luci-scheduler"
],
"updated_ts": "1614060386327201",
"url": "https://ci.chromium.org/b/8854532115229835136",
"utcnow_ts": "1614060387044141"
}
}
[06:06:27.058] Invocation finished in 53m48.259160776s with status FAILED