[22:13:00.142] New invocation is queued and will start shortly
[22:13:01.429] Starting the invocation (attempt 1)
[22:13:01.468] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:13:01.468] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:13:01.468] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024337233398012048",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"823a0cd39d71991e3be4b5bf9e937f2dc1fbe3bf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9024337233398012048",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/823a0cd39d71991e3be4b5bf9e937f2dc1fbe3bf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/823a0cd39d71991e3be4b5bf9e937f2dc1fbe3bf",
"gitiles_ref:refs/heads/master"
]
}
[22:13:02.618] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609884781670181",
"id": "8858907171133759232",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"823a0cd39d71991e3be4b5bf9e937f2dc1fbe3bf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609884782254174",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44357",
"builder:linux-chromeos-rel",
"buildset:commit/git/823a0cd39d71991e3be4b5bf9e937f2dc1fbe3bf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/823a0cd39d71991e3be4b5bf9e937f2dc1fbe3bf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024337233398012048",
"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/8858907171133759232/+/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": "1609884782254460",
"url": "https://ci.chromium.org/b/8858907171133759232",
"utcnow_ts": "1609884782598412"
}
}
[22:13:02.618] Task URL: https://ci.chromium.org/b/8858907171133759232
[22:13:02.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:2:0) after 1m0s
[22:13:38.853] Received PubSub notification, asking Buildbucket for the build status
[22:13:38.982] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:02.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:2:0)
[22:14:02.676] Timer tick, asking Buildbucket for the build status
[22:14:02.913] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:02.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:4:0) after 1m0s
[22:15:03.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:4:0)
[22:15:03.299] Timer tick, asking Buildbucket for the build status
[22:15:03.576] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:03.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:5:0) after 1m0s
[22:16:03.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:5:0)
[22:16:03.591] Timer tick, asking Buildbucket for the build status
[22:16:04.184] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:04.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:6:0) after 1m0s
[22:17:04.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:6:0)
[22:17:04.257] Timer tick, asking Buildbucket for the build status
[22:17:04.465] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:04.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:7:0) after 1m0s
[22:18:04.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:7:0)
[22:18:04.525] Timer tick, asking Buildbucket for the build status
[22:18:04.899] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:04.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:8:0) after 1m0s
[22:19:04.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:8:0)
[22:19:04.904] Timer tick, asking Buildbucket for the build status
[22:19:05.126] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:05.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:9:0) after 1m0s
[22:20:05.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:9:0)
[22:20:05.325] Timer tick, asking Buildbucket for the build status
[22:20:05.995] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:05.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:10:0) after 1m0s
[22:21:06.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:10:0)
[22:21:06.232] Timer tick, asking Buildbucket for the build status
[22:21:06.496] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:06.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:11:0) after 1m0s
[22:22:06.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:11:0)
[22:22:06.511] Timer tick, asking Buildbucket for the build status
[22:22:06.630] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:06.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:12:0) after 1m0s
[22:23:06.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:12:0)
[22:23:06.783] Timer tick, asking Buildbucket for the build status
[22:23:07.101] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:07.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:13:0) after 1m0s
[22:24:07.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:13:0)
[22:24:07.165] Timer tick, asking Buildbucket for the build status
[22:24:07.425] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:07.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:14:0) after 1m0s
[22:25:07.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:14:0)
[22:25:07.511] Timer tick, asking Buildbucket for the build status
[22:25:08.109] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:08.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:15:0) after 1m0s
[22:26:08.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:15:0)
[22:26:08.221] Timer tick, asking Buildbucket for the build status
[22:26:08.283] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:08.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:16:0) after 1m0s
[22:27:08.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:16:0)
[22:27:08.396] Timer tick, asking Buildbucket for the build status
[22:27:08.641] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:08.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:17:0) after 1m0s
[22:28:08.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:17:0)
[22:28:08.713] Timer tick, asking Buildbucket for the build status
[22:28:08.876] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:08.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:18:0) after 1m0s
[22:29:09.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:18:0)
[22:29:09.067] Timer tick, asking Buildbucket for the build status
[22:29:09.203] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:09.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:19:0) after 1m0s
[22:30:09.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:19:0)
[22:30:09.429] Timer tick, asking Buildbucket for the build status
[22:30:09.515] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:09.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:20:0) after 1m0s
[22:31:09.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:20:0)
[22:31:09.914] Timer tick, asking Buildbucket for the build status
[22:31:10.251] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:10.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:21:0) after 1m0s
[22:32:10.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:21:0)
[22:32:10.284] Timer tick, asking Buildbucket for the build status
[22:32:10.427] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:10.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:22:0) after 1m0s
[22:33:10.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:22:0)
[22:33:10.527] Timer tick, asking Buildbucket for the build status
[22:33:10.769] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:10.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:23:0) after 1m0s
[22:34:10.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:23:0)
[22:34:10.809] Timer tick, asking Buildbucket for the build status
[22:34:11.319] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:11.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:24:0) after 1m0s
[22:35:11.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:24:0)
[22:35:11.392] Timer tick, asking Buildbucket for the build status
[22:35:11.571] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:11.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:25:0) after 1m0s
[22:36:11.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:25:0)
[22:36:11.565] Timer tick, asking Buildbucket for the build status
[22:36:11.644] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:11.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:26:0) after 1m0s
[22:37:11.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:26:0)
[22:37:11.669] Timer tick, asking Buildbucket for the build status
[22:37:11.744] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:11.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:27:0) after 1m0s
[22:38:11.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:27:0)
[22:38:11.836] Timer tick, asking Buildbucket for the build status
[22:38:13.124] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:13.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:28:0) after 1m0s
[22:39:13.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:28:0)
[22:39:13.199] Timer tick, asking Buildbucket for the build status
[22:39:13.312] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:13.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:29:0) after 1m0s
[22:40:13.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:29:0)
[22:40:13.407] Timer tick, asking Buildbucket for the build status
[22:40:13.473] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:13.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:30:0) after 1m0s
[22:41:13.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:30:0)
[22:41:13.519] Timer tick, asking Buildbucket for the build status
[22:41:13.610] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:13.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:31:0) after 1m0s
[22:42:13.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:31:0)
[22:42:13.630] Timer tick, asking Buildbucket for the build status
[22:42:13.800] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:13.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:32:0) after 1m0s
[22:43:13.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:32:0)
[22:43:13.821] Timer tick, asking Buildbucket for the build status
[22:43:13.909] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:13.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:33:0) after 1m0s
[22:44:13.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:33:0)
[22:44:13.929] Timer tick, asking Buildbucket for the build status
[22:44:17.428] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:17.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:34:0) after 1m0s
[22:45:17.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:34:0)
[22:45:17.470] Timer tick, asking Buildbucket for the build status
[22:45:17.568] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:17.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:35:0) after 1m0s
[22:46:17.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:35:0)
[22:46:17.592] Timer tick, asking Buildbucket for the build status
[22:46:17.670] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:17.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:36:0) after 1m0s
[22:47:17.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:36:0)
[22:47:17.771] Timer tick, asking Buildbucket for the build status
[22:47:17.962] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:17.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:37:0) after 1m0s
[22:48:17.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:37:0)
[22:48:17.971] Timer tick, asking Buildbucket for the build status
[22:48:18.354] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:18.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:38:0) after 1m0s
[22:49:18.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:38:0)
[22:49:18.397] Timer tick, asking Buildbucket for the build status
[22:49:19.296] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:19.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:39:0) after 1m0s
[22:50:19.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:39:0)
[22:50:19.361] Timer tick, asking Buildbucket for the build status
[22:50:19.422] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:19.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:40:0) after 1m0s
[22:51:19.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:40:0)
[22:51:19.444] Timer tick, asking Buildbucket for the build status
[22:51:19.515] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:19.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:41:0) after 1m0s
[22:52:19.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:41:0)
[22:52:19.543] Timer tick, asking Buildbucket for the build status
[22:52:19.705] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:19.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:42:0) after 1m0s
[22:53:19.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:42:0)
[22:53:19.722] Timer tick, asking Buildbucket for the build status
[22:53:19.883] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:19.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:43:0) after 1m0s
[22:54:19.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:43:0)
[22:54:19.975] Timer tick, asking Buildbucket for the build status
[22:54:20.135] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:20.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:44:0) after 1m0s
[22:55:20.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:44:0)
[22:55:20.204] Timer tick, asking Buildbucket for the build status
[22:55:20.547] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:20.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:45:0) after 1m0s
[22:56:20.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:45:0)
[22:56:20.573] Timer tick, asking Buildbucket for the build status
[22:56:20.979] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:20.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:46:0) after 1m0s
[22:57:21.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:46:0)
[22:57:21.036] Timer tick, asking Buildbucket for the build status
[22:57:21.305] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:21.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:47:0) after 1m0s
[22:58:21.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:47:0)
[22:58:21.384] Timer tick, asking Buildbucket for the build status
[22:58:21.507] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:21.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:48:0) after 1m0s
[22:59:21.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:48:0)
[22:59:21.903] Timer tick, asking Buildbucket for the build status
[22:59:22.034] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:22.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:49:0) after 1m0s
[23:00:22.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:49:0)
[23:00:22.821] Timer tick, asking Buildbucket for the build status
[23:00:23.906] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:23.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:50:0) after 1m0s
[23:01:23.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:50:0)
[23:01:23.969] Timer tick, asking Buildbucket for the build status
[23:01:24.356] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:24.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:51:0) after 1m0s
[23:02:24.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:51:0)
[23:02:24.384] Timer tick, asking Buildbucket for the build status
[23:02:24.717] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:24.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:52:0) after 1m0s
[23:03:24.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:52:0)
[23:03:24.792] Timer tick, asking Buildbucket for the build status
[23:03:25.248] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:25.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:53:0) after 1m0s
[23:04:25.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:53:0)
[23:04:25.262] Timer tick, asking Buildbucket for the build status
[23:04:25.434] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:25.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:54:0) after 1m0s
[23:05:25.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:54:0)
[23:05:25.530] Timer tick, asking Buildbucket for the build status
[23:05:25.856] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:25.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:55:0) after 1m0s
[23:06:25.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:55:0)
[23:06:25.963] Timer tick, asking Buildbucket for the build status
[23:06:26.108] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:26.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:56:0) after 1m0s
[23:07:26.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:56:0)
[23:07:26.201] Timer tick, asking Buildbucket for the build status
[23:07:26.623] Build 8858907171133759232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:26.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024337233398012048:57:0) after 1m0s
[23:08:25.184] Received PubSub notification, asking Buildbucket for the build status
[23:08:25.323] Build 8858907171133759232: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:08:25.323] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609888103916090",
"created_by": "project:chromium",
"created_ts": "1609884781670181",
"id": "8858907171133759232",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"823a0cd39d71991e3be4b5bf9e937f2dc1fbe3bf\"}}",
"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\": \"823a0cd39d71991e3be4b5bf9e937f2dc1fbe3bf\", \"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-30-hvdv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44357, \"got_angle_revision\": \"973bd4ba0f5775c66b6811bf81f6483e629365c7\", \"got_dawn_revision\": \"200941c797512895039e9f0315fc18fd9d9734ad\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"823a0cd39d71991e3be4b5bf9e937f2dc1fbe3bf\", \"got_revision_cp\": \"refs/heads/master@{#840336}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"b9e179f1f239bd1da8fffbd997a41095345d1f6a\", \"got_v8_revision\": \"b5675ec04fc391dcfbeb1f3894245a08f3e445af\", \"got_v8_revision_cp\": \"refs/heads/8.9.211@{#1}\", \"got_webrtc_revision\": \"fc6b87192db6d5e4fd6997814f00b6792cf16180\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32904}\", \"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\": \"823a0cd39d71991e3be4b5bf9e937f2dc1fbe3bf\", \"swarm_hashes_refs/heads/master(at){#840336}_without_patch\": {\"absl_hardening_tests\": \"5c205f9be0615a77b1f51bc8b65c4c489f311f24\", \"accessibility_unittests\": \"1566ca373bb29b9623774cdb0f03e9d52c0fdf1d\", \"angle_unittests\": \"ff7690556c821d73543356637f0846f711a91408\", \"app_list_unittests\": \"d7b3ecf3e4137bfb88ed105cc032246a315af0b0\", \"app_shell_unittests\": \"f654945a242daf0651cc58bf49ebc742a00514c4\", \"ash_unittests\": \"9235e0d729db97417be699839a5e02521d2341b9\", \"aura_unittests\": \"ea69ce2ee60e545c5392fafb78605ff69bac359e\", \"base_unittests\": \"7688ab3967cdfdf186a0776f5308840a6e0b203e\", \"base_util_unittests\": \"d32e8d4744d9d6a2bb65c5393699c03a183a4438\", \"blink_common_unittests\": \"7362bb9dc0894f345f5904ac1147a21c3a247f24\", \"blink_fuzzer_unittests\": \"ae30fee311925bbb1e1897c39b9dae3de3ed7816\", \"blink_heap_unittests\": \"6cef8118a677c719828125b9b38cb11280516811\", \"blink_platform_unittests\": \"435974c896f8ec732fda55d43757a254a567263d\", \"blink_unittests\": \"736377cd60c610032cb2498fff28b6b0d4aa9827\", \"boringssl_crypto_tests\": \"59d29458d7651e33d2d5f3b02a9fe5eb4a451cf5\", \"boringssl_ssl_tests\": \"6e27d263de7eb558df7a8c8c9f771570e5f04ea3\", \"browser_tests\": \"31656062790c06f2ff4be045a7f6be5c1986b9d1\", \"capture_unittests\": \"d3e69d0bfe71bc58b74966d759dc075422f759bf\", \"cast_unittests\": \"1789d8beff90a71ce7b19fd465bfa04301546f7f\", \"cc_unittests\": \"881c18671df3b4f3243879de13031be0a400b78f\", \"chrome_app_unittests\": \"df1ec46657887e8806de2f70f21d4064e3c24cb0\", \"chromedriver_unittests\": \"dc9dc1a1a060d4f055eff22add7278c63f5f6cc7\", \"chromeos_components_unittests\": \"6da7d0d17e3d0a998224d93f362612acafb0582f\", \"chromeos_unittests\": \"51e2d5fc26fa789b186185c9a57097fa6da14891\", \"components_browsertests\": \"28f1de3f887c17b5d78176b39c9ec0b7b43f39b4\", \"components_unittests\": \"aea1b38da98018a4f60fd6abe6b65256a4dc5e35\", \"compositor_unittests\": \"0775b426b3365eb45e59985fff2992d636671dec\", \"content_browsertests\": \"d3eb09dd6961a9e848b6769a7911cfd6824c0218\", \"content_unittests\": \"358fc2410478dbe1ae1c26566774fb9d1ed6c3f4\", \"crashpad_tests\": \"5d3251db41e0769e4236285ca6096a8a2a8de6da\", \"crypto_unittests\": \"0f5f9b91720b75a1ceea1bc39146ef3bef2bbbff\", \"dbus_unittests\": \"9b80f6793b43f3867d68c197b932165b259ca8b9\", \"device_unittests\": \"639bc1b6ab4836cf2741ea406ae67b839f0c274b\", \"display_unittests\": \"8cbee6c2fcedb1c0ac3e008b3e220f3857a4e442\", \"events_unittests\": \"3a5958e071096f6a7a666a1a0c1385af3563bece\", \"exo_unittests\": \"8912ede516225289ed3ccaef47d35bece2082278\", \"extensions_browsertests\": \"286c957232d5529eacf6a7cbe9bc1f6ab3bd775d\", \"extensions_unittests\": \"321894e2ae361989900948ca22e5ffa1469e538b\", \"filesystem_service_unittests\": \"b213f3f7b46803c0d62e3c527a71c144d40577a4\", \"gcm_unit_tests\": \"15852a57a96311da56d117b1dc82ea555a8c9d3d\", \"gfx_unittests\": \"193f53f2b938641930941f07fa0af6c2d3b80d7f\", \"gin_unittests\": \"86f11f042f462086cf943b0b5e08339dd0d8ef2a\", \"gl_unittests_ozone\": \"91e1c43181212185fce1e5ee2045a87ac622dd06\", \"google_apis_unittests\": \"bd926dc1be1822570db88505f13d276407c17236\", \"gpu_unittests\": \"2e27c2b940df2c5fc0f29216970a5dc2d657a4af\", \"gwp_asan_unittests\": \"d466174dc8d794b86ac18c3476dfeefa7f20d1c9\", \"interactive_ui_tests\": \"329f07cc77d47559ebfff487e7567095fb4db4c6\", \"ipc_tests\": \"7efcafa35254db7ab08db2385e99b56d256d3908\", \"jingle_unittests\": \"b6106bad3a75731a5c7e1fe68016b8da5b34d6a0\", \"keyboard_unittests\": \"1dbd8c434b0a66948a971735a6d78b6b2cfeaef1\", \"latency_unittests\": \"8825a0c05db86990dc728d4dd5858b8b8cc825f9\", \"libjingle_xmpp_unittests\": \"043e185cc09d126d5a046c0a18c7e2bda052f1a0\", \"liburlpattern_unittests\": \"bd069934601f87ca1faee4100cb93153532a3466\", \"media_blink_unittests\": \"707fd910568f90e81fe4a5891e9bc0da83deb24e\", \"media_unittests\": \"9347765d345f00261f42feead7976330e4e23e90\", \"message_center_unittests\": \"1177907cc288e3c9c87d50d1fcbf06c1f5d19dc3\", \"midi_unittests\": \"1ee870779e7067ae72ee6d71b0ae9b4721f53a01\", \"mojo_core_unittests\": \"e62eef6fa4dfa05e47375a2d158e58d1452c5c73\", \"mojo_unittests\": \"7a88d718eda7cf707a3ea652debf9ec41100163c\", \"nacl_helper_nonsfi_unittests\": \"94da9523032326c0351a3fb49d2c83c2481c4194\", \"nacl_loader_unittests\": \"b84de03d2a48874d6f4ab370ca67f77e94420958\", \"native_theme_unittests\": \"1705d7e47c9b67ddd16828669662a1229ef52380\", \"net_unittests\": \"76ea2bff1a973a894b00854ccd87067c23aff951\", \"ozone_gl_unittests\": \"65183aa87aa11fedc5c65f21cb7aa0ec6a69b34d\", \"ozone_unittests\": \"b825306ac3f8d438264dd1102398050b4aee7030\", \"ozone_x11_unittests\": \"f8c24a6bef5e2e771094a07d3e2ff1efedb28b26\", \"pdf_unittests\": \"482f116e5d43d9fd00ccf823b2d3cbd87bd19408\", \"perfetto_unittests\": \"dbd9e1842a7a54b6f52e6ced2b6c1d19d279589c\", \"ppapi_unittests\": \"42675ebb3885e53a873d333f36c6e5709318fa78\", \"printing_unittests\": \"38765b9a6e635f2a478b5faa81d3603293b7b808\", \"remoting_unittests\": \"add9c883dfda38c65e51a5ce40cf2eb54afd5cac\", \"sandbox_linux_unittests\": \"02e7b3fa3fd9b6279e104a7540e4815837c76469\", \"service_manager_unittests\": \"aafd806608ba92321363cf84988f8224f8323b9a\", \"services_unittests\": \"f54490c4a7f15ef4c9fcc2f01270783687f91fc0\", \"shell_dialogs_unittests\": \"41a243ee7a63bb8b9ef1db2f0d9ba52161cc294e\", \"shell_encryption_unittests\": \"43cf0baebf8e7e5132384372cdeb78da50de48ce\", \"skia_unittests\": \"fd0729099cb62cf97db3325975afcbb9d7533c39\", \"snapshot_unittests\": \"670fb86e6035f4768c9226edd0bb65a63ad1dd3a\", \"sql_unittests\": \"2b58b91083b5e3f00588dadd2055a8234ee643d2\", \"storage_unittests\": \"5687ed310f2518349d1392065515fe5190653bf0\", \"sync_integration_tests\": \"45b2b13a979db2e909cdd8a527a308d0294279cb\", \"traffic_annotation_auditor_unittests\": \"8df66911194b717f32b80fbe327eec5c0d2316ff\", \"ui_base_unittests\": \"a92637acacc991126b42453346c5fcad3cfd4d80\", \"ui_chromeos_unittests\": \"7820b2a26bacbcce235af0e82fb4783453742db2\", \"ui_touch_selection_unittests\": \"c48197ded1fb1091dbea29a31d73f7f184de98d3\", \"unit_tests\": \"a2151e3bcd00d44a17d0a2aaf4450efa0553ed63\", \"url_unittests\": \"17d1bf4a701d24a641fcc80513a3eae2c514e874\", \"usage_time_limit_unittests\": \"a36db6bb0f0d5eef845901083c9a1ebb37203985\", \"views_unittests\": \"fec1655b9bdbf92a03c3694dfaa904776779da6a\", \"viz_unittests\": \"e1dcd9555f5d0fb9450db4c75118d940bd9df26b\", \"wayland_client_perftests\": \"de72c83d23fef748f645cbd103bf7d4e437a0edc\", \"wm_unittests\": \"bffa4bea900084c82d871537e1e56d9044309222\", \"wtf_unittests\": \"25408e0e859d3764ef7ec91905f7aa659efb6fe7\", \"zlib_unittests\": \"e523607ab2c0094bae752dc3122facddfffb96e0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_21a338e382a0dbd787bea981107dd7bac336a437920c3cc1b87ea8999b8bcb15_v2\", \"builder_70f3607e3f7d84b5c3698c0eed74813ee5c700477d5aec13835ae2ecc5ee2d5b_v2\", \"builder_78080097a3960c8831291638a631c67e272aa3d821d469cd7fbf44d1ce982b94_v2\", \"builder_79262342f920534415b6d515c76557b8e5c65ba3d1c1b85ae86a8176a9056a22_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_d0ba3cd99c36b697d8651140d51bf4b4f4b9cd9aa25af11363af5ede5f6e35b1_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-30-hvdv\"], \"image\": [\"chrome-xenial-20122700-a13233ce10d\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609884818209649",
"status": "COMPLETED",
"status_changed_ts": "1609888104468438",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44357",
"builder:linux-chromeos-rel",
"buildset:commit/git/823a0cd39d71991e3be4b5bf9e937f2dc1fbe3bf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/823a0cd39d71991e3be4b5bf9e937f2dc1fbe3bf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024337233398012048",
"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/8858907171133759232/+/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:50ed6dd82e85f610",
"user_agent:luci-scheduler"
],
"updated_ts": "1609888104491351",
"url": "https://ci.chromium.org/b/8858907171133759232",
"utcnow_ts": "1609888105310718"
}
}
[23:08:25.323] Invocation finished in 55m25.195903556s with status SUCCEEDED