[21:18:06.930] New invocation is queued and will start shortly
[21:18:08.087] Starting the invocation (attempt 1)
[21:18:08.126] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:18:08.126] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:18:08.126] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027420983447637264",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f8d0c16aa6e595ccdb18f1158b63cfe59601fc8e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9027420983447637264",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/f8d0c16aa6e595ccdb18f1158b63cfe59601fc8e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f8d0c16aa6e595ccdb18f1158b63cfe59601fc8e",
"gitiles_ref:refs/heads/master"
]
}
[21:18:09.101] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606943888240071",
"id": "8861990921402987712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f8d0c16aa6e595ccdb18f1158b63cfe59601fc8e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606943888827868",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43390",
"builder:linux-chromeos-rel",
"buildset:commit/git/f8d0c16aa6e595ccdb18f1158b63cfe59601fc8e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f8d0c16aa6e595ccdb18f1158b63cfe59601fc8e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027420983447637264",
"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/8861990921402987712/+/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": "1606943888828006",
"url": "https://ci.chromium.org/b/8861990921402987712",
"utcnow_ts": "1606943889076215"
}
}
[21:18:09.101] Task URL: https://ci.chromium.org/b/8861990921402987712
[21:18:09.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:2:0) after 1m0s
[21:19:09.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:2:0)
[21:19:09.122] Timer tick, asking Buildbucket for the build status
[21:19:09.603] Build 8861990921402987712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:19:09.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:3:0) after 1m0s
[21:20:09.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:3:0)
[21:20:09.632] Timer tick, asking Buildbucket for the build status
[21:20:10.021] Build 8861990921402987712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:20:10.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:4:0) after 1m0s
[21:21:10.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:4:0)
[21:21:10.162] Timer tick, asking Buildbucket for the build status
[21:21:10.260] Build 8861990921402987712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:21:10.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:5:0) after 1m0s
[21:21:43.857] Received PubSub notification, asking Buildbucket for the build status
[21:21:43.944] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:10.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:5:0)
[21:22:10.319] Timer tick, asking Buildbucket for the build status
[21:22:10.542] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:10.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:7:0) after 1m0s
[21:23:10.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:7:0)
[21:23:10.564] Timer tick, asking Buildbucket for the build status
[21:23:10.844] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:10.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:8:0) after 1m0s
[21:24:10.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:8:0)
[21:24:10.872] Timer tick, asking Buildbucket for the build status
[21:24:10.973] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:10.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:9:0) after 1m0s
[21:25:10.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:9:0)
[21:25:10.981] Timer tick, asking Buildbucket for the build status
[21:25:11.099] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:11.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:10:0) after 1m0s
[21:26:11.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:10:0)
[21:26:11.147] Timer tick, asking Buildbucket for the build status
[21:26:12.583] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:12.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:11:0) after 1m0s
[21:27:12.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:11:0)
[21:27:12.627] Timer tick, asking Buildbucket for the build status
[21:27:12.765] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:12.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:12:0) after 1m0s
[21:28:12.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:12:0)
[21:28:12.985] Timer tick, asking Buildbucket for the build status
[21:28:13.155] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:13.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:13:0) after 1m0s
[21:29:13.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:13:0)
[21:29:13.235] Timer tick, asking Buildbucket for the build status
[21:29:13.295] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:13.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:14:0) after 1m0s
[21:30:13.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:14:0)
[21:30:13.342] Timer tick, asking Buildbucket for the build status
[21:30:13.513] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:13.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:15:0) after 1m0s
[21:31:13.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:15:0)
[21:31:13.565] Timer tick, asking Buildbucket for the build status
[21:31:13.662] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:13.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:16:0) after 1m0s
[21:32:15.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:16:0)
[21:32:15.596] Timer tick, asking Buildbucket for the build status
[21:32:15.674] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:15.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:17:0) after 1m0s
[21:33:16.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:17:0)
[21:33:16.059] Timer tick, asking Buildbucket for the build status
[21:33:16.194] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:16.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:18:0) after 1m0s
[21:34:16.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:18:0)
[21:34:16.403] Timer tick, asking Buildbucket for the build status
[21:34:16.760] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:16.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:19:0) after 1m0s
[21:35:16.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:19:0)
[21:35:16.794] Timer tick, asking Buildbucket for the build status
[21:35:16.882] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:16.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:20:0) after 1m0s
[21:36:17.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:20:0)
[21:36:17.172] Timer tick, asking Buildbucket for the build status
[21:36:17.238] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:17.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:21:0) after 1m0s
[21:37:17.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:21:0)
[21:37:17.363] Timer tick, asking Buildbucket for the build status
[21:37:17.440] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:17.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:22:0) after 1m0s
[21:38:17.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:22:0)
[21:38:17.484] Timer tick, asking Buildbucket for the build status
[21:38:17.655] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:17.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:23:0) after 1m0s
[21:39:17.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:23:0)
[21:39:17.677] Timer tick, asking Buildbucket for the build status
[21:39:17.744] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:17.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:24:0) after 1m0s
[21:40:17.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:24:0)
[21:40:17.783] Timer tick, asking Buildbucket for the build status
[21:40:18.630] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:18.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:25:0) after 1m0s
[21:41:18.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:25:0)
[21:41:18.960] Timer tick, asking Buildbucket for the build status
[21:41:19.152] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:19.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:26:0) after 1m0s
[21:42:19.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:26:0)
[21:42:19.234] Timer tick, asking Buildbucket for the build status
[21:42:19.317] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:19.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:27:0) after 1m0s
[21:43:19.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:27:0)
[21:43:19.386] Timer tick, asking Buildbucket for the build status
[21:43:19.484] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:19.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:28:0) after 1m0s
[21:44:19.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:28:0)
[21:44:19.543] Timer tick, asking Buildbucket for the build status
[21:44:19.608] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:19.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:29:0) after 1m0s
[21:45:19.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:29:0)
[21:45:19.607] Timer tick, asking Buildbucket for the build status
[21:45:19.668] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:19.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:30:0) after 1m0s
[21:46:19.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:30:0)
[21:46:19.788] Timer tick, asking Buildbucket for the build status
[21:46:19.910] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:19.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:31:0) after 1m0s
[21:47:19.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:31:0)
[21:47:19.909] Timer tick, asking Buildbucket for the build status
[21:47:19.982] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:19.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:32:0) after 1m0s
[21:48:20.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:32:0)
[21:48:20.049] Timer tick, asking Buildbucket for the build status
[21:48:22.042] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:22.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:33:0) after 1m0s
[21:49:22.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:33:0)
[21:49:22.075] Timer tick, asking Buildbucket for the build status
[21:49:22.134] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:22.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:34:0) after 1m0s
[21:50:22.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:34:0)
[21:50:22.169] Timer tick, asking Buildbucket for the build status
[21:50:22.230] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:22.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:35:0) after 1m0s
[21:51:22.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:35:0)
[21:51:22.272] Timer tick, asking Buildbucket for the build status
[21:51:22.371] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:22.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:36:0) after 1m0s
[21:52:22.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:36:0)
[21:52:22.416] Timer tick, asking Buildbucket for the build status
[21:52:23.580] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:23.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:37:0) after 1m0s
[21:53:23.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:37:0)
[21:53:23.623] Timer tick, asking Buildbucket for the build status
[21:53:23.749] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:23.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:38:0) after 1m0s
[21:54:23.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:38:0)
[21:54:23.811] Timer tick, asking Buildbucket for the build status
[21:54:23.875] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:23.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:39:0) after 1m0s
[21:55:23.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:39:0)
[21:55:23.909] Timer tick, asking Buildbucket for the build status
[21:55:24.336] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:24.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:40:0) after 1m0s
[21:56:24.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:40:0)
[21:56:24.318] Timer tick, asking Buildbucket for the build status
[21:56:24.414] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:24.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:41:0) after 1m0s
[21:57:24.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:41:0)
[21:57:24.430] Timer tick, asking Buildbucket for the build status
[21:57:24.535] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:24.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:42:0) after 1m0s
[21:58:24.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:42:0)
[21:58:24.551] Timer tick, asking Buildbucket for the build status
[21:58:25.223] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:25.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:43:0) after 1m0s
[21:59:25.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:43:0)
[21:59:25.275] Timer tick, asking Buildbucket for the build status
[21:59:25.503] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:25.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:44:0) after 1m0s
[22:00:25.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:44:0)
[22:00:25.529] Timer tick, asking Buildbucket for the build status
[22:00:25.701] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:25.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:45:0) after 1m0s
[22:01:25.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:45:0)
[22:01:25.769] Timer tick, asking Buildbucket for the build status
[22:01:25.905] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:25.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:46:0) after 1m0s
[22:02:25.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:46:0)
[22:02:25.901] Timer tick, asking Buildbucket for the build status
[22:02:26.208] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:26.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:47:0) after 1m0s
[22:03:26.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:47:0)
[22:03:26.251] Timer tick, asking Buildbucket for the build status
[22:03:26.376] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:26.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:48:0) after 1m0s
[22:04:26.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:48:0)
[22:04:26.387] Timer tick, asking Buildbucket for the build status
[22:04:26.542] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:26.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:49:0) after 1m0s
[22:05:26.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:49:0)
[22:05:26.586] Timer tick, asking Buildbucket for the build status
[22:05:26.803] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:26.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:50:0) after 1m0s
[22:06:26.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:50:0)
[22:06:26.813] Timer tick, asking Buildbucket for the build status
[22:06:27.035] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:27.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:51:0) after 1m0s
[22:07:27.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:51:0)
[22:07:27.048] Timer tick, asking Buildbucket for the build status
[22:07:27.176] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:27.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:52:0) after 1m0s
[22:08:27.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:52:0)
[22:08:27.203] Timer tick, asking Buildbucket for the build status
[22:08:27.532] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:27.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:53:0) after 1m0s
[22:09:27.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:53:0)
[22:09:27.618] Timer tick, asking Buildbucket for the build status
[22:09:28.029] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:28.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:54:0) after 1m0s
[22:10:28.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:54:0)
[22:10:28.024] Timer tick, asking Buildbucket for the build status
[22:10:28.191] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:28.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:55:0) after 1m0s
[22:11:28.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:55:0)
[22:11:28.283] Timer tick, asking Buildbucket for the build status
[22:11:28.396] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:28.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:56:0) after 1m0s
[22:12:28.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:56:0)
[22:12:28.474] Timer tick, asking Buildbucket for the build status
[22:12:29.094] Build 8861990921402987712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:29.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027420983447637264:57:0) after 1m0s
[22:13:25.500] Received PubSub notification, asking Buildbucket for the build status
[22:13:25.647] Build 8861990921402987712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:13:25.647] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606947204425665",
"created_by": "project:chromium",
"created_ts": "1606943888240071",
"id": "8861990921402987712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f8d0c16aa6e595ccdb18f1158b63cfe59601fc8e\"}}",
"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\": \"f8d0c16aa6e595ccdb18f1158b63cfe59601fc8e\", \"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-54-oga7\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43390, \"got_angle_revision\": \"0c47015b57a03230e0cab10532c3deed80604512\", \"got_dawn_revision\": \"429a12542f160a36d87c1daa6c3102bce072207e\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"f8d0c16aa6e595ccdb18f1158b63cfe59601fc8e\", \"got_revision_cp\": \"refs/heads/master@{#832970}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bfb211914759cc5deffbe9419cd1c2cae0573488\", \"got_v8_revision\": \"b3456dd37acf448bb7e41b1dfc6eee5d28f38081\", \"got_v8_revision_cp\": \"refs/heads/8.9.75@{#1}\", \"got_webrtc_revision\": \"01b3e24a83564584ab0736074776e634c5ca6bb0\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32741}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f8d0c16aa6e595ccdb18f1158b63cfe59601fc8e\", \"swarm_hashes_refs/heads/master(at){#832970}_without_patch\": {\"absl_hardening_tests\": \"84205a29443fc94432f8341dfb3f16c2b35eb76e\", \"accessibility_unittests\": \"f20a6997207a7e61591837a3fe2a0d469c7d5d24\", \"angle_unittests\": \"02ee7c4f3dbe8ba2e5d113ab629cb43601cc82fb\", \"app_list_unittests\": \"9a91039355f307777b97e787dd66ad0817ffdb4f\", \"app_shell_unittests\": \"f306984b50ef71e86da7cf39c62404a0d6961a48\", \"ash_unittests\": \"c8dd2814758716a5b8f5cd0769728829d99d6346\", \"aura_unittests\": \"3f69dc9b23f9f0745de5390a5dc4c0186f8d8178\", \"base_unittests\": \"c15caf1d379450cb0f8f88a497ac62ee8e7b998c\", \"base_util_unittests\": \"8f27d6ee1b707db6052d0705bf850b4e5fd8bea6\", \"blink_common_unittests\": \"4207b8161bef165fd99423a53f10b2e5e172ea9b\", \"blink_fuzzer_unittests\": \"6e9ca50016702da581d4480098e396ae6d76192c\", \"blink_heap_unittests\": \"f66b9264a676a3fa9f2605cefedc6b12b510b064\", \"blink_platform_unittests\": \"45948ce832445d2569e1029215c46aa8dd106b97\", \"blink_unittests\": \"043234319cadab140c9890b6dd1ccf3f3faf6fa0\", \"boringssl_crypto_tests\": \"cbebce271deb1de6055cca8691fb2dfa26db633f\", \"boringssl_ssl_tests\": \"e233ca1cfc65480cf271f272700d8cc0aabadd11\", \"browser_tests\": \"ee13eadbd9a24860d85c07c6a8e27627a69620fb\", \"capture_unittests\": \"3a7aa8da0d4af510137acffeca24425c5e68a540\", \"cast_unittests\": \"1a53fb1a73b23ba78252867255afd85d43fbf392\", \"cc_unittests\": \"cea2118d082c04898442cacf2826e60485dae451\", \"chrome_app_unittests\": \"742b3f9d91cc1db13caae40c077c75625529769c\", \"chromedriver_unittests\": \"6f0204c01ba765cab32eda9a7923af09701390fd\", \"chromeos_components_unittests\": \"1b0ec4f0803a3b7937a1fc78a4d0053411a40f0a\", \"chromeos_unittests\": \"d869f113dee1d5ba1a4dad6cffea7a97d147f842\", \"components_browsertests\": \"5f1eae3592548b1d7de7d41167c34e758aa3288f\", \"components_unittests\": \"4e714d5ab4496a232dac355c0fd7095d9f7b4b15\", \"compositor_unittests\": \"f2c89ab382e3ce3b35d183d2fb28fd7d3b580319\", \"content_browsertests\": \"aa0b81a3ea39cfb8714161ac38692bafbf72592e\", \"content_unittests\": \"4a2768d16815975052287be067b008c9c23202a8\", \"crashpad_tests\": \"9be2b1c317910078a68758669b76fcbfb84713cf\", \"crypto_unittests\": \"f56a0bd0cd460f62908b3e36457e91a8fea55811\", \"dbus_unittests\": \"4cb30793d6883fba360cc6c10fbc9e6e5027a86b\", \"device_unittests\": \"dc0e1b1edab8a8f986384710c20b332a0096e18e\", \"display_unittests\": \"d6733cabd6d8dea96b156fccb836e5750257f1f3\", \"events_unittests\": \"c33f2a9c80c3894f105274bed840e4e57ef87e01\", \"exo_unittests\": \"893494bdac42e0ee24dd4b3b85018908765d84a7\", \"extensions_browsertests\": \"0cdfa14275a8af6246ab62135c58cf1ebd630202\", \"extensions_unittests\": \"2bd6971f1cc0d464533e0fce0a4fb3f272ad75f2\", \"filesystem_service_unittests\": \"db49a3a63c06c5cc70f1f1a9316aa3d2b155d6c6\", \"gcm_unit_tests\": \"6173c79237e2447359ff7e4a027dd8b329ea199c\", \"gfx_unittests\": \"61fe8422c3157cb648d6af4e3ddcf7c1afe1970d\", \"gin_unittests\": \"7d5744b981362dc1b6b4b923739e96fac571d41c\", \"gl_unittests_ozone\": \"4f27a3c387f5865209b2872efe75f429680fa24f\", \"google_apis_unittests\": \"0ba062bbbb25301be2ab5f0707e3e8ad1dcd590e\", \"gpu_unittests\": \"6cb812bd1910d8ac9f73c9ffded2b23886a37fa6\", \"gwp_asan_unittests\": \"9ac4069f428ccd4415758b2e19b04269e7bbfc23\", \"interactive_ui_tests\": \"028802b06b41534af05f6267ef4ba9a8bd487b4a\", \"ipc_tests\": \"585fea4fa5b9877493a6f226978a4191029018d8\", \"jingle_unittests\": \"e0d89016c9186b86d3dbc635bbaaf5a08bc082f7\", \"keyboard_unittests\": \"a6df2db9fcfb9e4ef69c8cd2db6176717fcc2b1b\", \"latency_unittests\": \"4076b84ef6e145a319ba329817c0f7622cbe2ba8\", \"libjingle_xmpp_unittests\": \"95e17ba4523eb667a115c69b431e925f343ba9e1\", \"liburlpattern_unittests\": \"9fe9dd5cea9a761b3892db04db617b915a26348b\", \"media_blink_unittests\": \"a3192a412c65dae5ee44ab2ff431f2728c732f42\", \"media_unittests\": \"f61dcb03fa97d2e5c53d13c37915271b9f73e15b\", \"message_center_unittests\": \"4064da1cd567c7680e0e0f550c6a81119cbc4eae\", \"midi_unittests\": \"e9bcaeea63e60b7e57edc6377b0e10ba68b22a24\", \"mojo_core_unittests\": \"66e819f886bbffe02948edc6cc9c0277b6f497bc\", \"mojo_unittests\": \"d1dc809002f2f0f8fc711032f100a142c71d7c03\", \"nacl_helper_nonsfi_unittests\": \"174f7461ec2d2caac333a65275fb1816332b436f\", \"nacl_loader_unittests\": \"da2e4b7901120adb3ee58fdafc1125ed46b6c2f7\", \"native_theme_unittests\": \"b0972a9e70aa60e6513a139906c255169eca6b88\", \"net_unittests\": \"8ee06118b6277eed73b5e3eeb48376b2881ac35e\", \"ozone_gl_unittests\": \"913027af33936bfe1957050f38a0b42aa0bcb24c\", \"ozone_unittests\": \"8c601baccb2549bbdb5670b6c95696c86f4528f4\", \"ozone_x11_unittests\": \"07b246ed6c1d81e241494e8af4dd64b8dd27f1e9\", \"pdf_unittests\": \"4e3cc2991a53b355133b2462e25e722bca1fd6f2\", \"perfetto_unittests\": \"5a8bdd2561524539e7be90801129acc76b5e4956\", \"ppapi_unittests\": \"801875faed159b4cc886f88678a467ae2179821f\", \"printing_unittests\": \"e32f386b3359df45f66fc43e0006e108847bf40c\", \"remoting_unittests\": \"4e30a020a7f49276913b8f8d7cc84f096ca5ef5e\", \"sandbox_linux_unittests\": \"ef4358997aa7087caad2b5c56243e4862efd3ec0\", \"service_manager_unittests\": \"eedd97b8f768a302f49c9e253789e714b774c5fd\", \"services_unittests\": \"1ae3721475c6110d3a2c2b6ef634ba42634f7b78\", \"shell_dialogs_unittests\": \"16680fb74818ec0aad4ddf1ea39783a4a2cb9bdf\", \"shell_encryption_unittests\": \"700578588359e1f892125fdcf9be2eb31a67e5e3\", \"skia_unittests\": \"31ebdd3a5e4db1f315e37297a67aaa539dcd982e\", \"snapshot_unittests\": \"66f291ede170337817e19e15e2b7777d96e40dfc\", \"sql_unittests\": \"11b2eb99452414adac2d3ff7c9f934ab903282c7\", \"storage_unittests\": \"1fedddb3b6da82815d3bd0b7c158793d30e4e208\", \"sync_integration_tests\": \"4f2e4d08d732af36aab925b74356300d4369afbb\", \"traffic_annotation_auditor_unittests\": \"f1708be298b5789aa57a3c360f903610d206c55a\", \"ui_base_unittests\": \"5a66aa9b5cb9d8e709db46f198c58347eef66b17\", \"ui_chromeos_unittests\": \"325a21f0dbc0a22481e8034e40a0c33ade7e4267\", \"ui_touch_selection_unittests\": \"12024d00d926c2948054f89bb45fd596c72c6b5b\", \"unit_tests\": \"bde088b151a64ec02e76737c6e83893a7dcd1e9c\", \"url_unittests\": \"a07aa7181081a2d87b7dca82682f2a5d25c23ab3\", \"usage_time_limit_unittests\": \"0e81f3b77290c0b7551d0959a421c0817790f17c\", \"views_unittests\": \"cc386a6380f0b61265c655776c623b55c5e49b69\", \"viz_unittests\": \"11bcf9eb432ab880333ede4b9245ac7332ba0ba3\", \"wayland_client_perftests\": \"d10f6ed1ce097f5706c64ee1eeca0a8b67bfcacf\", \"wm_unittests\": \"94972081e7d1a7f706e3f7cd1105729b1e4cbaad\", \"wtf_unittests\": \"7cf23aa1f06f318a43486cf5d83b980d80e0a904\", \"zlib_unittests\": \"53186e441f4d4cd4cb380a5dcc9bef8f672da098\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0e4559ffd6169ab721e778dfe83867ca08424e9b4d480f5c0e6f91286240fc3f_v2\", \"builder_1b8c0e295e0040ae60b46798151163eecc632ef935bd1ea9777aec71f94caa4f_v2\", \"builder_544ce64b59aa2a62f93b2d1058d8c643105c17650fa0dc2da4c94ddccafb95f6_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_9cda2f8c21edca8a77ce5edebdfeeced1c5c1bb5bdbdcfdc91d50b975e168f53_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_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-54-oga7\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606944102796396",
"status": "COMPLETED",
"status_changed_ts": "1606947204920344",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43390",
"builder:linux-chromeos-rel",
"buildset:commit/git/f8d0c16aa6e595ccdb18f1158b63cfe59601fc8e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f8d0c16aa6e595ccdb18f1158b63cfe59601fc8e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027420983447637264",
"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/8861990921402987712/+/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:503e23606412e010",
"user_agent:luci-scheduler"
],
"updated_ts": "1606947204926141",
"url": "https://ci.chromium.org/b/8861990921402987712",
"utcnow_ts": "1606947205638654"
}
}
[22:13:25.647] Invocation finished in 55m18.739887113s with status SUCCEEDED