[04:08:30.171] New invocation is queued and will start shortly
[04:08:31.279] Starting the invocation (attempt 1)
[04:08:31.319] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:08:31.320] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:08:31.320] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022321733982211344",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"eaf9228485e4eb6a91383c8918c3b2e8ffbed78e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022321733982211344",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/eaf9228485e4eb6a91383c8918c3b2e8ffbed78e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eaf9228485e4eb6a91383c8918c3b2e8ffbed78e",
"gitiles_ref:refs/heads/master"
]
}
[04:08:32.151] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611806911424891",
"id": "8856891672005253904",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eaf9228485e4eb6a91383c8918c3b2e8ffbed78e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611806911971631",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44961",
"builder:linux-chromeos-rel",
"buildset:commit/git/eaf9228485e4eb6a91383c8918c3b2e8ffbed78e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eaf9228485e4eb6a91383c8918c3b2e8ffbed78e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022321733982211344",
"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/8856891672005253904/+/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": "1611806911971754",
"url": "https://ci.chromium.org/b/8856891672005253904",
"utcnow_ts": "1611806912138723"
}
}
[04:08:32.151] Task URL: https://ci.chromium.org/b/8856891672005253904
[04:08:32.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:2:0) after 1m0s
[04:09:32.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:2:0)
[04:09:32.166] Timer tick, asking Buildbucket for the build status
[04:09:32.269] Build 8856891672005253904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:32.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:3:0) after 1m0s
[04:09:55.554] Received PubSub notification, asking Buildbucket for the build status
[04:09:55.661] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:32.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:3:0)
[04:10:32.304] Timer tick, asking Buildbucket for the build status
[04:10:33.187] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:33.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:5:0) after 1m0s
[04:11:33.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:5:0)
[04:11:33.206] Timer tick, asking Buildbucket for the build status
[04:11:34.300] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:34.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:6:0) after 1m0s
[04:12:34.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:6:0)
[04:12:34.318] Timer tick, asking Buildbucket for the build status
[04:12:35.940] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:35.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:7:0) after 1m0s
[04:13:35.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:7:0)
[04:13:35.974] Timer tick, asking Buildbucket for the build status
[04:13:36.148] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:36.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:8:0) after 1m0s
[04:14:36.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:8:0)
[04:14:36.154] Timer tick, asking Buildbucket for the build status
[04:14:36.390] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:36.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:9:0) after 1m0s
[04:15:36.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:9:0)
[04:15:36.413] Timer tick, asking Buildbucket for the build status
[04:15:36.899] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:36.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:10:0) after 1m0s
[04:16:36.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:10:0)
[04:16:36.985] Timer tick, asking Buildbucket for the build status
[04:16:37.153] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:37.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:11:0) after 1m0s
[04:17:37.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:11:0)
[04:17:37.163] Timer tick, asking Buildbucket for the build status
[04:17:37.247] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:37.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:12:0) after 1m0s
[04:18:37.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:12:0)
[04:18:37.233] Timer tick, asking Buildbucket for the build status
[04:18:38.694] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:38.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:13:0) after 1m0s
[04:19:38.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:13:0)
[04:19:38.733] Timer tick, asking Buildbucket for the build status
[04:19:38.829] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:38.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:14:0) after 1m0s
[04:20:38.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:14:0)
[04:20:38.848] Timer tick, asking Buildbucket for the build status
[04:20:38.923] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:38.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:15:0) after 1m0s
[04:21:38.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:15:0)
[04:21:38.941] Timer tick, asking Buildbucket for the build status
[04:21:39.021] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:39.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:16:0) after 1m0s
[04:22:39.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:16:0)
[04:22:39.076] Timer tick, asking Buildbucket for the build status
[04:22:39.184] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:39.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:17:0) after 1m0s
[04:23:39.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:17:0)
[04:23:39.207] Timer tick, asking Buildbucket for the build status
[04:23:39.969] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:39.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:18:0) after 1m0s
[04:24:40.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:18:0)
[04:24:40.051] Timer tick, asking Buildbucket for the build status
[04:24:40.751] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:40.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:19:0) after 1m0s
[04:25:40.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:19:0)
[04:25:40.804] Timer tick, asking Buildbucket for the build status
[04:25:40.869] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:40.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:20:0) after 1m0s
[04:26:40.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:20:0)
[04:26:40.893] Timer tick, asking Buildbucket for the build status
[04:26:40.954] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:40.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:21:0) after 1m0s
[04:27:40.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:21:0)
[04:27:40.993] Timer tick, asking Buildbucket for the build status
[04:27:41.267] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:41.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:22:0) after 1m0s
[04:28:41.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:22:0)
[04:28:41.286] Timer tick, asking Buildbucket for the build status
[04:28:41.961] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:41.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:23:0) after 1m0s
[04:29:42.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:23:0)
[04:29:42.036] Timer tick, asking Buildbucket for the build status
[04:29:42.282] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:42.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:24:0) after 1m0s
[04:30:42.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:24:0)
[04:30:42.365] Timer tick, asking Buildbucket for the build status
[04:30:42.472] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:42.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:25:0) after 1m0s
[04:31:42.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:25:0)
[04:31:42.514] Timer tick, asking Buildbucket for the build status
[04:31:42.635] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:42.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:26:0) after 1m0s
[04:32:42.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:26:0)
[04:32:42.658] Timer tick, asking Buildbucket for the build status
[04:32:42.803] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:42.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:27:0) after 1m0s
[04:33:42.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:27:0)
[04:33:42.873] Timer tick, asking Buildbucket for the build status
[04:33:43.037] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:43.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:28:0) after 1m0s
[04:34:43.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:28:0)
[04:34:43.057] Timer tick, asking Buildbucket for the build status
[04:34:43.195] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:43.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:29:0) after 1m0s
[04:35:43.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:29:0)
[04:35:43.214] Timer tick, asking Buildbucket for the build status
[04:35:43.287] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:43.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:30:0) after 1m0s
[04:36:43.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:30:0)
[04:36:43.314] Timer tick, asking Buildbucket for the build status
[04:36:43.403] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:43.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:31:0) after 1m0s
[04:37:43.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:31:0)
[04:37:43.444] Timer tick, asking Buildbucket for the build status
[04:37:44.271] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:44.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:32:0) after 1m0s
[04:38:44.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:32:0)
[04:38:44.293] Timer tick, asking Buildbucket for the build status
[04:38:44.702] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:44.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:33:0) after 1m0s
[04:39:44.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:33:0)
[04:39:44.706] Timer tick, asking Buildbucket for the build status
[04:39:44.778] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:44.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:34:0) after 1m0s
[04:40:44.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:34:0)
[04:40:44.780] Timer tick, asking Buildbucket for the build status
[04:40:44.880] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:44.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:35:0) after 1m0s
[04:41:44.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:35:0)
[04:41:44.902] Timer tick, asking Buildbucket for the build status
[04:41:45.219] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:45.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:36:0) after 1m0s
[04:42:45.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:36:0)
[04:42:45.261] Timer tick, asking Buildbucket for the build status
[04:42:45.334] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:45.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:37:0) after 1m0s
[04:43:45.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:37:0)
[04:43:45.334] Timer tick, asking Buildbucket for the build status
[04:43:45.478] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:45.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:38:0) after 1m0s
[04:44:45.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:38:0)
[04:44:45.529] Timer tick, asking Buildbucket for the build status
[04:44:45.651] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:45.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:39:0) after 1m0s
[04:45:45.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:39:0)
[04:45:45.685] Timer tick, asking Buildbucket for the build status
[04:45:46.176] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:46.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:40:0) after 1m0s
[04:46:46.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:40:0)
[04:46:46.197] Timer tick, asking Buildbucket for the build status
[04:46:46.276] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:46.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:41:0) after 1m0s
[04:47:46.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:41:0)
[04:47:46.284] Timer tick, asking Buildbucket for the build status
[04:47:46.406] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:46.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:42:0) after 1m0s
[04:48:46.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:42:0)
[04:48:46.424] Timer tick, asking Buildbucket for the build status
[04:48:46.528] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:46.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:43:0) after 1m0s
[04:49:46.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:43:0)
[04:49:46.609] Timer tick, asking Buildbucket for the build status
[04:49:47.313] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:47.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:44:0) after 1m0s
[04:50:47.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:44:0)
[04:50:47.350] Timer tick, asking Buildbucket for the build status
[04:50:47.510] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:47.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:45:0) after 1m0s
[04:51:47.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:45:0)
[04:51:47.523] Timer tick, asking Buildbucket for the build status
[04:51:47.653] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:47.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:46:0) after 1m0s
[04:52:47.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:46:0)
[04:52:47.714] Timer tick, asking Buildbucket for the build status
[04:52:48.169] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:48.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:47:0) after 1m0s
[04:53:48.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:47:0)
[04:53:48.236] Timer tick, asking Buildbucket for the build status
[04:53:48.356] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:48.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:48:0) after 1m0s
[04:54:48.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:48:0)
[04:54:48.429] Timer tick, asking Buildbucket for the build status
[04:54:48.544] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:48.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:49:0) after 1m0s
[04:55:48.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:49:0)
[04:55:48.586] Timer tick, asking Buildbucket for the build status
[04:55:48.748] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:48.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:50:0) after 1m0s
[04:56:48.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:50:0)
[04:56:48.769] Timer tick, asking Buildbucket for the build status
[04:56:49.115] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:49.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:51:0) after 1m0s
[04:57:49.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:51:0)
[04:57:49.169] Timer tick, asking Buildbucket for the build status
[04:57:49.282] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:49.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:52:0) after 1m0s
[04:58:49.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:52:0)
[04:58:49.351] Timer tick, asking Buildbucket for the build status
[04:58:49.622] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:49.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:53:0) after 1m0s
[04:59:49.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:53:0)
[04:59:49.625] Timer tick, asking Buildbucket for the build status
[04:59:50.610] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:50.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:54:0) after 1m0s
[05:00:50.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:54:0)
[05:00:50.632] Timer tick, asking Buildbucket for the build status
[05:00:51.293] Build 8856891672005253904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:51.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022321733982211344:55:0) after 1m0s
[05:01:36.211] Received PubSub notification, asking Buildbucket for the build status
[05:01:36.372] Build 8856891672005253904: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:01:36.372] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611810095105878",
"created_by": "project:chromium",
"created_ts": "1611806911424891",
"id": "8856891672005253904",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eaf9228485e4eb6a91383c8918c3b2e8ffbed78e\"}}",
"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\": \"eaf9228485e4eb6a91383c8918c3b2e8ffbed78e\", \"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-207-xtuo\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44961, \"got_angle_revision\": \"52afb6f17cbd13a290c2798b565067f47d47af86\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"eaf9228485e4eb6a91383c8918c3b2e8ffbed78e\", \"got_revision_cp\": \"refs/heads/master@{#847962}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"54a4e0518d25fab76af6ec1d99b860b0b53b47cf\", \"got_v8_revision_cp\": \"refs/heads/9.0.90@{#1}\", \"got_webrtc_revision\": \"49dbad021e802197b3c0b966c03b4aa766a5b578\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33080}\", \"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\", \"prev_got_revision\": \"1d3942742497e3bafd7ee9046705f3b42a77be23\", \"prev_got_revision_cp\": \"refs/heads/master@{#847952}\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eaf9228485e4eb6a91383c8918c3b2e8ffbed78e\", \"swarm_hashes_refs/heads/master(at){#847962}_without_patch\": {\"absl_hardening_tests\": \"79ca62d4d709ee137638c2a36b6b25fc55d1f9b4\", \"accessibility_unittests\": \"83c4ba7380e621445921237bf473a31f354e927c\", \"angle_unittests\": \"c03e19e2279ab8657dc4a86ed1043efa3c77cfbb\", \"app_list_unittests\": \"89bd73ad0fe2c0e210e7bae54e6a87565498e377\", \"app_shell_unittests\": \"fa04ace886ef05f407ddbd25a7b139040ba276ac\", \"ash_unittests\": \"84734e8be1362274c1fbd32f1e580308c59323b7\", \"aura_unittests\": \"522cc3516671a7814b2707d165555804fb1ff5cc\", \"base_unittests\": \"457f5ac8c70725281ba4e97a38c6660e6ce8b962\", \"base_util_unittests\": \"9291099af79e257b346f4b20d97ca845076c1794\", \"blink_common_unittests\": \"d9d2adaa88475ab625acd635319812a9e267e1ea\", \"blink_fuzzer_unittests\": \"039f43908a872c1e08af107f9e7571df307c3ae0\", \"blink_heap_unittests\": \"d1b472536446ac164ea92b50ad437626d7e14bbb\", \"blink_platform_unittests\": \"b916fd739824eb69a3923722a6c892874e924d3c\", \"blink_unittests\": \"130819df37aa76014b0170cd77a8d2f215ce90b9\", \"boringssl_crypto_tests\": \"d0ff0551a485c92e279be7c2f89a20ed4c444495\", \"boringssl_ssl_tests\": \"b10e52dc8ffec7e5fb9bc986b83dbdbba62a5998\", \"browser_tests\": \"9056331cb31397dd9425ebcfe5647e7a1b1781c6\", \"capture_unittests\": \"5dffffac3df671fd18dd950e9d0eb430e8c3a15f\", \"cast_unittests\": \"e9e54530b033f20efba3ef29b4c187d51f336eb3\", \"cc_unittests\": \"ce05971fde382b6ac063cf9e202a620299945830\", \"chrome_app_unittests\": \"e559e3ea7feaba27ccaa886b59f8fa125892533a\", \"chromedriver_unittests\": \"7154f701b0af55f585583ba7a7fe37831b167906\", \"chromeos_components_unittests\": \"f06bed744c60def60359aad6edd27efde05881ba\", \"chromeos_unittests\": \"234cf101e03c6dd43a509337eac1e3b65c4edf69\", \"components_browsertests\": \"6dd3fc77b1b2455e36506f853e1ed62aed96aa58\", \"components_unittests\": \"2884f4c4f87c877010ba2d749377db7e1809e0cb\", \"compositor_unittests\": \"a298416adc573e8af859aebff6073c3a7e74a989\", \"content_browsertests\": \"e681eb8ab65ad73c344c6f63f58c5df518faae0f\", \"content_unittests\": \"e39bd79ebab00167093a9b51fcb5ff3e78fe6e5e\", \"crashpad_tests\": \"631620a423690a8317e7ee8e3dcda50725f60730\", \"crypto_unittests\": \"dccedc247e6b8aaaa616962889fe758cb3bf677f\", \"dbus_unittests\": \"f62b547eec2348ce38c0ec9b0c4037c97c05432b\", \"device_unittests\": \"62a33fdbe2672047e0f14268d3ebe42ed1c9f90e\", \"display_unittests\": \"2c74cdc8e662f22df33d17890123ae69984be0f5\", \"events_unittests\": \"93251ff6a9dbbeb8602bb4123362af6a09d0ebed\", \"exo_unittests\": \"cfd34416921ff3291b0f4ffd11623de0ec96f715\", \"extensions_browsertests\": \"5bd89fe2530621d88680e30e04a172c28d7ec396\", \"extensions_unittests\": \"2c061d5f77ade7d348d2fe0c59209c15c37d8964\", \"filesystem_service_unittests\": \"5ace3c146e459cfc046d927f3fd223d86130db48\", \"gcm_unit_tests\": \"2a5c0f862ed8b989aa01a7f8c68c643d24c9a977\", \"gfx_unittests\": \"5b4a975c3603adf190c0721740e37a1e2b059d96\", \"gin_unittests\": \"d547dc10745c3c9f21213241c3cc2718969727b6\", \"gl_unittests_ozone\": \"729679edec0e56d9ca350f726be4c500ffb530d4\", \"google_apis_unittests\": \"92614f8b0176d4f38a324ff4797c8347b03d4804\", \"gpu_unittests\": \"43d620c402a34a9e48bbf687d6272e43f171be8a\", \"gwp_asan_unittests\": \"4faf94f3d52341b302d8974c9c906b1977f3e7e7\", \"interactive_ui_tests\": \"c83631c9a661b80627caa8cc21437bc5bcf8ca95\", \"ipc_tests\": \"a6bc7a6dc6e51e7c04bcd42ed549ebec08e9e03b\", \"jingle_unittests\": \"cc9278a5fb01528ea308f235acf73164a2f81c5b\", \"keyboard_unittests\": \"51be73311d20f49acf92ffb508b54d3ce06f0861\", \"latency_unittests\": \"9b7b1be6eea0dbcf87bfc4cd50a2fb7ff00f12e3\", \"libjingle_xmpp_unittests\": \"05cb80a3e1a2970c280d438885ad3e7a727c8253\", \"liburlpattern_unittests\": \"c6b77f5783f7e946258beb0e51fa488301aa94a3\", \"media_blink_unittests\": \"eebf4163869de933796cc86554d43d46d449c30e\", \"media_unittests\": \"be7a2fa2c138066d1ed43ed73117cd6035557ab9\", \"message_center_unittests\": \"3a98228e0c159b3bc9d91dd822a5fe21090a7474\", \"midi_unittests\": \"aaeddf8fb562cc2928ea7c7b48047ba7a499f122\", \"mojo_core_unittests\": \"5eff85e14f9dac28ba8118f953875dcfb455963f\", \"mojo_unittests\": \"96e9102dc5b94140916a70e9753312848350c951\", \"nacl_helper_nonsfi_unittests\": \"120c9db1b8fbc24701aa07c07cdc7a9b46b1c410\", \"nacl_loader_unittests\": \"a95f53861f54127e194c344bb41983485b12358d\", \"native_theme_unittests\": \"a9763921227de428e59a903d62ddb3ded056e183\", \"net_unittests\": \"044821b9893de9092be639189f9b85473cf74ff7\", \"ozone_gl_unittests\": \"44f7a9d885bd859a0bc9249f0474452fad77e17f\", \"ozone_unittests\": \"bc9ca686d7ef750d4bb28a86ab24a48f485a4879\", \"ozone_x11_unittests\": \"e775aa3c1f82e098afde32755ce93b365a3c2caa\", \"pdf_unittests\": \"e3c191af346253868032f754db58d6305030e2f0\", \"perfetto_unittests\": \"effd3463ac6b47380b84fc3e0958825b34f08090\", \"ppapi_unittests\": \"f7de145217836c2df94870c4791e13f318676ba8\", \"printing_unittests\": \"039425508df11da2df38537ac0dbe6a876c79404\", \"remoting_unittests\": \"01bd3212d0d75901dd1b0239e1ea8fbe9d6ff2d6\", \"sandbox_linux_unittests\": \"7b75156a3a9ef08933299bf1d4d00b47806918f3\", \"service_manager_unittests\": \"40d84fb0f7f1b0b3d569df59e09756efcc8ae49d\", \"services_unittests\": \"64e753279690fb3bc529f76d137e34771d01340f\", \"shell_dialogs_unittests\": \"cf96ed1e84a2d5f062fbfdb52678de03b5b2f200\", \"shell_encryption_unittests\": \"8a3de6477c9e66974a3842db7655c961fb6c707e\", \"skia_unittests\": \"ee291066e3feebff8ffe256b042abc2094222e92\", \"snapshot_unittests\": \"c3b2e9d55da396163d646c9229631f1db4a7da27\", \"sql_unittests\": \"57ba03ecf28c6366d481680161eec246f952e2ab\", \"storage_unittests\": \"6accc7b183a0c4ff253d28000942a4b504330116\", \"sync_integration_tests\": \"3e46e4d484393eaee2c7f64c660138f6f6f8c94a\", \"traffic_annotation_auditor_unittests\": \"15806a4ca64efeb4308be6a59a42e129a7aea5fc\", \"ui_base_unittests\": \"00f02cb13ff43aab95d9c98dcc5c53525d47561b\", \"ui_chromeos_unittests\": \"fd7a812b91ff591927a02ecb0c0c178d6e960676\", \"ui_touch_selection_unittests\": \"a1d924067afc89e94cf287c5c5c3912c2906ac1a\", \"unit_tests\": \"3024882fdd69ea02ef153f1330ba9f5d8c4a5e99\", \"url_unittests\": \"cd0492f1f42dbe50fe062f947aaa4d903b9fda07\", \"usage_time_limit_unittests\": \"365d8cd85ec21a93272f3ee6d3b471df1b82ca57\", \"views_unittests\": \"6c7d5967025544127f97c040dd263f109013bf91\", \"viz_unittests\": \"ee2380dc9510061ec96cff04f757a6573548eb34\", \"wayland_client_perftests\": \"398421b0d105d8918feeaa3b8e4490e74f35aa47\", \"wm_unittests\": \"b35c0fa1b59dfa96c8416ae6dd22be9cda84aec8\", \"wtf_unittests\": \"27a01ba9246ee33ffbe67c98a8c0972c6bf82b6e\", \"zlib_unittests\": \"40228d23436accefd9b2718da127fa346006af78\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0fb1f456593ae2600bf9c9616e0e5dcc3c87ffc9d4d6fb93e9350aac8ae4516c_v2\", \"builder_25c22b29ff9525bbfd333bb12e92a9faf5d35886dc9a7dacce03d872c45df5d1_v2\", \"builder_34caa451ddae04e30af534f20a2f04cca4108dc27b0a92529062f4f2e114a8e9_v2\", \"builder_74d362f4b8458dd9d0e97927161f205f1d3617f2c5338e4089191185ec3041e6_v2\", \"builder_7f949073f7e904bb9563d7870e146ee8e8e8f26011cb03330fcb60d1fc06c798_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_f0afc432815c064941e1e5f998abb72673d4068febb53723f4aedad56e1b9c62_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-207-xtuo\"], \"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\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611806994511145",
"status": "COMPLETED",
"status_changed_ts": "1611810095813030",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44961",
"builder:linux-chromeos-rel",
"buildset:commit/git/eaf9228485e4eb6a91383c8918c3b2e8ffbed78e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eaf9228485e4eb6a91383c8918c3b2e8ffbed78e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022321733982211344",
"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/8856891672005253904/+/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:515fff370eaafa10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611810095819044",
"url": "https://ci.chromium.org/b/8856891672005253904",
"utcnow_ts": "1611810096354499"
}
}
[05:01:36.372] Invocation finished in 53m6.217871279s with status SUCCEEDED