[15:56:45.473] New invocation is queued and will start shortly
[15:56:46.543] Starting the invocation (attempt 1)
[15:56:46.581] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:56:46.582] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:56:46.582] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026263440949475456",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"23f02cf0fb4e2b188cd177c1733ae06933ed6909\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9026263440949475456",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/23f02cf0fb4e2b188cd177c1733ae06933ed6909",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/23f02cf0fb4e2b188cd177c1733ae06933ed6909",
"gitiles_ref:refs/heads/master"
]
}
[15:56:47.253] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608047806700738",
"id": "8860833379000365712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"23f02cf0fb4e2b188cd177c1733ae06933ed6909\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608047807089181",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43746",
"builder:linux-chromeos-rel",
"buildset:commit/git/23f02cf0fb4e2b188cd177c1733ae06933ed6909",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/23f02cf0fb4e2b188cd177c1733ae06933ed6909",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026263440949475456",
"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/8860833379000365712/+/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": "1608047807089301",
"url": "https://ci.chromium.org/b/8860833379000365712",
"utcnow_ts": "1608047807243488"
}
}
[15:56:47.253] Task URL: https://ci.chromium.org/b/8860833379000365712
[15:56:47.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:2:0) after 1m0s
[15:56:52.247] Received PubSub notification, asking Buildbucket for the build status
[15:56:52.510] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:47.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:2:0)
[15:57:47.360] Timer tick, asking Buildbucket for the build status
[15:57:47.476] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:47.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:4:0) after 1m0s
[15:58:47.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:4:0)
[15:58:47.796] Timer tick, asking Buildbucket for the build status
[15:58:47.882] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:47.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:5:0) after 1m0s
[15:59:47.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:5:0)
[15:59:47.982] Timer tick, asking Buildbucket for the build status
[15:59:48.197] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:48.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:6:0) after 1m0s
[16:00:48.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:6:0)
[16:00:48.258] Timer tick, asking Buildbucket for the build status
[16:00:48.378] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:48.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:7:0) after 1m0s
[16:01:48.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:7:0)
[16:01:48.366] Timer tick, asking Buildbucket for the build status
[16:01:48.715] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:48.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:8:0) after 1m0s
[16:02:48.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:8:0)
[16:02:48.774] Timer tick, asking Buildbucket for the build status
[16:02:48.883] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:48.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:9:0) after 1m0s
[16:03:49.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:9:0)
[16:03:49.172] Timer tick, asking Buildbucket for the build status
[16:03:49.281] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:49.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:10:0) after 1m0s
[16:04:49.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:10:0)
[16:04:49.422] Timer tick, asking Buildbucket for the build status
[16:04:49.799] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:49.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:11:0) after 1m0s
[16:05:49.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:11:0)
[16:05:49.909] Timer tick, asking Buildbucket for the build status
[16:05:49.987] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:49.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:12:0) after 1m0s
[16:06:50.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:12:0)
[16:06:50.087] Timer tick, asking Buildbucket for the build status
[16:06:50.306] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:50.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:13:0) after 1m0s
[16:07:50.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:13:0)
[16:07:50.308] Timer tick, asking Buildbucket for the build status
[16:07:50.543] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:50.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:14:0) after 1m0s
[16:08:50.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:14:0)
[16:08:50.629] Timer tick, asking Buildbucket for the build status
[16:08:50.694] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:50.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:15:0) after 1m0s
[16:09:50.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:15:0)
[16:09:50.706] Timer tick, asking Buildbucket for the build status
[16:09:50.855] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:50.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:16:0) after 1m0s
[16:10:50.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:16:0)
[16:10:50.916] Timer tick, asking Buildbucket for the build status
[16:10:51.036] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:51.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:17:0) after 1m0s
[16:11:51.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:17:0)
[16:11:51.094] Timer tick, asking Buildbucket for the build status
[16:11:51.223] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:51.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:18:0) after 1m0s
[16:12:51.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:18:0)
[16:12:51.265] Timer tick, asking Buildbucket for the build status
[16:12:51.385] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:51.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:19:0) after 1m0s
[16:13:51.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:19:0)
[16:13:51.389] Timer tick, asking Buildbucket for the build status
[16:13:51.868] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:51.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:20:0) after 1m0s
[16:14:51.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:20:0)
[16:14:51.941] Timer tick, asking Buildbucket for the build status
[16:14:52.094] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:52.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:21:0) after 1m0s
[16:15:52.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:21:0)
[16:15:52.112] Timer tick, asking Buildbucket for the build status
[16:15:52.260] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:52.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:22:0) after 1m0s
[16:16:52.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:22:0)
[16:16:52.266] Timer tick, asking Buildbucket for the build status
[16:16:52.383] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:52.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:23:0) after 1m0s
[16:17:52.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:23:0)
[16:17:52.458] Timer tick, asking Buildbucket for the build status
[16:17:52.652] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:52.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:24:0) after 1m0s
[16:18:52.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:24:0)
[16:18:52.761] Timer tick, asking Buildbucket for the build status
[16:18:52.931] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:52.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:25:0) after 1m0s
[16:19:53.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:25:0)
[16:19:53.078] Timer tick, asking Buildbucket for the build status
[16:19:53.314] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:53.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:26:0) after 1m0s
[16:20:53.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:26:0)
[16:20:53.399] Timer tick, asking Buildbucket for the build status
[16:20:53.468] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:53.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:27:0) after 1m0s
[16:21:53.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:27:0)
[16:21:53.488] Timer tick, asking Buildbucket for the build status
[16:21:53.806] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:53.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:28:0) after 1m0s
[16:22:53.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:28:0)
[16:22:53.874] Timer tick, asking Buildbucket for the build status
[16:22:53.940] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:53.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:29:0) after 1m0s
[16:23:54.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:29:0)
[16:23:54.016] Timer tick, asking Buildbucket for the build status
[16:23:54.072] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:54.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:30:0) after 1m0s
[16:24:54.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:30:0)
[16:24:54.274] Timer tick, asking Buildbucket for the build status
[16:24:54.361] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:54.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:31:0) after 1m0s
[16:25:54.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:31:0)
[16:25:54.507] Timer tick, asking Buildbucket for the build status
[16:25:54.573] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:54.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:32:0) after 1m0s
[16:26:54.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:32:0)
[16:26:54.729] Timer tick, asking Buildbucket for the build status
[16:26:54.864] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:54.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:33:0) after 1m0s
[16:27:54.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:33:0)
[16:27:54.885] Timer tick, asking Buildbucket for the build status
[16:27:54.958] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:54.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:34:0) after 1m0s
[16:28:55.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:34:0)
[16:28:55.024] Timer tick, asking Buildbucket for the build status
[16:28:55.097] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:55.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:35:0) after 1m0s
[16:29:55.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:35:0)
[16:29:55.144] Timer tick, asking Buildbucket for the build status
[16:29:55.196] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:55.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:36:0) after 1m0s
[16:30:55.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:36:0)
[16:30:55.273] Timer tick, asking Buildbucket for the build status
[16:30:55.344] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:55.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:37:0) after 1m0s
[16:31:55.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:37:0)
[16:31:55.579] Timer tick, asking Buildbucket for the build status
[16:31:55.705] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:55.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:38:0) after 1m0s
[16:32:55.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:38:0)
[16:32:55.801] Timer tick, asking Buildbucket for the build status
[16:32:55.914] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:55.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:39:0) after 1m0s
[16:33:55.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:39:0)
[16:33:55.980] Timer tick, asking Buildbucket for the build status
[16:33:56.095] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:56.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:40:0) after 1m0s
[16:34:56.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:40:0)
[16:34:56.118] Timer tick, asking Buildbucket for the build status
[16:34:56.229] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:56.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:41:0) after 1m0s
[16:35:56.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:41:0)
[16:35:56.274] Timer tick, asking Buildbucket for the build status
[16:35:56.334] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:56.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:42:0) after 1m0s
[16:36:56.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:42:0)
[16:36:56.427] Timer tick, asking Buildbucket for the build status
[16:36:56.565] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:56.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:43:0) after 1m0s
[16:37:56.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:43:0)
[16:37:56.658] Timer tick, asking Buildbucket for the build status
[16:37:56.757] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:56.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:44:0) after 1m0s
[16:39:46.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:44:0)
[16:39:46.550] Timer tick, asking Buildbucket for the build status
[16:39:46.958] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:46.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:45:0) after 1m0s
[16:41:40.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:45:0)
[16:41:40.442] Timer tick, asking Buildbucket for the build status
[16:41:40.532] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:40.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:46:0) after 1m0s
[16:42:40.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:46:0)
[16:42:40.950] Timer tick, asking Buildbucket for the build status
[16:42:41.207] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:41.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:47:0) after 1m0s
[16:43:41.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:47:0)
[16:43:41.225] Timer tick, asking Buildbucket for the build status
[16:43:41.358] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:41.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:48:0) after 1m0s
[16:44:41.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:48:0)
[16:44:41.438] Timer tick, asking Buildbucket for the build status
[16:44:41.549] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:41.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:49:0) after 1m0s
[16:45:41.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:49:0)
[16:45:41.591] Timer tick, asking Buildbucket for the build status
[16:45:41.695] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:41.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:50:0) after 1m0s
[16:46:41.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:50:0)
[16:46:41.739] Timer tick, asking Buildbucket for the build status
[16:46:41.821] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:41.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:51:0) after 1m0s
[16:47:41.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:51:0)
[16:47:41.852] Timer tick, asking Buildbucket for the build status
[16:47:41.968] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:41.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:52:0) after 1m0s
[16:48:41.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:52:0)
[16:48:41.986] Timer tick, asking Buildbucket for the build status
[16:48:42.153] Build 8860833379000365712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:42.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026263440949475456:53:0) after 1m0s
[16:48:58.266] Received PubSub notification, asking Buildbucket for the build status
[16:48:58.376] Build 8860833379000365712: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[16:48:58.376] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608050937737679",
"created_by": "project:chromium",
"created_ts": "1608047806700738",
"failure_reason": "BUILD_FAILURE",
"id": "8860833379000365712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"23f02cf0fb4e2b188cd177c1733ae06933ed6909\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**content_browsertests** failed because of:\\n\\n- All/SitePerProcessBrowserTest.CompositingScaleFactorInNestedFrameTest/0\"}, \"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\": \"23f02cf0fb4e2b188cd177c1733ae06933ed6909\", \"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-0-3x6w\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43746, \"got_angle_revision\": \"fd7733e974236d34b822c36becc965b8d3414f08\", \"got_dawn_revision\": \"985db28c6faec66a28315eb7f5b46f21e04e4d77\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"23f02cf0fb4e2b188cd177c1733ae06933ed6909\", \"got_revision_cp\": \"refs/heads/master@{#837105}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"fa44979d90aac8cca42e2fee711d44f23c9c4d67\", \"got_v8_revision\": \"6b82504a52acfe8ff39dfc8c3e052e853e44244f\", \"got_v8_revision_cp\": \"refs/heads/8.9.154@{#1}\", \"got_webrtc_revision\": \"cf8ec1f6867651204d81b14a8c31a86e6eb97572\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32829}\", \"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\": \"23f02cf0fb4e2b188cd177c1733ae06933ed6909\", \"swarm_hashes_refs/heads/master(at){#837105}_without_patch\": {\"absl_hardening_tests\": \"b24fea8c6bdaced50e74df2d89d813bd97f17264\", \"accessibility_unittests\": \"e6771b39c0f4e13823bd79d07e7151832a1fa44d\", \"angle_unittests\": \"134a4e98fd5c7854513920c6ddf3f281dd9485a2\", \"app_list_unittests\": \"a260d6f71cdd2c43a6473e2785c2da63c17fb597\", \"app_shell_unittests\": \"024e83edcf2767d2e41cf92bc6251d48198842c1\", \"ash_unittests\": \"1b741087d397efe36ec4d79f4bebdbc3e25a86e5\", \"aura_unittests\": \"f4a79b4b44362960ab3e4213e5e29f099b7f747a\", \"base_unittests\": \"9429e31dae913400a34ccdd523ec490e48ff0b49\", \"base_util_unittests\": \"c5c9c02d8bfd7c94de388cbe62b7baacf0b9f076\", \"blink_common_unittests\": \"ec56e3990eb85c5c8e251f06cfe4b1d78321ca8d\", \"blink_fuzzer_unittests\": \"0e3e0e01bee470f4b4ad45fb117a6fea84d2c45b\", \"blink_heap_unittests\": \"7117091115b8ff5aa73d715783bfa565dbd794c6\", \"blink_platform_unittests\": \"89eb2db601a087dfb48a3b167687a024b2dd5c6f\", \"blink_unittests\": \"a3e748dfa57767f731e16bafca2a866a7c9c42d7\", \"boringssl_crypto_tests\": \"8180ce248ed3814fa6a9bf2165948a717389aed6\", \"boringssl_ssl_tests\": \"d6bf543b48a463e0244527f98c04fb635563f011\", \"browser_tests\": \"9f949f71c39bc9a9bbadb5ca7680950b1853061f\", \"capture_unittests\": \"da589f86ae0fd547f8ca7977310cbf755c9784ee\", \"cast_unittests\": \"69ca3115dd035a300e11488d6482cb7a16721ce9\", \"cc_unittests\": \"14b78f7cf3fbee868671f976b4615db31eb74435\", \"chrome_app_unittests\": \"0571ba173f68f6a34d0c02d3f761f47ef23d1ad9\", \"chromedriver_unittests\": \"c25af63a666d246341a69281483571686e21cc30\", \"chromeos_components_unittests\": \"dc659856e858c8baa27b949863d673ff4e4603f1\", \"chromeos_unittests\": \"364ec714d1ff0fd5d62dd391479feb89bb9edf50\", \"components_browsertests\": \"1e579eb239a0def2656ba6d63cd8f76deb071344\", \"components_unittests\": \"a754af4c86ab28000104c8709505928c2428ef85\", \"compositor_unittests\": \"80d5e89d1fd3c3b9a142c0938c64eb32e3cbbb15\", \"content_browsertests\": \"7b1bb4746d9e7c1dc575236aa242819945607c23\", \"content_unittests\": \"2f9e26a2846ecae2cc015db22bac300e05bf2556\", \"crashpad_tests\": \"ccd92ce1c69fb94cf8835caf0168c1124b094cc2\", \"crypto_unittests\": \"e0c00835a28fd482dbba9b8ab4cd60005cc4df31\", \"dbus_unittests\": \"e47a771e23dea7f7161afb8b9cf98ede266db865\", \"device_unittests\": \"3052079248f1b6a7f4eea61a711e0bfb395a02a7\", \"display_unittests\": \"9cf15d9931d330c0e3e04903268f93589263d8d1\", \"events_unittests\": \"c8c7db7689d6d1ec1e5185dced6e2d9993d0d744\", \"exo_unittests\": \"1f7150d8d26e02b6ab0e9addacf451d1bed55037\", \"extensions_browsertests\": \"b613628174e168118a99a7fce336876005dce26a\", \"extensions_unittests\": \"4e2fb251b6452fdd2e8262ac5150e86707dda101\", \"filesystem_service_unittests\": \"a4686d04ffc5359ab51e767c8cf2161b0fa3e66e\", \"gcm_unit_tests\": \"17844aaeebfcb8c5f075e5f2fda84dfd2f0f54c3\", \"gfx_unittests\": \"16bab1df818769661e9be61d9bba3b850e4fdecd\", \"gin_unittests\": \"55a9a3cf94bd61290757d94d34b6f2039020274a\", \"gl_unittests_ozone\": \"9cb3b35a66846d49b2f0f3f003690b9b10699d61\", \"google_apis_unittests\": \"04eba087c52c6584a9296e5b73d16d67287ef361\", \"gpu_unittests\": \"27420a8fd51880c308f505ed10cf2c6e8d25e486\", \"gwp_asan_unittests\": \"180bc92a8906f8abfdca3c3fd1ebfc341420a392\", \"interactive_ui_tests\": \"7762a469b6132c7e2acb7b94800c00175f6dab91\", \"ipc_tests\": \"8348f1439476243ba20bc829f61a285143112021\", \"jingle_unittests\": \"ceb6b308ac76ea83dd974a7db8b32727cd447f37\", \"keyboard_unittests\": \"bfad459b11463f336b9934d818f60eff6a22bfd9\", \"latency_unittests\": \"a718a676a6c6c6c0cf0c2986db03fbc6adba22f3\", \"libjingle_xmpp_unittests\": \"25f7350959725b76cab3b624300da77a56679889\", \"liburlpattern_unittests\": \"65060c83078e86647d8a8b0cfceac6121f5955e1\", \"media_blink_unittests\": \"7e4a2f1eec63e1ea94a653d64545dc65feb80bbe\", \"media_unittests\": \"42e512ca2a445725d2330f5f7eb1b006f6111737\", \"message_center_unittests\": \"2c5bf132adb7f9d895d04000666e627d5e0518e7\", \"midi_unittests\": \"ec54fd78df3eee1cb3abe4a86a98bc788d6c7a93\", \"mojo_core_unittests\": \"b5c6f79d8e5a86681728e1e1049b7e2c6253ac08\", \"mojo_unittests\": \"8c87f4037bedffee03dba1ec29010dded4b0ca76\", \"nacl_helper_nonsfi_unittests\": \"bce85bfdcba18abd429fb68489ecfd1832e89b31\", \"nacl_loader_unittests\": \"44f672bee72a755000f47e035c1a6d5156cf86e9\", \"native_theme_unittests\": \"17159bf8d466e5b748d199fc333e5905c6d5afaa\", \"net_unittests\": \"ff30fcd808eead98e4ec19166361f5d805faae93\", \"ozone_gl_unittests\": \"3b5d1ac817eeb49ec469071206068e35aa85318e\", \"ozone_unittests\": \"4b712cd0366162a712adf869f761d41c62c29e55\", \"ozone_x11_unittests\": \"58b6001f576b0aecdd5ce04e5215406b17c0ddf3\", \"pdf_unittests\": \"dcd52c274a0eee2a169d448aaa03aef9d8ee5204\", \"perfetto_unittests\": \"6e068a5599d407772e3830130b72cb2c704abef4\", \"ppapi_unittests\": \"4029ba39159479f02a7a22365998aac74f37bf51\", \"printing_unittests\": \"1f85c5f3299f9d72520af268f95c68889d546b58\", \"remoting_unittests\": \"e2e2676270f8c2d996f8aab8bcefa21b006eee6d\", \"sandbox_linux_unittests\": \"8601cf3d71e351f3fd0900cb4629370867771eca\", \"service_manager_unittests\": \"57fd92d536a5ff6c3b9fff5cb87e022975c5eee4\", \"services_unittests\": \"83ebc26178f9510de6a7cd7c2932e952af71568f\", \"shell_dialogs_unittests\": \"96fedbb415bb559eebed9c584f641d599b3eb342\", \"shell_encryption_unittests\": \"f15f80b5228790f69c317e2c1a7bb04d22a788df\", \"skia_unittests\": \"cc4553960a81e07f14f095faaada0d9f238ca5f3\", \"snapshot_unittests\": \"c94f908841b6a34e14da24e39c1d1b12543da626\", \"sql_unittests\": \"849be9ce7e757703835f62271a89debaf0834a76\", \"storage_unittests\": \"b909cd1dcbb66dc2f47da7ca93027c0a1c6199b9\", \"sync_integration_tests\": \"f64082fb01b0c521236523533294d83fe29c7096\", \"traffic_annotation_auditor_unittests\": \"e3b51832483f827e2cf70bb62d90b631f39c3178\", \"ui_base_unittests\": \"2620c0e4063f8b490b639c76e9ebd2bc47187696\", \"ui_chromeos_unittests\": \"5b2e0086cf660b1d32bfa0a88fe87b6c3af478cd\", \"ui_touch_selection_unittests\": \"8c206a4fb9265acadfc382e251efd95d6e4a7555\", \"unit_tests\": \"009744f033dfb24c53ffd203236e48b7aaf22a14\", \"url_unittests\": \"1d8137a438cbd302b6d4d7c9a52b65ab475ca23c\", \"usage_time_limit_unittests\": \"8e681f0de47215bfec3768a8861a8a27b8f59dc6\", \"views_unittests\": \"ee8e881b688cb1082fd1757e852ba064431baf67\", \"viz_unittests\": \"d3bebdfd771a9fa2421e09a6036b778ad7c8d17e\", \"wayland_client_perftests\": \"070f81f3a078942453c6ac64c96798dca4fcb12a\", \"wm_unittests\": \"34745711cb4a1a6b4f672d221c3d3b35ae6bef64\", \"wtf_unittests\": \"4f587fb38ff79b41e657b12737c0b62f471cde0c\", \"zlib_unittests\": \"bcd70522ddd4af067e12afbfee247b0150a57ee7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0e22c04085d4f23fdc95f18e428a3d660f7cf1c501a8c991d94e3298ba2ece61_v2\", \"builder_4bb8df61718ee3173d82ea540402eadde21707c87b43c35a861cfb17546437c1_v2\", \"builder_620847ba863b7b859d365f855d10aa27bab23d13b665ad3a30c50048a11ad6c4_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a10052c67097968898fa29710cdaa0ada58a120001760a536a006ca29eefe964_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"builder_eae3a4dc277b4e2282e9fce002ae6861b5ee5509389502cf3acc9366ec79a2d3_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-0-3x6w\"], \"image\": [\"chrome-xenial-20120600-c5cfbe11ce8\"], \"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\": [\"5657-0417a3f\"], \"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- All/SitePerProcessBrowserTest.CompositingScaleFactorInNestedFrameTest/0\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608047811738471",
"status": "COMPLETED",
"status_changed_ts": "1608047812036282",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43746",
"builder:linux-chromeos-rel",
"buildset:commit/git/23f02cf0fb4e2b188cd177c1733ae06933ed6909",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/23f02cf0fb4e2b188cd177c1733ae06933ed6909",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026263440949475456",
"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/8860833379000365712/+/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:507fefd5bfebec10",
"user_agent:luci-scheduler"
],
"updated_ts": "1608050938022029",
"url": "https://ci.chromium.org/b/8860833379000365712",
"utcnow_ts": "1608050938366992"
}
}
[16:48:58.377] Invocation finished in 52m12.919860824s with status FAILED