[01:22:02.068] New invocation is queued and will start shortly
[01:22:03.136] Starting the invocation (attempt 1)
[01:22:03.169] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:22:03.170] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:22:03.170] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019976686139252400",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8e4bf6625f1231ea20d53ebbe890ea2b42e76765\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9019976686139252400",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/8e4bf6625f1231ea20d53ebbe890ea2b42e76765",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e4bf6625f1231ea20d53ebbe890ea2b42e76765",
"gitiles_ref:refs/heads/master"
]
}
[01:22:04.854] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614043323312167",
"id": "8854546624172855840",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e4bf6625f1231ea20d53ebbe890ea2b42e76765\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614043324521914",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45645",
"builder:linux-chromeos-rel",
"buildset:commit/git/8e4bf6625f1231ea20d53ebbe890ea2b42e76765",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e4bf6625f1231ea20d53ebbe890ea2b42e76765",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019976686139252400",
"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/8854546624172855840/+/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": "1614043324522053",
"url": "https://ci.chromium.org/b/8854546624172855840",
"utcnow_ts": "1614043324837276"
}
}
[01:22:04.854] Task URL: https://ci.chromium.org/b/8854546624172855840
[01:22:04.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:2:0) after 1m0s
[01:22:08.498] Received PubSub notification, asking Buildbucket for the build status
[01:22:08.593] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:04.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:2:0)
[01:23:04.920] Timer tick, asking Buildbucket for the build status
[01:23:05.022] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:05.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:4:0) after 1m0s
[01:24:05.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:4:0)
[01:24:05.015] Timer tick, asking Buildbucket for the build status
[01:24:05.095] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:05.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:5:0) after 1m0s
[01:25:05.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:5:0)
[01:25:05.067] Timer tick, asking Buildbucket for the build status
[01:25:05.152] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:05.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:6:0) after 1m0s
[01:26:05.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:6:0)
[01:26:05.235] Timer tick, asking Buildbucket for the build status
[01:26:05.318] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:05.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:7:0) after 1m0s
[01:27:05.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:7:0)
[01:27:05.363] Timer tick, asking Buildbucket for the build status
[01:27:05.451] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:05.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:8:0) after 1m0s
[01:28:05.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:8:0)
[01:28:05.504] Timer tick, asking Buildbucket for the build status
[01:28:05.662] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:05.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:9:0) after 1m0s
[01:29:05.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:9:0)
[01:29:05.760] Timer tick, asking Buildbucket for the build status
[01:29:06.056] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:06.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:10:0) after 1m0s
[01:30:06.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:10:0)
[01:30:06.134] Timer tick, asking Buildbucket for the build status
[01:30:06.247] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:06.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:11:0) after 1m0s
[01:31:06.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:11:0)
[01:31:06.282] Timer tick, asking Buildbucket for the build status
[01:31:06.626] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:06.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:12:0) after 1m0s
[01:32:06.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:12:0)
[01:32:06.647] Timer tick, asking Buildbucket for the build status
[01:32:06.908] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:06.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:13:0) after 1m0s
[01:33:07.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:13:0)
[01:33:07.043] Timer tick, asking Buildbucket for the build status
[01:33:07.150] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:07.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:14:0) after 1m0s
[01:34:07.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:14:0)
[01:34:07.290] Timer tick, asking Buildbucket for the build status
[01:34:07.389] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:07.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:15:0) after 1m0s
[01:35:07.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:15:0)
[01:35:07.477] Timer tick, asking Buildbucket for the build status
[01:35:07.951] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:07.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:16:0) after 1m0s
[01:36:08.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:16:0)
[01:36:08.041] Timer tick, asking Buildbucket for the build status
[01:36:08.204] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:08.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:17:0) after 1m0s
[01:37:08.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:17:0)
[01:37:08.297] Timer tick, asking Buildbucket for the build status
[01:37:08.409] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:08.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:18:0) after 1m0s
[01:38:08.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:18:0)
[01:38:08.482] Timer tick, asking Buildbucket for the build status
[01:38:08.573] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:08.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:19:0) after 1m0s
[01:39:08.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:19:0)
[01:39:08.651] Timer tick, asking Buildbucket for the build status
[01:39:08.743] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:08.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:20:0) after 1m0s
[01:40:08.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:20:0)
[01:40:08.764] Timer tick, asking Buildbucket for the build status
[01:40:08.919] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:08.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:21:0) after 1m0s
[01:41:08.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:21:0)
[01:41:08.961] Timer tick, asking Buildbucket for the build status
[01:41:09.094] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:09.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:22:0) after 1m0s
[01:42:09.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:22:0)
[01:42:09.190] Timer tick, asking Buildbucket for the build status
[01:42:09.285] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:09.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:23:0) after 1m0s
[01:43:09.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:23:0)
[01:43:09.452] Timer tick, asking Buildbucket for the build status
[01:43:09.604] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:09.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:24:0) after 1m0s
[01:44:09.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:24:0)
[01:44:09.596] Timer tick, asking Buildbucket for the build status
[01:44:09.681] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:09.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:25:0) after 1m0s
[01:45:09.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:25:0)
[01:45:09.681] Timer tick, asking Buildbucket for the build status
[01:45:10.064] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:10.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:26:0) after 1m0s
[01:46:10.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:26:0)
[01:46:10.107] Timer tick, asking Buildbucket for the build status
[01:46:10.231] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:10.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:27:0) after 1m0s
[01:47:10.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:27:0)
[01:47:10.252] Timer tick, asking Buildbucket for the build status
[01:47:10.378] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:10.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:28:0) after 1m0s
[01:48:10.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:28:0)
[01:48:10.412] Timer tick, asking Buildbucket for the build status
[01:48:10.589] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:10.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:29:0) after 1m0s
[01:49:10.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:29:0)
[01:49:10.634] Timer tick, asking Buildbucket for the build status
[01:49:10.747] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:10.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:30:0) after 1m0s
[01:50:10.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:30:0)
[01:50:10.736] Timer tick, asking Buildbucket for the build status
[01:50:10.831] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:10.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:31:0) after 1m0s
[01:51:10.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:31:0)
[01:51:10.832] Timer tick, asking Buildbucket for the build status
[01:51:11.061] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:11.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:32:0) after 1m0s
[01:52:11.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:32:0)
[01:52:11.098] Timer tick, asking Buildbucket for the build status
[01:52:11.196] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:11.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:33:0) after 1m0s
[01:53:11.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:33:0)
[01:53:11.260] Timer tick, asking Buildbucket for the build status
[01:53:11.658] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:11.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:34:0) after 1m0s
[01:54:11.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:34:0)
[01:54:11.722] Timer tick, asking Buildbucket for the build status
[01:54:11.839] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:11.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:35:0) after 1m0s
[01:55:11.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:35:0)
[01:55:11.951] Timer tick, asking Buildbucket for the build status
[01:55:12.230] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:12.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:36:0) after 1m0s
[01:56:12.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:36:0)
[01:56:12.226] Timer tick, asking Buildbucket for the build status
[01:56:12.321] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:12.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:37:0) after 1m0s
[01:57:12.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:37:0)
[01:57:12.449] Timer tick, asking Buildbucket for the build status
[01:57:12.639] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:12.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:38:0) after 1m0s
[01:58:12.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:38:0)
[01:58:12.654] Timer tick, asking Buildbucket for the build status
[01:58:12.804] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:12.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:39:0) after 1m0s
[01:59:12.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:39:0)
[01:59:12.893] Timer tick, asking Buildbucket for the build status
[01:59:12.971] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:12.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:40:0) after 1m0s
[02:00:13.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:40:0)
[02:00:13.119] Timer tick, asking Buildbucket for the build status
[02:00:13.256] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:13.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:41:0) after 1m0s
[02:01:13.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:41:0)
[02:01:13.347] Timer tick, asking Buildbucket for the build status
[02:01:13.457] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:13.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:42:0) after 1m0s
[02:02:13.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:42:0)
[02:02:13.891] Timer tick, asking Buildbucket for the build status
[02:02:14.079] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:14.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:43:0) after 1m0s
[02:03:14.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:43:0)
[02:03:14.302] Timer tick, asking Buildbucket for the build status
[02:03:14.911] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:14.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:44:0) after 1m0s
[02:04:15.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:44:0)
[02:04:15.005] Timer tick, asking Buildbucket for the build status
[02:04:15.218] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:15.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:45:0) after 1m0s
[02:05:15.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:45:0)
[02:05:15.267] Timer tick, asking Buildbucket for the build status
[02:05:15.692] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:15.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:46:0) after 1m0s
[02:06:15.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:46:0)
[02:06:15.761] Timer tick, asking Buildbucket for the build status
[02:06:15.973] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:15.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:47:0) after 1m0s
[02:07:16.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:47:0)
[02:07:16.026] Timer tick, asking Buildbucket for the build status
[02:07:16.188] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:16.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:48:0) after 1m0s
[02:08:16.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:48:0)
[02:08:16.235] Timer tick, asking Buildbucket for the build status
[02:08:16.316] Build 8854546624172855840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:16.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019976686139252400:49:0) after 1m0s
[02:09:12.191] Received PubSub notification, asking Buildbucket for the build status
[02:09:12.402] Build 8854546624172855840: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:09:12.402] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614046151240567",
"created_by": "project:chromium",
"created_ts": "1614043323312167",
"id": "8854546624172855840",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e4bf6625f1231ea20d53ebbe890ea2b42e76765\"}}",
"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\": \"8e4bf6625f1231ea20d53ebbe890ea2b42e76765\", \"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-east1-d-8-23-98xn\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45645, \"got_angle_revision\": \"4a95488c0edfb4590c808ee01079069da5a6b2b1\", \"got_dawn_revision\": \"2d3c2e355337037dfa6873536bfb3e3a558bf9ed\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"8e4bf6625f1231ea20d53ebbe890ea2b42e76765\", \"got_revision_cp\": \"refs/heads/master@{#856546}\", \"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\": \"8e4bf6625f1231ea20d53ebbe890ea2b42e76765\", \"swarm_hashes_refs/heads/master(at){#856546}_without_patch\": {\"absl_hardening_tests\": \"3c9dd4826c8c4ccb318415964985f914e5ce86cb\", \"accessibility_unittests\": \"f276914ee696616cf1796d84fe85b558e9ce2ba4\", \"angle_unittests\": \"66ddb5f95106e1aa167e9360ab01a2c5c30141b0\", \"app_list_unittests\": \"9676b2b3d80ea58e88efb77d2ed4785a0b037619\", \"app_shell_unittests\": \"e2945f1bbe7a7eb06feb03e241f5786d967a2a34\", \"ash_unittests\": \"d19ebb455839ebf8a45ac5a963d196527104a82c\", \"aura_unittests\": \"c8c3635d68a45132b57f7c3f1ad69b1f020465db\", \"base_unittests\": \"2f65068c52c82fd7f726207d5ffdb19f5893d633\", \"base_util_unittests\": \"593fe48f705ac661ab4a13573c98851530f796b1\", \"blink_common_unittests\": \"2ce28d3b1414b36128d524b72649f3defb59ab0c\", \"blink_fuzzer_unittests\": \"83548d88e9ea8d8789df0e5e02ec0757829005e6\", \"blink_heap_unittests\": \"00cc59e02572e18e9674a1b5843d1a4c7df9b059\", \"blink_platform_unittests\": \"5acb6eadf708207cc217ae3f6aee84d2dc7c2a84\", \"blink_unittests\": \"af91eb362d8fd12f02a85bfc4cc23dc4e08390e5\", \"boringssl_crypto_tests\": \"daa0263a682720a16b6b10fe8a47c9d059576e02\", \"boringssl_ssl_tests\": \"ab4d22d30a37855f9635bd40ced5d0b3495acbb1\", \"browser_tests\": \"ba2e0779392bc65090816e1021cf5ed959475357\", \"capture_unittests\": \"5f3a7f34b5bf4c213401fd1c941962c9e9e56d2a\", \"cast_unittests\": \"8d9346636dc8fe0674824b0a81c1d77fa6817bb7\", \"cc_unittests\": \"645c03fbc595d8276f41115d72cd02652ece8492\", \"chrome_app_unittests\": \"dfa6c890ad0730f94e0b195bca0eb67217db5c7d\", \"chromedriver_unittests\": \"61d1c71f2dffce6f0da5e8c9179d7c57e2efa90f\", \"chromeos_components_unittests\": \"4ca41202300336be9f56316eefbbdc28df0baac5\", \"chromeos_unittests\": \"8d3423d4b240930efda6e8604cccbbc04d80c462\", \"components_browsertests\": \"7e2100f939262e101cac819b5fe63917c9c527bc\", \"components_unittests\": \"b61091b5ca5bb7d67eaf1fa789c04e41281f4436\", \"compositor_unittests\": \"7ed9628ba610db1c65951c483e5405aee066099c\", \"content_browsertests\": \"95a59775799d73af484da14ecaff3c02f2db5fc3\", \"content_unittests\": \"53c4d1466b31a2680b8c1c15ecc4154e964b5330\", \"crashpad_tests\": \"bea33522882e4ec4252b663002a1dfd539dae484\", \"crypto_unittests\": \"c0314ba79acac3e4652c583b8d3dab341c18a1ba\", \"dbus_unittests\": \"c27090b5f95da29d2ec8d6962aba6e5c249d9b87\", \"device_unittests\": \"be324f5695d219f85260300f2562d9d72ab768db\", \"display_unittests\": \"110ef14dd8c0b23e3663ba27a6d9affe916be8c1\", \"events_unittests\": \"ae312f286e614cf4b0146c78d131443ee1f2a5d9\", \"exo_unittests\": \"987adcd9f472f1b4f01860f185034215c8dc973f\", \"extensions_browsertests\": \"eab2a57df3f478a4b95f028baccca3fa186a65f9\", \"extensions_unittests\": \"d1d9c1323e9d46833bdae297d52d0de491081bdc\", \"filesystem_service_unittests\": \"830e213a3820d9f0a6153ce897687646c7f81ae6\", \"gcm_unit_tests\": \"81eaf8d498b2d5cf2222604ef63c87cba6b03da4\", \"gfx_unittests\": \"8709f49e49cfa0d7f091849b8ba161a62230314a\", \"gin_unittests\": \"6513a35925a005af0f91aa23dcc93cad9c44c3f6\", \"gl_unittests_ozone\": \"fac01a2d4b0b57c3bf895ae234236ab0e166a272\", \"google_apis_unittests\": \"bb0cdf4b9882fc527abc5eaddf6de799278f5168\", \"gpu_unittests\": \"9dc43e537739ec754095412e97e5f2cf952e81eb\", \"gwp_asan_unittests\": \"5ae64a5423f55d6001b438525641fdea425dce4f\", \"interactive_ui_tests\": \"4aa5288f5bfb1de8e93af0037e28b6d449107a9d\", \"ipc_tests\": \"b20e2e061e97b1cdce8f09cd4cb5d4bebef89070\", \"jingle_unittests\": \"dd8e500e545515960e7809c6a6e0db2703e38313\", \"keyboard_unittests\": \"1032298ea65318bc19c9f8531608a563cd89940f\", \"latency_unittests\": \"bffc4462db039d14327559776b46e3817cdf0089\", \"libjingle_xmpp_unittests\": \"1fc05fce2e990c5180f0679ba6ee3eebccf8c792\", \"liburlpattern_unittests\": \"358bb1e5b18275939432edb50ce11cad0ad58b40\", \"media_blink_unittests\": \"0af3b81de563410d592886393322f9856305f4f8\", \"media_unittests\": \"16ae979810bfa4a9768c0df9a0cc30630268ca2f\", \"message_center_unittests\": \"5337fb262470a40034cab4c2843851783c9c5abf\", \"midi_unittests\": \"a3c82d016dbf6c3cd295ab9ca9170f10dc288ad6\", \"mojo_core_unittests\": \"4a81f675a7f3a1a63659d59092b795ac2e63fe55\", \"mojo_unittests\": \"4c8df6e04432840a61d73ae9f45e129a0f20a684\", \"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\": \"f4dcc6f1adf468fa1d3300f57e0ce3bb73bcd236\", \"perfetto_unittests\": \"f62ba088519aff6ecacfe02237deba4c0f39d895\", \"ppapi_unittests\": \"18518c5867055f49589df75ce4882f609ce77618\", \"printing_unittests\": \"4199624771c85c63cad77617f88c94ff98c9d4e4\", \"remoting_unittests\": \"bbacb9f088732f5f951fb368e0a207127cfe0380\", \"sandbox_linux_unittests\": \"c95c343c6a88804b0704598c5e4e545c3968a25a\", \"service_manager_unittests\": \"11c00d5ec9bf3615141237bf0020b81c2f098abd\", \"services_unittests\": \"2dbb7e8c837ae7c33f1a85db203ff839624125cd\", \"shell_dialogs_unittests\": \"5d7ead790a574b06e9501fbe2abe8e14f1720bc9\", \"shell_encryption_unittests\": \"38b00278a809a9cb555d94d7ab8c1fc3b77296db\", \"skia_unittests\": \"1c970bda4bbe72e2bae337d95c77a24e1cf31bb7\", \"snapshot_unittests\": \"5a8d760f695ecaaef0342902654f9f22cff29e07\", \"sql_unittests\": \"443fd91f92e078c1ff3632b7d27c97f0560c6309\", \"storage_unittests\": \"78ae624e8cb1cc396bcdf8a2ade8d6f3613b574c\", \"sync_integration_tests\": \"c21563fbcfccf4327cf5c3b7ab0dc0fb7f1e2c13\", \"traffic_annotation_auditor_unittests\": \"e85fb08347aeb7dc3a4dbbb796948fa2e77e2d8d\", \"ui_base_unittests\": \"40899d845d6b9b500c3a29e83e7471a951972377\", \"ui_chromeos_unittests\": \"421e28b0b1e856eab14352aef6798190efd3883a\", \"ui_touch_selection_unittests\": \"bc3a3fc0b481852f7de23b025ed09329431e1581\", \"unit_tests\": \"9eb1016f45fdaf8cabf53a0e51690dfa894c3bf2\", \"url_unittests\": \"e409c10b884e7f63dc85da7544444632cf538a93\", \"usage_time_limit_unittests\": \"c872d4fa4a5ec619054f3417424a5a3d22573e20\", \"views_unittests\": \"1b8485a411942ab5e824cced22677b8403edcbfd\", \"viz_unittests\": \"3ac425b14d63fa1e486f52650f33a9fe3459886b\", \"wayland_client_perftests\": \"b9b534073aeed16ea0edcce63309e6bc2e2df786\", \"wm_unittests\": \"123b47197dbe02131fad2d8483e38bebda79a970\", \"wtf_unittests\": \"2c7e764b73202c4c38ffcc6b59d17ca15bebb406\", \"zlib_unittests\": \"b24526bc66621bcd565d889fb7c11a0bf703f430\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2bbcd421f4eb1113f3a23522b280d70ced47ef846cc2e40eada60721dff8d17e_v2\", \"builder_6e4a31244c7251e88cf04b6a466eafe8dff7b745833b61f340cac0d6618c3644_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_cb8f28a5d59bb80cbafed89b56af03ba2ea85f5e24941631d330b6bd1d886cb5_v2\", \"builder_e9d7d0a19fc068adf341a224b6eb4c464e3f53ed9d47979ef0c80d8aa2ba711c_v2\", \"builder_f0afc432815c064941e1e5f998abb72673d4068febb53723f4aedad56e1b9c62_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-east1-d-8-23-98xn\"], \"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-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614043326859391",
"status": "COMPLETED",
"status_changed_ts": "1614046151661657",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45645",
"builder:linux-chromeos-rel",
"buildset:commit/git/8e4bf6625f1231ea20d53ebbe890ea2b42e76765",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e4bf6625f1231ea20d53ebbe890ea2b42e76765",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019976686139252400",
"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/8854546624172855840/+/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:51e54c2f000e1a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614046151666413",
"url": "https://ci.chromium.org/b/8854546624172855840",
"utcnow_ts": "1614046152385696"
}
}
[02:09:12.402] Invocation finished in 47m10.349702064s with status SUCCEEDED