[16:23:12.626] New invocation is queued and will start shortly
[16:23:13.781] Starting the invocation (attempt 1)
[16:23:13.820] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:23:13.820] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:23:13.820] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021007152648269984",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"501ab7679ed84882436733c5ae0189c0991cfa13\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9021007152648269984",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/501ab7679ed84882436733c5ae0189c0991cfa13",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/501ab7679ed84882436733c5ae0189c0991cfa13",
"gitiles_ref:refs/heads/master"
]
}
[16:23:14.557] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613060593978394",
"id": "8855577090567061488",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"501ab7679ed84882436733c5ae0189c0991cfa13\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613060594437352",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45334",
"builder:linux-chromeos-rel",
"buildset:commit/git/501ab7679ed84882436733c5ae0189c0991cfa13",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/501ab7679ed84882436733c5ae0189c0991cfa13",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021007152648269984",
"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/8855577090567061488/+/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": "1613060594437506",
"url": "https://ci.chromium.org/b/8855577090567061488",
"utcnow_ts": "1613060594547260"
}
}
[16:23:14.557] Task URL: https://ci.chromium.org/b/8855577090567061488
[16:23:14.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:2:0) after 1m0s
[16:23:19.279] Received PubSub notification, asking Buildbucket for the build status
[16:23:19.349] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:14.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:2:0)
[16:24:14.883] Timer tick, asking Buildbucket for the build status
[16:24:14.994] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:14.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:4:0) after 1m0s
[16:25:15.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:4:0)
[16:25:15.103] Timer tick, asking Buildbucket for the build status
[16:25:15.444] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:15.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:5:0) after 1m0s
[16:26:15.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:5:0)
[16:26:15.583] Timer tick, asking Buildbucket for the build status
[16:26:16.536] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:16.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:6:0) after 1m0s
[16:27:16.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:6:0)
[16:27:16.617] Timer tick, asking Buildbucket for the build status
[16:27:16.765] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:16.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:7:0) after 1m0s
[16:28:16.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:7:0)
[16:28:16.816] Timer tick, asking Buildbucket for the build status
[16:28:17.127] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:17.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:8:0) after 1m0s
[16:29:17.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:8:0)
[16:29:17.173] Timer tick, asking Buildbucket for the build status
[16:29:17.245] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:17.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:9:0) after 1m0s
[16:30:17.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:9:0)
[16:30:17.289] Timer tick, asking Buildbucket for the build status
[16:30:17.462] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:17.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:10:0) after 1m0s
[16:31:17.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:10:0)
[16:31:17.919] Timer tick, asking Buildbucket for the build status
[16:31:18.095] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:18.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:11:0) after 1m0s
[16:32:18.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:11:0)
[16:32:18.226] Timer tick, asking Buildbucket for the build status
[16:32:18.445] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:18.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:12:0) after 1m0s
[16:33:18.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:12:0)
[16:33:18.495] Timer tick, asking Buildbucket for the build status
[16:33:18.607] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:18.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:13:0) after 1m0s
[16:34:18.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:13:0)
[16:34:18.871] Timer tick, asking Buildbucket for the build status
[16:34:19.250] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:19.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:14:0) after 1m0s
[16:35:19.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:14:0)
[16:35:19.462] Timer tick, asking Buildbucket for the build status
[16:35:19.530] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:19.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:15:0) after 1m0s
[16:36:19.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:15:0)
[16:36:19.738] Timer tick, asking Buildbucket for the build status
[16:36:19.867] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:19.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:16:0) after 1m0s
[16:37:19.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:16:0)
[16:37:19.940] Timer tick, asking Buildbucket for the build status
[16:37:20.071] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:20.071] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:17:0) after 1m0s
[16:38:20.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:17:0)
[16:38:20.279] Timer tick, asking Buildbucket for the build status
[16:38:20.394] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:20.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:18:0) after 1m0s
[16:39:20.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:18:0)
[16:39:20.423] Timer tick, asking Buildbucket for the build status
[16:39:20.499] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:20.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:19:0) after 1m0s
[16:40:20.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:19:0)
[16:40:20.571] Timer tick, asking Buildbucket for the build status
[16:40:20.678] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:20.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:20:0) after 1m0s
[16:41:20.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:20:0)
[16:41:20.723] Timer tick, asking Buildbucket for the build status
[16:41:20.840] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:20.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:21:0) after 1m0s
[16:42:20.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:21:0)
[16:42:20.950] Timer tick, asking Buildbucket for the build status
[16:42:21.069] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:21.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:22:0) after 1m0s
[16:43:21.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:22:0)
[16:43:21.178] Timer tick, asking Buildbucket for the build status
[16:43:21.262] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:21.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:23:0) after 1m0s
[16:44:21.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:23:0)
[16:44:21.284] Timer tick, asking Buildbucket for the build status
[16:44:21.359] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:21.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:24:0) after 1m0s
[16:45:21.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:24:0)
[16:45:21.432] Timer tick, asking Buildbucket for the build status
[16:45:21.593] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:21.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:25:0) after 1m0s
[16:46:21.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:25:0)
[16:46:21.605] Timer tick, asking Buildbucket for the build status
[16:46:21.826] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:21.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:26:0) after 1m0s
[16:47:21.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:26:0)
[16:47:21.900] Timer tick, asking Buildbucket for the build status
[16:47:21.979] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:21.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:27:0) after 1m0s
[16:48:22.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:27:0)
[16:48:22.095] Timer tick, asking Buildbucket for the build status
[16:48:22.452] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:22.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:28:0) after 1m0s
[16:49:22.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:28:0)
[16:49:22.553] Timer tick, asking Buildbucket for the build status
[16:49:22.865] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:22.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:29:0) after 1m0s
[16:50:22.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:29:0)
[16:50:22.922] Timer tick, asking Buildbucket for the build status
[16:50:23.041] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:23.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:30:0) after 1m0s
[16:51:23.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:30:0)
[16:51:23.065] Timer tick, asking Buildbucket for the build status
[16:51:23.197] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:23.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:31:0) after 1m0s
[16:52:23.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:31:0)
[16:52:23.212] Timer tick, asking Buildbucket for the build status
[16:52:23.517] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:23.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:32:0) after 1m0s
[16:53:23.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:32:0)
[16:53:23.534] Timer tick, asking Buildbucket for the build status
[16:53:23.637] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:23.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:33:0) after 1m0s
[16:54:23.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:33:0)
[16:54:23.687] Timer tick, asking Buildbucket for the build status
[16:54:23.975] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:23.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:34:0) after 1m0s
[16:55:24.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:34:0)
[16:55:24.055] Timer tick, asking Buildbucket for the build status
[16:55:24.319] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:24.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:35:0) after 1m0s
[16:56:24.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:35:0)
[16:56:24.357] Timer tick, asking Buildbucket for the build status
[16:56:24.677] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:24.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:36:0) after 1m0s
[16:57:24.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:36:0)
[16:57:24.746] Timer tick, asking Buildbucket for the build status
[16:57:24.834] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:24.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:37:0) after 1m0s
[16:58:24.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:37:0)
[16:58:24.867] Timer tick, asking Buildbucket for the build status
[16:58:24.971] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:24.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:38:0) after 1m0s
[16:59:24.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:38:0)
[16:59:24.996] Timer tick, asking Buildbucket for the build status
[16:59:25.240] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:25.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:39:0) after 1m0s
[17:00:25.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:39:0)
[17:00:25.300] Timer tick, asking Buildbucket for the build status
[17:00:25.525] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:25.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:40:0) after 1m0s
[17:01:25.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:40:0)
[17:01:25.559] Timer tick, asking Buildbucket for the build status
[17:01:26.247] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:26.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:41:0) after 1m0s
[17:02:26.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:41:0)
[17:02:26.272] Timer tick, asking Buildbucket for the build status
[17:02:26.645] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:26.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:42:0) after 1m0s
[17:03:26.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:42:0)
[17:03:26.679] Timer tick, asking Buildbucket for the build status
[17:03:26.835] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:26.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:43:0) after 1m0s
[17:04:26.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:43:0)
[17:04:26.858] Timer tick, asking Buildbucket for the build status
[17:04:27.263] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:27.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:44:0) after 1m0s
[17:05:27.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:44:0)
[17:05:27.281] Timer tick, asking Buildbucket for the build status
[17:05:27.755] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:27.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:45:0) after 1m0s
[17:06:27.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:45:0)
[17:06:27.759] Timer tick, asking Buildbucket for the build status
[17:06:28.058] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:28.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:46:0) after 1m0s
[17:07:28.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:46:0)
[17:07:28.095] Timer tick, asking Buildbucket for the build status
[17:07:28.192] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:28.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:47:0) after 1m0s
[17:08:28.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:47:0)
[17:08:28.256] Timer tick, asking Buildbucket for the build status
[17:08:28.391] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:28.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:48:0) after 1m0s
[17:09:28.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:48:0)
[17:09:28.522] Timer tick, asking Buildbucket for the build status
[17:09:28.682] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:28.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:49:0) after 1m0s
[17:10:28.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:49:0)
[17:10:28.710] Timer tick, asking Buildbucket for the build status
[17:10:29.149] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:29.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:50:0) after 1m0s
[17:11:29.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:50:0)
[17:11:29.211] Timer tick, asking Buildbucket for the build status
[17:11:29.347] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:29.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:51:0) after 1m0s
[17:12:29.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:51:0)
[17:12:29.597] Timer tick, asking Buildbucket for the build status
[17:12:29.720] Build 8855577090567061488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:29.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021007152648269984:52:0) after 1m0s
[17:12:51.966] Received PubSub notification, asking Buildbucket for the build status
[17:12:52.055] Build 8855577090567061488: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:12:52.055] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613063568399303",
"created_by": "project:chromium",
"created_ts": "1613060593978394",
"id": "8855577090567061488",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"501ab7679ed84882436733c5ae0189c0991cfa13\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"501ab7679ed84882436733c5ae0189c0991cfa13\", \"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-165-pzoq\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45334, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e9f42997b213f1b287aa31698e22b2bca6976853\", \"got_nacl_revision\": \"82ac8c0a6f0d3ffc843c693dd5149a356b866ae5\", \"got_revision\": \"501ab7679ed84882436733c5ae0189c0991cfa13\", \"got_revision_cp\": \"refs/heads/master@{#853139}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"673a7fe5c3ff6686c98951cafb24a93ca5bd1303\", \"got_v8_revision\": \"02d4d4b3a2d530260c6172e3af40729555ce5db7\", \"got_v8_revision_cp\": \"refs/heads/9.0.164@{#1}\", \"got_webrtc_revision\": \"f28d7e89b7a3c985d83f59d16b9f3c3f45ef7997\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33224}\", \"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\": \"501ab7679ed84882436733c5ae0189c0991cfa13\", \"swarm_hashes_refs/heads/master(at){#853139}_without_patch\": {\"absl_hardening_tests\": \"e90953cb5d9ccc83fcecbab05d801bc5fd5f26c0\", \"accessibility_unittests\": \"2c6f6f734ad1658022245b378759c5e0c1b32444\", \"angle_unittests\": \"8db89b0fe320c7a07296e4e6798c31466b23f272\", \"app_list_unittests\": \"4e2868fcd9c4078749ef7fde659815a6b69fd021\", \"app_shell_unittests\": \"80587759448e7085ecb253f65a1dad8e261a7844\", \"ash_unittests\": \"8ffd066cbccefd43269b7d6c6d28c71ed8376229\", \"aura_unittests\": \"8401c206c9be03ac0f4f7ec6e063cc77121d851f\", \"base_unittests\": \"39d7f6ace0098c26dfff944e1651bec364f9baca\", \"base_util_unittests\": \"dabc0b2055bc27deece97f874c259966d5a0a659\", \"blink_common_unittests\": \"c25a36249fc488df9547af03a7e05e72bc67f137\", \"blink_fuzzer_unittests\": \"8de56125f8aa389693826f5c7381faef79ed985d\", \"blink_heap_unittests\": \"3ef733dd01764962aec9313ae6e468276df16313\", \"blink_platform_unittests\": \"724d0979870f1bb43ca5bf5373f7c9e7bcc2a6fc\", \"blink_unittests\": \"0087964e4d9488673c41d1bef869a36384a0eebc\", \"boringssl_crypto_tests\": \"ec7190a5d5f6acb0de170d8f90120abd91459965\", \"boringssl_ssl_tests\": \"e8ae33a3e8ac2675f0e3d3176233b7d587c7cd1e\", \"browser_tests\": \"345cd8460f7e3df5904921b4e1edd64cd54ca116\", \"capture_unittests\": \"b37a01fc238520294f2844e7df27c8d161a47c2f\", \"cast_unittests\": \"9ade8483bead21faf889e3d32b19219f18f74530\", \"cc_unittests\": \"9057e2ab686981e0b898054bd503af0d93048090\", \"chrome_app_unittests\": \"04d29bfffd0a58e5dd263fdc68ee6a3b68651732\", \"chromedriver_unittests\": \"503fe7aa4c9b12429f8ac30c11fe99163551ffad\", \"chromeos_components_unittests\": \"653c942c84c7c23683db8d2b3bc9802b12bf22fa\", \"chromeos_unittests\": \"67c2a537aec967d9daec1e7602152253bcbe4561\", \"components_browsertests\": \"d0b63c215828acbb8f1911d7b852a56360afcc00\", \"components_unittests\": \"0512fc7c24959b3c2d553fab275aee0b6a119ce7\", \"compositor_unittests\": \"122b9c334c751c0223e7c478d40b6a94c75413d1\", \"content_browsertests\": \"f0d95976818e93b0fd02f1585325134406c4df98\", \"content_unittests\": \"48a480490526b08389170fba2056ec0c3fed7b73\", \"crashpad_tests\": \"7249ffae39e2bdc8e021cb539e47403b7458e240\", \"crypto_unittests\": \"31f6329c4ab3957712daf79730c6b45351d36c89\", \"dbus_unittests\": \"e70e43b7d56521c009d186c21f9b344b0589c166\", \"device_unittests\": \"ff0498bbbacdde4032f301990a93421f5b4828a0\", \"display_unittests\": \"4a686c57a1d1e8cb0dd802ff6cb8513469b831c2\", \"events_unittests\": \"8578daa442a09a4b9020aec4889260c5e03d5836\", \"exo_unittests\": \"aa26c7958e608a2ac83e2db1da209d14ab51a564\", \"extensions_browsertests\": \"ef0db71cfb487ff6c48c5a956ea8f956bf747e4e\", \"extensions_unittests\": \"ce760c2d1ac0ac06f0eef28bf02240c29a72509f\", \"filesystem_service_unittests\": \"c3b3b97275df5f46a75077d98faf17c4e41c4b6c\", \"gcm_unit_tests\": \"6b6016b4776d3ba58c56661a3207f38a43cc3b4f\", \"gfx_unittests\": \"7f7c271f5ce56451b1d19b4f2b25cc5cd73437fa\", \"gin_unittests\": \"152db61d83b0c3f0c526d241dc118ba33a07ba08\", \"gl_unittests_ozone\": \"5f58660075b4e2672fef712455a2b24a849aaaa2\", \"google_apis_unittests\": \"e660cd429aa0e13afc364352bd5116fed01dd2a7\", \"gpu_unittests\": \"b270331cc798a1a4a42f40f81bcc15571176c17d\", \"gwp_asan_unittests\": \"a831bb84bd032e318b2a64b833e1a66f746d51ae\", \"interactive_ui_tests\": \"acaa9d557b0de6d642f189dc9c6f0baa2853db10\", \"ipc_tests\": \"712e6dd3e4ff57da3ce4a82a0bc213b8fdd541ad\", \"jingle_unittests\": \"e6e5eec903de4db99a9fac36bd80fce4e55a6cb1\", \"keyboard_unittests\": \"2abbe8615db2ff47abf4f308535c82e2d4319901\", \"latency_unittests\": \"bc4a09e49b0644630a596c799e009e7b54794fa9\", \"libjingle_xmpp_unittests\": \"7d243c2425e7977faec6e25ae587954b5bd1d2d6\", \"liburlpattern_unittests\": \"1eb3b604bd014800d58ced3adaea0ae7166a718c\", \"media_blink_unittests\": \"b531ec73fba5b9d58a562bfd75d5791e70443758\", \"media_unittests\": \"25b4fb3969a383ebf83358a2967e91373e86a27b\", \"message_center_unittests\": \"e5f6bff1d33c5af611622680b559c2654c4133e5\", \"midi_unittests\": \"85b326e1b6c2f52fa3bc6fc369cb2328666b5097\", \"mojo_core_unittests\": \"fdb3fbf5679f3abca42f2dcb4635316b555b40d6\", \"mojo_unittests\": \"f98882bcd27b37a2de65932b075ef6f1939eece7\", \"nacl_helper_nonsfi_unittests\": \"c05cf7c44a3ada13e0d17f63b0f268b748ca1e6f\", \"nacl_loader_unittests\": \"69c1f1a92432bc654ed7177a7b58e60d601ea541\", \"native_theme_unittests\": \"0dcd67179d723fe4abf4544f7526ea6606abe258\", \"net_unittests\": \"1397e82437cc339a34f0f3a3bf64309e71b9c4ab\", \"ozone_gl_unittests\": \"be523b2ab577774a5798ca03eaeb89d221b72186\", \"ozone_unittests\": \"f45ea6f3edb70d45a9022ac55f8d6d27a57f67c7\", \"ozone_x11_unittests\": \"b769a4ad23aade7d60cc3022ab5d1edb293b3e7d\", \"pdf_unittests\": \"95ccf11e33dff89318a0cefa6f9eeae49fc1002b\", \"perfetto_unittests\": \"e5129e792312fd03b3b8cc8d31069cb8be691c5c\", \"ppapi_unittests\": \"8881329596e5a890c795476de65ae893cd0ad2a1\", \"printing_unittests\": \"f2728a640b5fd6d54f4d15846773cb3f167106ea\", \"remoting_unittests\": \"590d3db5d8c62d9a9ea3142942be2e2f03cb25bc\", \"sandbox_linux_unittests\": \"ac4aaeff58dd7fabda0dc76fc93ea1af82e3690d\", \"service_manager_unittests\": \"b94f81e949e052faf43cd75cba52deb5910af9d0\", \"services_unittests\": \"f654b516795ea4e305bdcb90fef8b6d630227351\", \"shell_dialogs_unittests\": \"4ca2e7f2d6710a5205e61801f09431833892fd38\", \"shell_encryption_unittests\": \"393403f65cb8fdaa8120d99135b345a0792fb8ac\", \"skia_unittests\": \"cda62e87aa37997daf44bbae3b384a4e05f88ce6\", \"snapshot_unittests\": \"f16664ccd43d4c392190858fd9aa60d5a0c51379\", \"sql_unittests\": \"bf03a195a8803d4f7e4204c2e9db54e8786975fd\", \"storage_unittests\": \"a05ee55030695cbef65ce398fc1f7de70cf0f9bc\", \"sync_integration_tests\": \"42af351cc276e1464fa2a96a736fab451f6fd5f8\", \"traffic_annotation_auditor_unittests\": \"4220e6e86170688a4dc10a4a1060ba149b5774d9\", \"ui_base_unittests\": \"5defb28d5a33bc82711942b7d335bbd2d56baf8c\", \"ui_chromeos_unittests\": \"b24b6dbdbff08f4fe9cb8331fc1e1dfec29e39aa\", \"ui_touch_selection_unittests\": \"73e6a4d1fafa86bf624c42458ee4a06cbde70071\", \"unit_tests\": \"e5c9dcae2a93d125cdfde377d6c49e5083eabc6e\", \"url_unittests\": \"a4c1358cb8368268153f7fc0c9d1265e273170de\", \"usage_time_limit_unittests\": \"697234b6509660ff24b88dbef24bef5d52cadf4e\", \"views_unittests\": \"3e652d1d67c76e3fa0955fd75862993cca303e9a\", \"viz_unittests\": \"581e46171e1362546448a097fbad782027090915\", \"wayland_client_perftests\": \"ee03cb643e9e82ee59bfb40090be7bdc1b0241ba\", \"wm_unittests\": \"dfcee1972bd5887f33546b171b6501e3cfdc301a\", \"wtf_unittests\": \"26f2f5d4bc8979ac018231efb01e3c46795082ac\", \"zlib_unittests\": \"8622a887888a83021763980165b7ef30f1d036eb\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_17616f83fd632132c65ea3dd60ce01b78f71f01fa76c3e3446f88a64858a3864_v2\", \"builder_578c225c2c50d5653cce8ddfaab266952737b31d66b6113fbb64cc6f5229aebd_v2\", \"builder_81975214af25fe3c157931ccf4182e1c4ae2635ce20b925a941b30b87e2fcb1d_v2\", \"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_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-165-pzoq\"], \"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\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613060595796215",
"status": "COMPLETED",
"status_changed_ts": "1613063568847496",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45334",
"builder:linux-chromeos-rel",
"buildset:commit/git/501ab7679ed84882436733c5ae0189c0991cfa13",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/501ab7679ed84882436733c5ae0189c0991cfa13",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021007152648269984",
"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/8855577090567061488/+/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:51aab8e410ae5510",
"user_agent:luci-scheduler"
],
"updated_ts": "1613063568853367",
"url": "https://ci.chromium.org/b/8855577090567061488",
"utcnow_ts": "1613063572041383"
}
}
[17:12:52.055] Invocation finished in 49m39.445353234s with status SUCCEEDED