[19:55:22.361] New invocation is queued and will start shortly
[19:55:23.815] Starting the invocation (attempt 1)
[19:55:23.858] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:55:23.858] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:55:23.858] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018547686458787584",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5fee3f1ba3a60f12642c2a89ae6d82d49e4a7f7d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018547686458787584",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/5fee3f1ba3a60f12642c2a89ae6d82d49e4a7f7d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5fee3f1ba3a60f12642c2a89ae6d82d49e4a7f7d",
"gitiles_ref:refs/heads/master"
]
}
[19:55:25.024] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615406123934705",
"id": "8853117624147947840",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5fee3f1ba3a60f12642c2a89ae6d82d49e4a7f7d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615406124688165",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46058",
"builder:linux-chromeos-rel",
"buildset:commit/git/5fee3f1ba3a60f12642c2a89ae6d82d49e4a7f7d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5fee3f1ba3a60f12642c2a89ae6d82d49e4a7f7d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018547686458787584",
"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/8853117624147947840/+/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": "1615406124688329",
"url": "https://ci.chromium.org/b/8853117624147947840",
"utcnow_ts": "1615406125003710"
}
}
[19:55:25.024] Task URL: https://ci.chromium.org/b/8853117624147947840
[19:55:25.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:2:0) after 1m0s
[19:55:57.659] Received PubSub notification, asking Buildbucket for the build status
[19:55:57.746] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:25.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:2:0)
[19:56:25.055] Timer tick, asking Buildbucket for the build status
[19:56:25.154] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:25.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:4:0) after 1m0s
[19:57:25.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:4:0)
[19:57:25.170] Timer tick, asking Buildbucket for the build status
[19:57:25.250] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:25.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:5:0) after 1m0s
[19:58:25.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:5:0)
[19:58:25.238] Timer tick, asking Buildbucket for the build status
[19:58:25.317] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:25.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:6:0) after 1m0s
[19:59:25.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:6:0)
[19:59:25.416] Timer tick, asking Buildbucket for the build status
[19:59:25.710] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:25.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:7:0) after 1m0s
[20:00:25.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:7:0)
[20:00:25.797] Timer tick, asking Buildbucket for the build status
[20:00:25.926] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:25.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:8:0) after 1m0s
[20:01:26.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:8:0)
[20:01:26.085] Timer tick, asking Buildbucket for the build status
[20:01:26.172] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:26.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:9:0) after 1m0s
[20:02:26.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:9:0)
[20:02:26.254] Timer tick, asking Buildbucket for the build status
[20:02:26.443] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:26.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:10:0) after 1m0s
[20:03:26.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:10:0)
[20:03:26.506] Timer tick, asking Buildbucket for the build status
[20:03:26.593] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:26.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:11:0) after 1m0s
[20:04:26.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:11:0)
[20:04:26.711] Timer tick, asking Buildbucket for the build status
[20:04:26.949] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:26.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:12:0) after 1m0s
[20:05:27.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:12:0)
[20:05:27.009] Timer tick, asking Buildbucket for the build status
[20:05:27.350] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:27.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:13:0) after 1m0s
[20:06:27.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:13:0)
[20:06:27.398] Timer tick, asking Buildbucket for the build status
[20:06:27.571] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:27.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:14:0) after 1m0s
[20:07:27.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:14:0)
[20:07:27.654] Timer tick, asking Buildbucket for the build status
[20:07:27.764] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:27.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:15:0) after 1m0s
[20:08:27.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:15:0)
[20:08:27.795] Timer tick, asking Buildbucket for the build status
[20:08:27.942] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:27.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:16:0) after 1m0s
[20:09:28.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:16:0)
[20:09:28.094] Timer tick, asking Buildbucket for the build status
[20:09:28.223] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:28.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:17:0) after 1m0s
[20:10:28.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:17:0)
[20:10:28.242] Timer tick, asking Buildbucket for the build status
[20:10:28.330] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:28.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:18:0) after 1m0s
[20:11:28.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:18:0)
[20:11:28.347] Timer tick, asking Buildbucket for the build status
[20:11:28.423] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:28.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:19:0) after 1m0s
[20:12:28.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:19:0)
[20:12:28.446] Timer tick, asking Buildbucket for the build status
[20:12:28.614] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:28.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:20:0) after 1m0s
[20:13:28.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:20:0)
[20:13:28.663] Timer tick, asking Buildbucket for the build status
[20:13:28.735] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:28.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:21:0) after 1m0s
[20:14:28.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:21:0)
[20:14:28.780] Timer tick, asking Buildbucket for the build status
[20:14:28.850] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:28.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:22:0) after 1m0s
[20:15:28.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:22:0)
[20:15:28.967] Timer tick, asking Buildbucket for the build status
[20:15:29.084] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:29.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:23:0) after 1m0s
[20:16:29.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:23:0)
[20:16:29.115] Timer tick, asking Buildbucket for the build status
[20:16:29.255] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:29.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:24:0) after 1m0s
[20:17:29.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:24:0)
[20:17:29.272] Timer tick, asking Buildbucket for the build status
[20:17:29.346] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:29.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:25:0) after 1m0s
[20:18:29.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:25:0)
[20:18:29.364] Timer tick, asking Buildbucket for the build status
[20:18:29.425] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:29.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:26:0) after 1m0s
[20:19:29.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:26:0)
[20:19:29.442] Timer tick, asking Buildbucket for the build status
[20:19:29.525] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:29.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:27:0) after 1m0s
[20:20:29.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:27:0)
[20:20:29.552] Timer tick, asking Buildbucket for the build status
[20:20:29.642] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:29.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:28:0) after 1m0s
[20:21:29.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:28:0)
[20:21:29.688] Timer tick, asking Buildbucket for the build status
[20:21:29.805] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:29.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:29:0) after 1m0s
[20:22:29.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:29:0)
[20:22:29.810] Timer tick, asking Buildbucket for the build status
[20:22:29.881] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:29.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:30:0) after 1m0s
[20:23:29.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:30:0)
[20:23:29.923] Timer tick, asking Buildbucket for the build status
[20:23:30.010] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:30.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:31:0) after 1m0s
[20:24:30.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:31:0)
[20:24:30.037] Timer tick, asking Buildbucket for the build status
[20:24:30.113] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:30.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:32:0) after 1m0s
[20:25:30.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:32:0)
[20:25:30.132] Timer tick, asking Buildbucket for the build status
[20:25:30.210] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:30.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:33:0) after 1m0s
[20:26:30.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:33:0)
[20:26:30.230] Timer tick, asking Buildbucket for the build status
[20:26:30.597] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:30.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:34:0) after 1m0s
[20:27:30.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:34:0)
[20:27:30.620] Timer tick, asking Buildbucket for the build status
[20:27:30.714] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:30.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:35:0) after 1m0s
[20:28:30.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:35:0)
[20:28:30.769] Timer tick, asking Buildbucket for the build status
[20:28:31.104] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:31.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:36:0) after 1m0s
[20:29:31.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:36:0)
[20:29:31.143] Timer tick, asking Buildbucket for the build status
[20:29:31.216] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:31.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:37:0) after 1m0s
[20:30:31.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:37:0)
[20:30:31.268] Timer tick, asking Buildbucket for the build status
[20:30:31.378] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:31.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:38:0) after 1m0s
[20:31:31.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:38:0)
[20:31:31.406] Timer tick, asking Buildbucket for the build status
[20:31:32.761] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:32.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:39:0) after 1m0s
[20:32:32.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:39:0)
[20:32:32.764] Timer tick, asking Buildbucket for the build status
[20:32:32.841] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:32.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:40:0) after 1m0s
[20:33:32.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:40:0)
[20:33:32.892] Timer tick, asking Buildbucket for the build status
[20:33:33.053] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:33.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:41:0) after 1m0s
[20:34:33.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:41:0)
[20:34:33.081] Timer tick, asking Buildbucket for the build status
[20:34:33.151] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:33.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:42:0) after 1m0s
[20:35:33.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:42:0)
[20:35:33.206] Timer tick, asking Buildbucket for the build status
[20:35:33.307] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:33.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:43:0) after 1m0s
[20:36:33.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:43:0)
[20:36:33.413] Timer tick, asking Buildbucket for the build status
[20:36:33.548] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:33.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:44:0) after 1m0s
[20:37:33.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:44:0)
[20:37:33.621] Timer tick, asking Buildbucket for the build status
[20:37:33.700] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:33.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:45:0) after 1m0s
[20:38:33.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:45:0)
[20:38:33.761] Timer tick, asking Buildbucket for the build status
[20:38:33.832] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:33.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:46:0) after 1m0s
[20:39:33.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:46:0)
[20:39:33.864] Timer tick, asking Buildbucket for the build status
[20:39:33.930] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:33.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:47:0) after 1m0s
[20:40:34.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:47:0)
[20:40:34.013] Timer tick, asking Buildbucket for the build status
[20:40:34.151] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:34.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:48:0) after 1m0s
[20:41:34.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:48:0)
[20:41:34.197] Timer tick, asking Buildbucket for the build status
[20:41:34.266] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:34.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:49:0) after 1m0s
[20:42:34.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:49:0)
[20:42:34.331] Timer tick, asking Buildbucket for the build status
[20:42:34.439] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:34.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:50:0) after 1m0s
[20:43:34.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:50:0)
[20:43:34.494] Timer tick, asking Buildbucket for the build status
[20:43:34.634] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:34.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:51:0) after 1m0s
[20:44:34.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:51:0)
[20:44:34.724] Timer tick, asking Buildbucket for the build status
[20:44:34.958] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:34.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:52:0) after 1m0s
[20:45:34.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:52:0)
[20:45:34.977] Timer tick, asking Buildbucket for the build status
[20:45:35.857] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:35.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:53:0) after 1m0s
[20:46:35.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:53:0)
[20:46:35.926] Timer tick, asking Buildbucket for the build status
[20:46:36.018] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:36.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:54:0) after 1m0s
[20:47:36.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:54:0)
[20:47:36.174] Timer tick, asking Buildbucket for the build status
[20:47:36.713] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:36.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:55:0) after 1m0s
[20:48:36.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:55:0)
[20:48:36.717] Timer tick, asking Buildbucket for the build status
[20:48:36.852] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:36.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:56:0) after 1m0s
[20:49:36.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:56:0)
[20:49:36.974] Timer tick, asking Buildbucket for the build status
[20:49:37.156] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:37.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:57:0) after 1m0s
[20:50:37.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:57:0)
[20:50:37.285] Timer tick, asking Buildbucket for the build status
[20:50:37.416] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:37.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:58:0) after 1m0s
[20:51:38.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:58:0)
[20:51:38.177] Timer tick, asking Buildbucket for the build status
[20:51:38.263] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:38.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:59:0) after 1m0s
[20:52:38.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:59:0)
[20:52:38.379] Timer tick, asking Buildbucket for the build status
[20:52:38.445] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:38.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:60:0) after 1m0s
[20:53:38.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:60:0)
[20:53:38.570] Timer tick, asking Buildbucket for the build status
[20:53:38.651] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:38.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:61:0) after 1m0s
[20:54:38.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:61:0)
[20:54:38.675] Timer tick, asking Buildbucket for the build status
[20:54:38.775] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:38.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:62:0) after 1m0s
[20:55:38.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:62:0)
[20:55:38.937] Timer tick, asking Buildbucket for the build status
[20:55:39.060] Build 8853117624147947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:39.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018547686458787584:63:0) after 1m0s
[20:56:29.829] Received PubSub notification, asking Buildbucket for the build status
[20:56:29.957] Build 8853117624147947840: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:56:29.957] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615409787721226",
"created_by": "project:chromium",
"created_ts": "1615406123934705",
"id": "8853117624147947840",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5fee3f1ba3a60f12642c2a89ae6d82d49e4a7f7d\"}}",
"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\": \"5fee3f1ba3a60f12642c2a89ae6d82d49e4a7f7d\", \"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-70-prdt\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46058, \"got_angle_revision\": \"b2f547f4f423f492c4483d901d1b3ad5f3ad8798\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"5fee3f1ba3a60f12642c2a89ae6d82d49e4a7f7d\", \"got_revision_cp\": \"refs/heads/master@{#861641}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"de5df026428a7e343abb139064e99eac24cd2404\", \"got_v8_revision_cp\": \"refs/heads/9.1.90@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": true, \"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\": \"5fee3f1ba3a60f12642c2a89ae6d82d49e4a7f7d\", \"swarm_hashes_refs/heads/master(at){#861641}_without_patch\": {\"absl_hardening_tests\": \"b2d906c55e730996f32dba6b777470eecd08cecb\", \"accessibility_unittests\": \"f845613a3d71e4e0617ae6ae3a60773b424258d8\", \"angle_unittests\": \"b43a0dfba3698c2a5d1af5ecbc5b32e86dd79c1f\", \"app_list_unittests\": \"8705066ef0d8f5866c4fd098918fd736bc81338b\", \"app_shell_unittests\": \"7e85a6dbd6282bf965ab2ecaad2d29985ea6ae5a\", \"ash_unittests\": \"6d8b6a72ed83e81816929a8048d6f4e058ea2a3b\", \"aura_unittests\": \"01e36f0aaf8bbf9eb36245555b857ab24fb354b2\", \"base_unittests\": \"ae6bdc202f2cf12b11bbe8086fbf3a4d3eff8eb8\", \"base_util_unittests\": \"429b3563cfe8c8eb14abdbc4d84e61d392997e9f\", \"blink_common_unittests\": \"d60a61294778314cbc6216b17f8682b9f8a76219\", \"blink_fuzzer_unittests\": \"5e959e64c991266871652fc224d33e1d17fc2e2a\", \"blink_heap_unittests\": \"790bd2b7722756a487a73f5a81313453350e5712\", \"blink_platform_unittests\": \"bea384ccbaccaf1c1318d062f86f0f8ef822918d\", \"blink_unittests\": \"411b9eba7aa66f2b6fb592c1cb32c2d576f65f0e\", \"boringssl_crypto_tests\": \"7917290e6dc8f83c2f6dfaebc79244d1227961ea\", \"boringssl_ssl_tests\": \"2bbe8e48d9351287bf6144e303c21d9d77719fec\", \"browser_tests\": \"aa077c054e938ea349fed73a5f36f5f05bb84b28\", \"capture_unittests\": \"35d1eb483336c0fe3b38ffdaa6b92e26e7b9047d\", \"cast_unittests\": \"cfd2904dc421647bd9ba83366273fd6fe45be8c3\", \"cc_unittests\": \"64450ce58bdc34ace209e73ee7014cda4b38ff87\", \"chrome_app_unittests\": \"405c52fc9622573a57a79225ca6389a68dc122d3\", \"chromedriver_unittests\": \"72cbf464ee4ae045a21abb298d41024f2f4a66da\", \"chromeos_components_unittests\": \"ddbc3eac9f059077b30f4b7d2c942f280cfa5751\", \"chromeos_unittests\": \"170fd35e7e8821aa040fcaac26f90680f4ee9fe4\", \"color_unittests\": \"22012e36341484f9e6d7a35f148e716e37626698\", \"components_browsertests\": \"2698b15b63cb9f7817c672315639c673ec1841c8\", \"components_unittests\": \"2973e5b2c9865ea44ca901389afc9e6672d14613\", \"compositor_unittests\": \"91f8e8e8c207fd4d80f0085f00e71555f863c6c2\", \"content_browsertests\": \"5d5b1be051d12219924ebf1e767494efacc77426\", \"content_unittests\": \"8e303ba576cab007f1acf1a53018aaad748c3e7a\", \"crashpad_tests\": \"f4bbe971871f8b7516f4488b6ff7e489a47d5115\", \"crypto_unittests\": \"23c4495bbdf2aae32bfe553933b45e77330dbe11\", \"dbus_unittests\": \"48f6636f85398c2a61366c426b9a78ec2adb2078\", \"device_unittests\": \"dcc35276c690c00bd7e1c2fab2a7b9cd994fc4a7\", \"display_unittests\": \"9a27dc65ced22b322a15816f5e66ee9b3c026c53\", \"events_unittests\": \"ac3a99bb7797ab4c865e43763bcd8781dcf7f364\", \"exo_unittests\": \"1d8a8ceef8dd547604dddcc624189fed41ff81de\", \"extensions_browsertests\": \"8e3553907ca0d99e371350ca1e7266e36073cd13\", \"extensions_unittests\": \"3affa654d15dff27cd71b67912aa026e3f61aeb6\", \"filesystem_service_unittests\": \"3836a58acfa48eb2b0e529a7cb2272efac1d1474\", \"gcm_unit_tests\": \"fe08eb94cfdf39177369228b8259b60110d048fc\", \"gfx_unittests\": \"eb54c1077b5c5e8e41ffa92369ebc77ce7bd504d\", \"gin_unittests\": \"21e90e21579bdc4e4694c792ecdb75be5090817c\", \"gl_unittests_ozone\": \"bd6dabf93f63f8d661882efb656c604014b9ce18\", \"google_apis_unittests\": \"a269791ab0f0469e3fd805a1b7d9e7826fbd3362\", \"gpu_unittests\": \"cbb158c00d6c52f63d97afd21dca6c6e8eafac05\", \"gwp_asan_unittests\": \"b8ebcc845f334b76f2006b8bc94cc6e5542c27e6\", \"interactive_ui_tests\": \"44d8c35ad20357e3241cd31220d0b5fb44742fb4\", \"ipc_tests\": \"1686e52174f42c91f5c33bf1dedbc9666908dd4e\", \"jingle_unittests\": \"1c1505fd60119e4e6d5d053eda0a499fbde3408d\", \"keyboard_unittests\": \"8b668d5594fc0164812db7c698bac1b8577c07cd\", \"latency_unittests\": \"a7ca34a1d329518d0b6086ca5782e2d77d1dfead\", \"libjingle_xmpp_unittests\": \"83efa45c2ff401b509e9e1bb751e678b0717cea6\", \"liburlpattern_unittests\": \"d68ab7d56f18e1bb156f7918d32e38d1dc2d50b5\", \"media_blink_unittests\": \"92427015fe92e10c6d44995422386b1a8702535b\", \"media_unittests\": \"be0aed0b739f980d99f11b52d7a60ccfcc4cdeca\", \"message_center_unittests\": \"08e85c8aa866e9c137e72b0597b968473e31ddf4\", \"midi_unittests\": \"7fc7cb960025b3bb87aafe51d51bf50107f967ee\", \"mojo_core_unittests\": \"db38a8e51a9bd081aefb01066351e7887d8331da\", \"mojo_unittests\": \"001132373e95f413ae07857dcddceb557562df46\", \"nacl_helper_nonsfi_unittests\": \"dcba318ea049df26d4673c2ad079b03a2e78c40d\", \"nacl_loader_unittests\": \"2f59ee477de55bbfc148dc95b46975e626a881fb\", \"native_theme_unittests\": \"2ccc2d6d3c35125c8d95395fa0f20a1f2406d2c2\", \"net_unittests\": \"efbc3cf6892606ee6e64485b6b42ce80cd0c3e68\", \"ozone_gl_unittests\": \"b30dd8efde754275cb9ea5aa78113e7303391de1\", \"ozone_unittests\": \"f41b9e0bb8bb64bf3109246a0a9a0c5885733171\", \"ozone_x11_unittests\": \"f866cda5343b5eecec06644cb3fe2c41c28c7c3b\", \"pdf_unittests\": \"c42fec775fb151e0255ef7704a7c6375d038b99a\", \"perfetto_unittests\": \"84165725ba44f262e43b9eec3893681e569d9f59\", \"ppapi_unittests\": \"942d78d9ca7502a0f164ad7c03d3bbcfdeb356c7\", \"printing_unittests\": \"8aefec8ca8fc8b4afdc878fe96d290610b362be2\", \"remoting_unittests\": \"6303c1051a3efd012e384f050d28f9539e07282f\", \"sandbox_linux_unittests\": \"acc67a70da294f12a4cb33fe171304b9f2872252\", \"service_manager_unittests\": \"01f27671965aaa9305fa82dc60e1c3b6ff46d71c\", \"services_unittests\": \"88b3997aed147225e1caa505300c74879557bec8\", \"shell_dialogs_unittests\": \"aa7030eecfa4db94d45458e2a271a3c85c050d75\", \"shell_encryption_unittests\": \"954d1fa749065da26caa58d4bd9554c1cd4e6272\", \"skia_unittests\": \"ee3a4db0cabb00bcca80495e615099c0ddfb25d0\", \"snapshot_unittests\": \"7b8e20cbf8a1cc5f955be68c5b667d3ceff29206\", \"sql_unittests\": \"8ade9803a01a2c69708e4295fcb7cf40332cda5f\", \"storage_unittests\": \"e21caa98db87a1a255030dab86ffcbe74286c6de\", \"sync_integration_tests\": \"552980fcf6f54ae03bc6fa0188349d33afc92a3f\", \"traffic_annotation_auditor_unittests\": \"9629f773499e1fc110b2f51bf7e060ef72bc0ba8\", \"ui_base_unittests\": \"e0c7768d93c9199bb1722a1618e77c5b9a0cba6b\", \"ui_chromeos_unittests\": \"3b123ffdf861939a93cf190f305202f73943f7c2\", \"ui_touch_selection_unittests\": \"00e3a02087a179b3c2df1f7403d78c336c8336fc\", \"unit_tests\": \"65a075c9cfc25e71b20e0ed00c7f0ce67e611d45\", \"url_unittests\": \"86aa80a7606767f1c3ef7a205b612cd99d0fa9c5\", \"usage_time_limit_unittests\": \"9e5dbf96fe3aa63e9eb5024a4a38b03735802e48\", \"views_unittests\": \"5263bc9aea7b952930a082c2bc24166cd53f2e08\", \"viz_unittests\": \"4a58c17c56141c96826f1101ef681c64bd474042\", \"wayland_client_perftests\": \"e54aee6a39bffa5af96b0f2f5f9651197754317d\", \"wayland_client_tests\": \"a2b28bde1db0d9bf29206bfd800c1f8c09b66e2b\", \"wm_unittests\": \"b3b173fd89abff5b6bff9538861add575e4b20ab\", \"wtf_unittests\": \"f148e0d0022aa39e7df96d2bad5a205e4c5680fe\", \"zlib_unittests\": \"b110951dd52171bdb643f93859ac38622286305b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_12fe258969bd458c0c491cc8ec8a110de21b19ba6d4540c003334ed929b828ba_v2\", \"builder_52b3455bc016485ac846758ed32679b3eb96461dff570695d0073fe962116473_v2\", \"builder_5f9879dd307b3e3de87d4273aaf77dfc3adf50a63c1d75c3b245bfdff463a933_v2\", \"builder_678d8b556ed6d2ea4aa43b80debb7b547a1d6d4433ddff28e80ab170912c760d_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9d891a598cf8ebf0ae5ddfdbe2fc0861535c9a49467e7412fefe4675a15b7f18_v2\", \"builder_f5b4454e99a04aaa5ba743b59cc70de19e20bebedef65e50e3b90534a8d6a5e4_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-70-prdt\"], \"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\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615406157043548",
"status": "COMPLETED",
"status_changed_ts": "1615409788213652",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46058",
"builder:linux-chromeos-rel",
"buildset:commit/git/5fee3f1ba3a60f12642c2a89ae6d82d49e4a7f7d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5fee3f1ba3a60f12642c2a89ae6d82d49e4a7f7d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018547686458787584",
"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/8853117624147947840/+/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:523686d7cbafe710",
"user_agent:luci-scheduler"
],
"updated_ts": "1615409788240424",
"url": "https://ci.chromium.org/b/8853117624147947840",
"utcnow_ts": "1615409789942366"
}
}
[20:56:29.957] Invocation finished in 1h1m7.609833492s with status SUCCEEDED