[16:38:27.549] New invocation is queued and will start shortly
[16:38:28.849] Starting the invocation (attempt 1)
[16:38:28.916] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:38:28.917] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:38:28.917] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021912162975608640",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1385e9abed79659f3792fa26fa12bf56eeb8aacb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9021912162975608640",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/1385e9abed79659f3792fa26fa12bf56eeb8aacb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1385e9abed79659f3792fa26fa12bf56eeb8aacb",
"gitiles_ref:refs/heads/master"
]
}
[16:38:29.877] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612197509053480",
"id": "8856482100704972176",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1385e9abed79659f3792fa26fa12bf56eeb8aacb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612197509613376",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45060",
"builder:linux-chromeos-rel",
"buildset:commit/git/1385e9abed79659f3792fa26fa12bf56eeb8aacb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1385e9abed79659f3792fa26fa12bf56eeb8aacb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021912162975608640",
"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/8856482100704972176/+/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": "1612197509613522",
"url": "https://ci.chromium.org/b/8856482100704972176",
"utcnow_ts": "1612197509868992"
}
}
[16:38:29.877] Task URL: https://ci.chromium.org/b/8856482100704972176
[16:38:29.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:2:0) after 1m0s
[16:38:33.104] Received PubSub notification, asking Buildbucket for the build status
[16:38:33.196] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:29.861] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:2:0)
[16:39:29.861] Timer tick, asking Buildbucket for the build status
[16:39:29.976] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:29.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:4:0) after 1m0s
[16:40:30.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:4:0)
[16:40:30.082] Timer tick, asking Buildbucket for the build status
[16:40:30.159] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:30.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:5:0) after 1m0s
[16:41:30.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:5:0)
[16:41:30.247] Timer tick, asking Buildbucket for the build status
[16:41:30.536] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:30.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:6:0) after 1m0s
[16:42:30.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:6:0)
[16:42:30.793] Timer tick, asking Buildbucket for the build status
[16:42:30.967] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:30.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:7:0) after 1m0s
[16:43:31.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:7:0)
[16:43:31.054] Timer tick, asking Buildbucket for the build status
[16:43:31.145] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:31.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:8:0) after 1m0s
[16:44:31.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:8:0)
[16:44:31.209] Timer tick, asking Buildbucket for the build status
[16:44:31.358] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:31.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:9:0) after 1m0s
[16:45:31.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:9:0)
[16:45:31.466] Timer tick, asking Buildbucket for the build status
[16:45:32.188] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:32.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:10:0) after 1m0s
[16:46:32.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:10:0)
[16:46:32.248] Timer tick, asking Buildbucket for the build status
[16:46:32.413] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:32.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:11:0) after 1m0s
[16:47:32.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:11:0)
[16:47:32.438] Timer tick, asking Buildbucket for the build status
[16:47:32.758] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:32.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:12:0) after 1m0s
[16:48:32.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:12:0)
[16:48:32.826] Timer tick, asking Buildbucket for the build status
[16:48:32.956] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:32.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:13:0) after 1m0s
[16:49:33.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:13:0)
[16:49:33.043] Timer tick, asking Buildbucket for the build status
[16:49:33.127] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:33.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:14:0) after 1m0s
[16:50:33.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:14:0)
[16:50:33.514] Timer tick, asking Buildbucket for the build status
[16:50:33.760] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:33.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:15:0) after 1m0s
[16:51:33.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:15:0)
[16:51:33.779] Timer tick, asking Buildbucket for the build status
[16:51:33.842] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:33.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:16:0) after 1m0s
[16:52:33.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:16:0)
[16:52:33.864] Timer tick, asking Buildbucket for the build status
[16:52:33.919] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:33.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:17:0) after 1m0s
[16:53:33.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:17:0)
[16:53:33.924] Timer tick, asking Buildbucket for the build status
[16:53:34.076] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:34.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:18:0) after 1m0s
[16:54:34.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:18:0)
[16:54:34.118] Timer tick, asking Buildbucket for the build status
[16:54:34.198] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:34.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:19:0) after 1m0s
[16:55:34.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:19:0)
[16:55:34.276] Timer tick, asking Buildbucket for the build status
[16:55:34.639] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:34.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:20:0) after 1m0s
[16:56:34.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:20:0)
[16:56:34.674] Timer tick, asking Buildbucket for the build status
[16:56:34.737] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:34.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:21:0) after 1m0s
[16:57:34.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:21:0)
[16:57:34.806] Timer tick, asking Buildbucket for the build status
[16:57:34.881] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:34.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:22:0) after 1m0s
[16:58:34.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:22:0)
[16:58:34.975] Timer tick, asking Buildbucket for the build status
[16:58:35.364] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:35.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:23:0) after 1m0s
[16:59:35.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:23:0)
[16:59:35.509] Timer tick, asking Buildbucket for the build status
[16:59:35.794] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:35.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:24:0) after 1m0s
[17:00:35.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:24:0)
[17:00:35.882] Timer tick, asking Buildbucket for the build status
[17:00:35.987] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:35.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:25:0) after 1m0s
[17:01:36.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:25:0)
[17:01:36.025] Timer tick, asking Buildbucket for the build status
[17:01:36.103] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:36.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:26:0) after 1m0s
[17:02:36.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:26:0)
[17:02:36.205] Timer tick, asking Buildbucket for the build status
[17:02:36.296] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:36.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:27:0) after 1m0s
[17:03:36.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:27:0)
[17:03:36.335] Timer tick, asking Buildbucket for the build status
[17:03:36.471] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:36.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:28:0) after 1m0s
[17:04:36.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:28:0)
[17:04:36.505] Timer tick, asking Buildbucket for the build status
[17:04:36.636] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:36.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:29:0) after 1m0s
[17:05:36.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:29:0)
[17:05:36.743] Timer tick, asking Buildbucket for the build status
[17:05:36.823] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:36.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:30:0) after 1m0s
[17:06:36.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:30:0)
[17:06:36.904] Timer tick, asking Buildbucket for the build status
[17:06:36.984] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:36.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:31:0) after 1m0s
[17:07:37.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:31:0)
[17:07:37.052] Timer tick, asking Buildbucket for the build status
[17:07:37.178] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:37.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:32:0) after 1m0s
[17:08:37.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:32:0)
[17:08:37.287] Timer tick, asking Buildbucket for the build status
[17:08:37.441] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:37.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:33:0) after 1m0s
[17:09:37.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:33:0)
[17:09:37.502] Timer tick, asking Buildbucket for the build status
[17:09:37.572] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:37.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:34:0) after 1m0s
[17:10:37.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:34:0)
[17:10:37.626] Timer tick, asking Buildbucket for the build status
[17:10:37.688] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:37.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:35:0) after 1m0s
[17:11:37.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:35:0)
[17:11:37.780] Timer tick, asking Buildbucket for the build status
[17:11:38.217] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:38.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:36:0) after 1m0s
[17:12:38.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:36:0)
[17:12:38.322] Timer tick, asking Buildbucket for the build status
[17:12:38.913] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:38.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:37:0) after 1m0s
[17:13:39.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:37:0)
[17:13:39.042] Timer tick, asking Buildbucket for the build status
[17:13:39.285] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:39.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:38:0) after 1m0s
[17:14:39.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:38:0)
[17:14:39.325] Timer tick, asking Buildbucket for the build status
[17:14:39.389] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:39.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:39:0) after 1m0s
[17:15:39.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:39:0)
[17:15:39.490] Timer tick, asking Buildbucket for the build status
[17:15:39.641] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:39.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:40:0) after 1m0s
[17:16:39.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:40:0)
[17:16:39.717] Timer tick, asking Buildbucket for the build status
[17:16:39.853] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:39.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:41:0) after 1m0s
[17:17:39.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:41:0)
[17:17:39.872] Timer tick, asking Buildbucket for the build status
[17:17:40.334] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:40.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:42:0) after 1m0s
[17:18:40.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:42:0)
[17:18:40.401] Timer tick, asking Buildbucket for the build status
[17:18:40.527] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:40.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:43:0) after 1m0s
[17:19:40.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:43:0)
[17:19:40.623] Timer tick, asking Buildbucket for the build status
[17:19:40.768] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:40.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:44:0) after 1m0s
[17:20:40.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:44:0)
[17:20:40.843] Timer tick, asking Buildbucket for the build status
[17:20:41.717] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:41.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:45:0) after 1m0s
[17:21:41.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:45:0)
[17:21:41.812] Timer tick, asking Buildbucket for the build status
[17:21:43.134] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:43.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:46:0) after 1m0s
[17:22:43.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:46:0)
[17:22:43.172] Timer tick, asking Buildbucket for the build status
[17:22:43.342] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:43.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:47:0) after 1m0s
[17:23:43.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:47:0)
[17:23:43.361] Timer tick, asking Buildbucket for the build status
[17:23:43.506] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:43.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:48:0) after 1m0s
[17:24:43.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:48:0)
[17:24:43.526] Timer tick, asking Buildbucket for the build status
[17:24:43.627] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:43.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:49:0) after 1m0s
[17:25:43.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:49:0)
[17:25:43.738] Timer tick, asking Buildbucket for the build status
[17:25:43.914] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:43.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:50:0) after 1m0s
[17:26:43.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:50:0)
[17:26:43.956] Timer tick, asking Buildbucket for the build status
[17:26:44.122] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:44.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:51:0) after 1m0s
[17:27:44.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:51:0)
[17:27:44.177] Timer tick, asking Buildbucket for the build status
[17:27:44.346] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:44.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:52:0) after 1m0s
[17:28:44.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:52:0)
[17:28:44.396] Timer tick, asking Buildbucket for the build status
[17:28:44.927] Build 8856482100704972176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:44.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021912162975608640:53:0) after 1m0s
[17:29:33.324] Received PubSub notification, asking Buildbucket for the build status
[17:29:33.490] Build 8856482100704972176: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:29:33.490] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612200571940000",
"created_by": "project:chromium",
"created_ts": "1612197509053480",
"id": "8856482100704972176",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1385e9abed79659f3792fa26fa12bf56eeb8aacb\"}}",
"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\": \"1385e9abed79659f3792fa26fa12bf56eeb8aacb\", \"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-208-9ccp\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45060, \"got_angle_revision\": \"85a9ec10b18fdb9cabb8177d95892e46d7abcc87\", \"got_dawn_revision\": \"d7aacdda1119d419ce886f9ba4b9401de2834bed\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"1385e9abed79659f3792fa26fa12bf56eeb8aacb\", \"got_revision_cp\": \"refs/heads/master@{#849135}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8b4cf1c2491d56cf9eda153b5455e4b295732b7c\", \"got_v8_revision\": \"e60468ddb6a9b78c3eef0e40c1f17c73c8b0d2c0\", \"got_v8_revision_cp\": \"refs/heads/9.0.104@{#1}\", \"got_webrtc_revision\": \"b853d722501bcd445f802d59face4ff7892daea7\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33119}\", \"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\": \"1385e9abed79659f3792fa26fa12bf56eeb8aacb\", \"swarm_hashes_refs/heads/master(at){#849135}_without_patch\": {\"absl_hardening_tests\": \"46585d3a2ae5551bd7391ea675118a527f3d2920\", \"accessibility_unittests\": \"1431a43c95b2d54f17a0ebb3acefe70b93c36278\", \"angle_unittests\": \"d08c286d26423f98be8aad2f4b741f3717127e26\", \"app_list_unittests\": \"40a27c2316c92047ac5f7eed1946d4f319a9200a\", \"app_shell_unittests\": \"185166c55d3133b092a41f822476a262d10a98cb\", \"ash_unittests\": \"899436a88465c330a161b5b5757eef0c21f996d2\", \"aura_unittests\": \"637a9ec95838c8dc4e3235d84cac359688ef7df5\", \"base_unittests\": \"ca5918d34c27a658728da01ef5c9a8462f5dd61a\", \"base_util_unittests\": \"8981c9b59e8fef9eaed7541f41b7306a049408c7\", \"blink_common_unittests\": \"97ff800a5d41917629e13f529152f91bf1bd3530\", \"blink_fuzzer_unittests\": \"802d339fd39c04e45e2159107ddd6a98f44b1a72\", \"blink_heap_unittests\": \"0ce144019d72b1bf18243abebdde7603dafcefe8\", \"blink_platform_unittests\": \"8d3d30ad86d23fad3e28b130c821a65f3cf0d865\", \"blink_unittests\": \"4e80a5952070d86b19b4289945a1d6acbcf1502a\", \"boringssl_crypto_tests\": \"626ae57819736dd9ed44f80df2166a9f8b6c828b\", \"boringssl_ssl_tests\": \"94acb3823e1db16e26971befd905d2aecee545cf\", \"browser_tests\": \"cc5c2cb43ad2f064231e8d190917add1736c67c4\", \"capture_unittests\": \"ad10779b13d66dade5aaff0781c5a6ef28fc5ce5\", \"cast_unittests\": \"f4029e62fc94ec2192a0fa07548004a1ee7a07f1\", \"cc_unittests\": \"3380560d6c8a247d8f310d4cd7d6fa9feec2749c\", \"chrome_app_unittests\": \"264d2923d3a56dbdacdf61cf3b1baf09e9043539\", \"chromedriver_unittests\": \"d1397b4b7234b2732ca49d828bf388f68c2f8f3d\", \"chromeos_components_unittests\": \"081e7679ec785468b287156b966d808db333d80a\", \"chromeos_unittests\": \"05b2d4098727f2908632ddfb7e5e5beb14a70697\", \"components_browsertests\": \"d06bb01a138417596ca572e71a5c3ed83a9911bf\", \"components_unittests\": \"3d42537666c964aef04d97a7dbca47c785337771\", \"compositor_unittests\": \"efca55e1d05cfc6616b2ea86243c604d28613500\", \"content_browsertests\": \"f16a78407e5b9ce5f61fd63c62306063be06b3f9\", \"content_unittests\": \"330891b55d519bf7bcbd30faea3ab1079222196d\", \"crashpad_tests\": \"6f2d02fa7b14836832c184114e2de3c9eb296da4\", \"crypto_unittests\": \"ede510b5404da883201c1a6d021dca4724ba68ea\", \"dbus_unittests\": \"05861f7061a373f74325b3f4314d682f21c565c1\", \"device_unittests\": \"3c835e9078d49ba451aff0410acc87734c5fd169\", \"display_unittests\": \"62823dca92d6cf2aa6ff9d7eff284d4c8ac26953\", \"events_unittests\": \"0d3a094cacbc56689d90b7b07ba5c47de1f6cc42\", \"exo_unittests\": \"2058829b66490deb2af531233054a4bfb556bb63\", \"extensions_browsertests\": \"a5327e258dcc5d15bc0d0702ea6a62b77f474970\", \"extensions_unittests\": \"5e4757e5b8ed916e3ff00e26392023ba40fd8320\", \"filesystem_service_unittests\": \"f8b7368d436c4a7d745113dabcc773d2cfbafd0b\", \"gcm_unit_tests\": \"628a68625182617f345f65c4187a0ba41763c01c\", \"gfx_unittests\": \"2f9538e76c18532e1d565e8964881e4d2d6c20f2\", \"gin_unittests\": \"72be16f5ba45c63534beea489b67a578eea05ba8\", \"gl_unittests_ozone\": \"2ee2427110524f10f7ab0448998959c728ff72fc\", \"google_apis_unittests\": \"2847d000231f733c6b4cc36ca03d8045dc8b16c4\", \"gpu_unittests\": \"b5562e731ab777899e7d8e4709a0322c6efa5400\", \"gwp_asan_unittests\": \"38dd38ee0d090c608cf31b806b6c413fb7a3ecdd\", \"interactive_ui_tests\": \"d1884785102884eedea7e064fe9e2d5050bb4fa8\", \"ipc_tests\": \"e20d99ba37825befc76272c8b949a7b2fb179cce\", \"jingle_unittests\": \"c7218db3e2e9ac37dee897bfe56502359ee19a65\", \"keyboard_unittests\": \"f996d84c5d460a2793a8c55bd227a7c7797d6cdd\", \"latency_unittests\": \"1518fbd4a85585b26111a7f848d5e35a5e574f05\", \"libjingle_xmpp_unittests\": \"a118ddf9ad7c3bee179ee4f4c9dcefeee3992efa\", \"liburlpattern_unittests\": \"019c3273243e7508c5bd39530e22e17e4247fd72\", \"media_blink_unittests\": \"682e514b371a7759b12ba6076869278234a44fba\", \"media_unittests\": \"0c338fa9ecbf440e930da0317447f045c887cfbc\", \"message_center_unittests\": \"f7dbec5b615c8b0bfbd1faf9b0f68604a11391ff\", \"midi_unittests\": \"a3dc980c54523663e4b996fa6b8e4b3915768068\", \"mojo_core_unittests\": \"c8c4ebcdd659ca646342ddea994b1e90091f2ef0\", \"mojo_unittests\": \"0550c9a27f30391e5aafb71f0cbb3e299cb60259\", \"nacl_helper_nonsfi_unittests\": \"ec4a1c94254ee75c10fe781819cae3338d372dfc\", \"nacl_loader_unittests\": \"93295fe89e4a53b377ff7cd2fd76b282b6ea0f5c\", \"native_theme_unittests\": \"7d503932ae00313ba54a600d999356b0c8b39694\", \"net_unittests\": \"ab2b165730dc66a97b785d9f8a40d3715c59422f\", \"ozone_gl_unittests\": \"5bc303b7d84fe571a34a046dfd60243d672a2578\", \"ozone_unittests\": \"913ba24103c702100e2324eaee08648e78ba8689\", \"ozone_x11_unittests\": \"f8f0ffa4c0f4235d08ae499037a9acb1c2a8c70e\", \"pdf_unittests\": \"10d2e2efc4cc8215ff9021200d2645dfee80d750\", \"perfetto_unittests\": \"be64e95de1cd178892918d9d666111d9ce31789c\", \"ppapi_unittests\": \"2dcab3fce942ed1dc6d6de3923381ce5c273cfe4\", \"printing_unittests\": \"7b83cbfc4b01f932f6fa22240a8d0b6144895f6b\", \"remoting_unittests\": \"43b80a90e8567f6067f4d10081e7c5070752729a\", \"sandbox_linux_unittests\": \"6495547049482df1dc2228f4515c408b21d1afaa\", \"service_manager_unittests\": \"178c990d3d73c97780a5bf86546037a67870a64c\", \"services_unittests\": \"5c649f15961f125ff4df5e0d87d3cd51567e4873\", \"shell_dialogs_unittests\": \"6978e7d62b888a72ef5a6a71ceb04434536533b5\", \"shell_encryption_unittests\": \"cf58706dfbec708ae093aba24d60673ed6416b04\", \"skia_unittests\": \"ff3193d30b482733b75cfe826b0843375706b725\", \"snapshot_unittests\": \"5575d7b639473e5c38e9efd23d9504f5e70dcd4b\", \"sql_unittests\": \"179fe047815936ab74609144154573190f38eaff\", \"storage_unittests\": \"6f328695cf20c4352ed6c4540990b874c700c075\", \"sync_integration_tests\": \"0aafdb9c5b36586163a65f15cd3b4cf91289ee1e\", \"traffic_annotation_auditor_unittests\": \"91b33b134ab59189a4d77982ffd1e403c5ab53e6\", \"ui_base_unittests\": \"673706671895e5b6d46505e5b20b8cb8d89a146e\", \"ui_chromeos_unittests\": \"65f60051d16878ab1ab2566c07b9215a7367e3d9\", \"ui_touch_selection_unittests\": \"dbd91905d33c3c078065ed5f96b9f0397338d9f6\", \"unit_tests\": \"fc432311cc4bdf5a8ba240c5c531828aabde2e2e\", \"url_unittests\": \"70895e4e581a3adc12e11c5d2ecc418d95e69270\", \"usage_time_limit_unittests\": \"85b1e23d421844da75720745591ef694c76dfd01\", \"views_unittests\": \"ef289c9d359274eb98fe4768d6092dfd198aa10e\", \"viz_unittests\": \"78dc2304ab0cbbec1a54c283d18198cb3581e604\", \"wayland_client_perftests\": \"52b8b9a63a5e6bd6eb9e24f78e047cfb96ddeec5\", \"wm_unittests\": \"56b9bdc69b8a596c77d5891da475fc76b3711406\", \"wtf_unittests\": \"95f4173c04f7a2083bb068c41348a542b83b9a2e\", \"zlib_unittests\": \"34dbe2318a0cea145d78d7254f6460b5160f504d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_421907a467e2788e68517b08f1c0b8cf87393ea82f2cbff03718224ebc4df608_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_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-208-9ccp\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612197512280938",
"status": "COMPLETED",
"status_changed_ts": "1612200572429927",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45060",
"builder:linux-chromeos-rel",
"buildset:commit/git/1385e9abed79659f3792fa26fa12bf56eeb8aacb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1385e9abed79659f3792fa26fa12bf56eeb8aacb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021912162975608640",
"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/8856482100704972176/+/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:51774743ce2f2b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1612200572434338",
"url": "https://ci.chromium.org/b/8856482100704972176",
"utcnow_ts": "1612200573462162"
}
}
[17:29:33.490] Invocation finished in 51m5.985302234s with status SUCCEEDED