[13:00:14.143] New invocation is queued and will start shortly
[13:00:15.266] Starting the invocation (attempt 1)
[13:00:15.313] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:00:15.314] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:00:15.314] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018754998561225280",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2efc53d12f91b445b902a04509f27564687a5ce6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018754998561225280",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/2efc53d12f91b445b902a04509f27564687a5ce6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2efc53d12f91b445b902a04509f27564687a5ce6",
"gitiles_ref:refs/heads/master"
]
}
[13:00:15.990] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615208415522630",
"id": "8853324936443729056",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2efc53d12f91b445b902a04509f27564687a5ce6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615208415892213",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45991",
"builder:linux-chromeos-rel",
"buildset:commit/git/2efc53d12f91b445b902a04509f27564687a5ce6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2efc53d12f91b445b902a04509f27564687a5ce6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018754998561225280",
"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/8853324936443729056/+/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": "1615208415892317",
"url": "https://ci.chromium.org/b/8853324936443729056",
"utcnow_ts": "1615208415984422"
}
}
[13:00:15.990] Task URL: https://ci.chromium.org/b/8853324936443729056
[13:00:15.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:2:0) after 1m0s
[13:00:57.926] Received PubSub notification, asking Buildbucket for the build status
[13:00:58.351] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:16.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:2:0)
[13:01:16.096] Timer tick, asking Buildbucket for the build status
[13:01:16.208] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:16.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:4:0) after 1m0s
[13:02:16.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:4:0)
[13:02:16.738] Timer tick, asking Buildbucket for the build status
[13:02:17.333] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:17.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:5:0) after 1m0s
[13:03:17.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:5:0)
[13:03:17.704] Timer tick, asking Buildbucket for the build status
[13:03:17.841] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:17.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:6:0) after 1m0s
[13:04:17.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:6:0)
[13:04:17.881] Timer tick, asking Buildbucket for the build status
[13:04:17.986] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:17.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:7:0) after 1m0s
[13:05:18.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:7:0)
[13:05:18.127] Timer tick, asking Buildbucket for the build status
[13:05:18.329] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:18.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:8:0) after 1m0s
[13:06:18.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:8:0)
[13:06:18.457] Timer tick, asking Buildbucket for the build status
[13:06:18.544] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:18.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:9:0) after 1m0s
[13:07:20.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:9:0)
[13:07:20.181] Timer tick, asking Buildbucket for the build status
[13:07:20.421] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:20.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:10:0) after 1m0s
[13:08:20.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:10:0)
[13:08:20.608] Timer tick, asking Buildbucket for the build status
[13:08:20.823] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:20.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:11:0) after 1m0s
[13:09:20.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:11:0)
[13:09:20.871] Timer tick, asking Buildbucket for the build status
[13:09:21.361] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:21.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:12:0) after 1m0s
[13:10:21.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:12:0)
[13:10:21.409] Timer tick, asking Buildbucket for the build status
[13:10:21.490] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:21.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:13:0) after 1m0s
[13:11:21.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:13:0)
[13:11:21.527] Timer tick, asking Buildbucket for the build status
[13:11:22.049] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:22.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:14:0) after 1m0s
[13:12:22.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:14:0)
[13:12:22.127] Timer tick, asking Buildbucket for the build status
[13:12:22.190] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:22.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:15:0) after 1m0s
[13:13:22.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:15:0)
[13:13:22.307] Timer tick, asking Buildbucket for the build status
[13:13:22.399] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:22.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:16:0) after 1m0s
[13:14:22.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:16:0)
[13:14:22.431] Timer tick, asking Buildbucket for the build status
[13:14:22.501] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:22.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:17:0) after 1m0s
[13:15:22.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:17:0)
[13:15:22.519] Timer tick, asking Buildbucket for the build status
[13:15:22.598] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:22.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:18:0) after 1m0s
[13:16:22.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:18:0)
[13:16:22.639] Timer tick, asking Buildbucket for the build status
[13:16:22.705] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:22.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:19:0) after 1m0s
[13:17:22.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:19:0)
[13:17:22.772] Timer tick, asking Buildbucket for the build status
[13:17:22.856] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:22.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:20:0) after 1m0s
[13:18:22.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:20:0)
[13:18:22.891] Timer tick, asking Buildbucket for the build status
[13:18:23.037] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:23.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:21:0) after 1m0s
[13:19:23.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:21:0)
[13:19:23.073] Timer tick, asking Buildbucket for the build status
[13:19:23.336] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:23.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:22:0) after 1m0s
[13:20:23.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:22:0)
[13:20:23.373] Timer tick, asking Buildbucket for the build status
[13:20:23.669] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:23.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:23:0) after 1m0s
[13:21:23.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:23:0)
[13:21:23.696] Timer tick, asking Buildbucket for the build status
[13:21:23.761] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:23.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:24:0) after 1m0s
[13:22:23.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:24:0)
[13:22:23.744] Timer tick, asking Buildbucket for the build status
[13:22:23.838] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:23.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:25:0) after 1m0s
[13:23:23.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:25:0)
[13:23:23.874] Timer tick, asking Buildbucket for the build status
[13:23:23.952] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:23.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:26:0) after 1m0s
[13:24:24.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:26:0)
[13:24:24.002] Timer tick, asking Buildbucket for the build status
[13:24:24.258] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:24.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:27:0) after 1m0s
[13:25:24.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:27:0)
[13:25:24.289] Timer tick, asking Buildbucket for the build status
[13:25:24.356] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:24.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:28:0) after 1m0s
[13:26:24.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:28:0)
[13:26:24.424] Timer tick, asking Buildbucket for the build status
[13:26:25.119] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:25.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:29:0) after 1m0s
[13:27:25.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:29:0)
[13:27:25.257] Timer tick, asking Buildbucket for the build status
[13:27:25.323] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:25.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:30:0) after 1m0s
[13:28:25.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:30:0)
[13:28:25.341] Timer tick, asking Buildbucket for the build status
[13:28:25.618] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:25.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:31:0) after 1m0s
[13:29:25.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:31:0)
[13:29:25.683] Timer tick, asking Buildbucket for the build status
[13:29:25.753] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:25.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:32:0) after 1m0s
[13:30:25.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:32:0)
[13:30:25.801] Timer tick, asking Buildbucket for the build status
[13:30:25.941] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:25.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:33:0) after 1m0s
[13:31:25.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:33:0)
[13:31:25.972] Timer tick, asking Buildbucket for the build status
[13:31:26.248] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:26.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:34:0) after 1m0s
[13:32:26.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:34:0)
[13:32:26.267] Timer tick, asking Buildbucket for the build status
[13:32:26.441] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:26.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:35:0) after 1m0s
[13:33:26.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:35:0)
[13:33:26.470] Timer tick, asking Buildbucket for the build status
[13:33:26.541] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:26.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:36:0) after 1m0s
[13:34:26.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:36:0)
[13:34:26.871] Timer tick, asking Buildbucket for the build status
[13:34:26.974] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:26.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:37:0) after 1m0s
[13:35:27.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:37:0)
[13:35:27.236] Timer tick, asking Buildbucket for the build status
[13:35:27.296] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:27.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:38:0) after 1m0s
[13:36:27.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:38:0)
[13:36:27.456] Timer tick, asking Buildbucket for the build status
[13:36:27.554] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:27.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:39:0) after 1m0s
[13:37:27.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:39:0)
[13:37:27.834] Timer tick, asking Buildbucket for the build status
[13:37:28.255] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:28.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:40:0) after 1m0s
[13:38:28.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:40:0)
[13:38:28.253] Timer tick, asking Buildbucket for the build status
[13:38:28.429] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:28.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:41:0) after 1m0s
[13:39:28.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:41:0)
[13:39:28.482] Timer tick, asking Buildbucket for the build status
[13:39:28.904] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:28.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:42:0) after 1m0s
[13:40:28.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:42:0)
[13:40:28.996] Timer tick, asking Buildbucket for the build status
[13:40:29.080] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:29.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:43:0) after 1m0s
[13:41:29.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:43:0)
[13:41:29.058] Timer tick, asking Buildbucket for the build status
[13:41:29.138] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:29.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:44:0) after 1m0s
[13:42:29.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:44:0)
[13:42:29.193] Timer tick, asking Buildbucket for the build status
[13:42:29.260] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:29.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:45:0) after 1m0s
[13:43:29.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:45:0)
[13:43:29.282] Timer tick, asking Buildbucket for the build status
[13:43:29.360] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:29.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:46:0) after 1m0s
[13:44:29.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:46:0)
[13:44:29.405] Timer tick, asking Buildbucket for the build status
[13:44:29.590] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:29.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:47:0) after 1m0s
[13:45:29.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:47:0)
[13:45:29.605] Timer tick, asking Buildbucket for the build status
[13:45:29.770] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:29.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:48:0) after 1m0s
[13:46:29.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:48:0)
[13:46:29.774] Timer tick, asking Buildbucket for the build status
[13:46:29.852] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:29.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:49:0) after 1m0s
[13:47:29.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:49:0)
[13:47:29.904] Timer tick, asking Buildbucket for the build status
[13:47:30.023] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:30.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:50:0) after 1m0s
[13:48:30.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:50:0)
[13:48:30.190] Timer tick, asking Buildbucket for the build status
[13:48:30.261] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:30.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:51:0) after 1m0s
[13:49:30.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:51:0)
[13:49:30.387] Timer tick, asking Buildbucket for the build status
[13:49:30.471] Build 8853324936443729056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:30.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018754998561225280:52:0) after 1m0s
[13:50:14.888] Received PubSub notification, asking Buildbucket for the build status
[13:50:15.307] Build 8853324936443729056: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:50:15.307] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615211413497946",
"created_by": "project:chromium",
"created_ts": "1615208415522630",
"id": "8853324936443729056",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2efc53d12f91b445b902a04509f27564687a5ce6\"}}",
"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\": \"2efc53d12f91b445b902a04509f27564687a5ce6\", \"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-33-5qac\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45991, \"got_angle_revision\": \"9bc86c50f283560a3294c256bacccc1accb5bc94\", \"got_dawn_revision\": \"010fd1a8d7c7dd4e8fabe73546be78c45b6419c2\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"2efc53d12f91b445b902a04509f27564687a5ce6\", \"got_revision_cp\": \"refs/heads/master@{#860693}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"de7d5775ab25234a2c14d061e0cda342248a0e6d\", \"got_v8_revision\": \"f8b883fbba96b155409eb00da93826216bea9fc0\", \"got_v8_revision_cp\": \"refs/heads/9.1.60@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"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\": \"2efc53d12f91b445b902a04509f27564687a5ce6\", \"swarm_hashes_refs/heads/master(at){#860693}_without_patch\": {\"absl_hardening_tests\": \"42033aee87f14f7caae70e62ce07b154032900b0\", \"accessibility_unittests\": \"e00fc7c9b50cfdd4f6ed1a8a532483de8a98546c\", \"angle_unittests\": \"ae8a186f45d0e569998715fdeb3323f25ec421e1\", \"app_list_unittests\": \"dd0bc0e64f36846cb9906adf748c553ff26394e2\", \"app_shell_unittests\": \"89fa20766c1b78e3ea3de8ca4d4071f4d8045334\", \"ash_unittests\": \"65218693aa601af6e88b1399289c8751fc039ed6\", \"aura_unittests\": \"c756a9e4d983adb724a1e5169c9399706c5ac71c\", \"base_unittests\": \"78da33337e6dde03fcfe5a7c87c36c8d92c3baab\", \"base_util_unittests\": \"f038265b759aa2a44fb55f4b054878943e935c27\", \"blink_common_unittests\": \"59fee09e042645a066f85cc4ef0513adc41749bd\", \"blink_fuzzer_unittests\": \"69a9c00423b0b7ee003cb33d7498b2cb1589b6db\", \"blink_heap_unittests\": \"f17367244f45423bd86c6c74a4513448bfc757f4\", \"blink_platform_unittests\": \"ec82e2de8fa0ea6ae88a4f5898cc0ad033724f91\", \"blink_unittests\": \"7641d31e5001c6ae1785b057c92fc86c0b30c951\", \"boringssl_crypto_tests\": \"04d26bf044b9c9cba6645718c183748dc8917c6a\", \"boringssl_ssl_tests\": \"883a3697a0e11e7f91411a460bed70f7730065e2\", \"browser_tests\": \"846f24f04bf24c84c132a67ea24270eeb5287eab\", \"capture_unittests\": \"443cc16063e5d6b4efea547d3ed23f2fbad45792\", \"cast_unittests\": \"f1d6f417f35d6bd32cd253d024c427a1363a5286\", \"cc_unittests\": \"4e679d0fd5e79e0ee263e544a9111da93ca6cb44\", \"chrome_app_unittests\": \"faea29a0e3045212bb5d91723b7ff5a9df57dec6\", \"chromedriver_unittests\": \"b53f3ec307e662866ae9f7b5daca26bc1ba8d75d\", \"chromeos_components_unittests\": \"c16e20e48c942b964d7b6fe1f4ad6cc4c61f1fca\", \"chromeos_unittests\": \"d85afa30440d5ce00c7196200dfb6e334396a1fc\", \"color_unittests\": \"ac3824aa95cc57ae914501408bc71e3b67398f2c\", \"components_browsertests\": \"2cb48376f5e09cfbbe03ba57f6b775e9e613dd10\", \"components_unittests\": \"d1f4ab173419f6e98944a8161a0888a61dbb85ff\", \"compositor_unittests\": \"b81ad7c72bb9b7d6d24af9609815c91380c2452e\", \"content_browsertests\": \"67e9e8f5a263aeacdd6b7b168961e7cbb2e8b9ee\", \"content_unittests\": \"e214d35783f2186ab0e5eb86b9e10e6620c169e6\", \"crashpad_tests\": \"af3095318e2ac3116ec37db1fc5210b253cbffa0\", \"crypto_unittests\": \"39f801dfad3f82028b384212eed182d094b979bb\", \"dbus_unittests\": \"557c61afa249290d1caa8d183c2190badb06714f\", \"device_unittests\": \"76d92c33a9d2cf81a34c933acf0cc037e1546205\", \"display_unittests\": \"552ae167805885629e5ad9dbaab6efee69803763\", \"events_unittests\": \"f7fa33adf6b3b4b875a8f0ece55f109d0e318cd8\", \"exo_unittests\": \"f1beaec73d37994af0062310d1749fcd9b0afd5e\", \"extensions_browsertests\": \"8a5a73634d071563e5ddbfea30f77f5b41edc066\", \"extensions_unittests\": \"ff1641e88edd7c7dadc55f760ea2671f776fec4a\", \"filesystem_service_unittests\": \"04aa712b4f93a427b7f3187aed405690545ca3d2\", \"gcm_unit_tests\": \"e1f9d51fde9707b1d20cf8bba2cd3c1fa97a9a06\", \"gfx_unittests\": \"4b031c9eb61144b8ff2649736f77fb0be42839b0\", \"gin_unittests\": \"d2936a466ee1c9660565703b73ccc8d968d0251c\", \"gl_unittests_ozone\": \"53eed5e60156d5fe198f5c43ce01070d05b9c5b2\", \"google_apis_unittests\": \"9f59738cd4624ae67b34bc1f8a300bef94825511\", \"gpu_unittests\": \"bffb86921caa8b6b58a45582fd3299dab44c0114\", \"gwp_asan_unittests\": \"dc06aa12b2d664cccf90513165fa640d4b5c18f9\", \"interactive_ui_tests\": \"7c9d4a00f121ad9ca79a527a23507d9fc464a67b\", \"ipc_tests\": \"526671e855b620836875a6d9fe77f6231ff77563\", \"jingle_unittests\": \"bcdbaf138b4267759fa0a7f2b6e3f980599da1f3\", \"keyboard_unittests\": \"5c2a847aeded66367acdf2c1618e8d76c84499b9\", \"latency_unittests\": \"6b873ed11ccc03b9be66ea57e1a37c58f1884309\", \"libjingle_xmpp_unittests\": \"058025b421a779e83a418359c5e4222ed321e233\", \"liburlpattern_unittests\": \"feb9f41ec9af2f92127c0d8cb7dea692021e1e48\", \"media_blink_unittests\": \"4f02dc4c07601627b1ebbeadaf0f06391b9206ac\", \"media_unittests\": \"0f21a25d21c6493e1d0f9da74480c5ed56c8a283\", \"message_center_unittests\": \"fe71e446c2b4b0aabd8a40759af0908c1a089564\", \"midi_unittests\": \"63d809856d9f4f0c9914050daa2cc001f6293a9f\", \"mojo_core_unittests\": \"61182564c90cb752840c991d0e53238224a1c3e8\", \"mojo_unittests\": \"f4a1465d4b4f5f8c01b7349bf464f2aba77523d3\", \"nacl_helper_nonsfi_unittests\": \"be286d5c9bf95fd06396cd13dfb57a993fbacb37\", \"nacl_loader_unittests\": \"74a45afad0e0a748b37eed1532cb2b6cad82dad5\", \"native_theme_unittests\": \"2f391a51eaf6679bc20e9a0e1ef90528f6b2eaec\", \"net_unittests\": \"bde0da151749936d74f63d39acb573726dc5c4d7\", \"ozone_gl_unittests\": \"1c7930132e63d02062e6d996571a7a0be31fd62f\", \"ozone_unittests\": \"4eed2a21e598f83f10ff06def6e97b3ad280f776\", \"ozone_x11_unittests\": \"d83badd7c3c31427800b9e7c969036a258a5a852\", \"pdf_unittests\": \"16427b2a08f2f7f31aeee235c658dab3f9a6f3fa\", \"perfetto_unittests\": \"7d30025de24607f7b1359c381d0e3f19f866bdb8\", \"ppapi_unittests\": \"f35d9687e80ce4acbd0e3d44882f954297aecbd6\", \"printing_unittests\": \"778d3e366a501bb542b8f3e91b6700bd3608d486\", \"remoting_unittests\": \"fbbb89009881871546e44ff956799d31527f54e8\", \"sandbox_linux_unittests\": \"023c06d1e658192614e99797d9d20a0a9aeeeeff\", \"service_manager_unittests\": \"112071f5e91e98f31bb59553bfc8c14da264a498\", \"services_unittests\": \"ddcd1dedf111f2fcbc84993694d400726cca07ea\", \"shell_dialogs_unittests\": \"410b59936c67a4d4a8c722f7647b47f6004f1130\", \"shell_encryption_unittests\": \"8a970c6110ce7d4908b468486e311d726372cd66\", \"skia_unittests\": \"785e4dbaed6c83a144c619f83bcb93a14d15283a\", \"snapshot_unittests\": \"81a9530fba5786c65f93ce408817fa42b798a8f2\", \"sql_unittests\": \"147f27658d54072471e57c99ccb2163e5cda7cfd\", \"storage_unittests\": \"dd509f8718c3669f686959c632614d1fb02ba818\", \"sync_integration_tests\": \"9b3e58ffeda45c9273cad00df153af5ccb73c493\", \"traffic_annotation_auditor_unittests\": \"c1932c8322864e71fc7b116a09df5ae00f34ab88\", \"ui_base_unittests\": \"f53a28b708a27683f34bbbe81e4e64c587d7d8ed\", \"ui_chromeos_unittests\": \"2f8774a1c52aa981f4ed6757bbf9bc6e82651235\", \"ui_touch_selection_unittests\": \"3747b62fff16ca5c8767d483fb507983f854b451\", \"unit_tests\": \"d467c4d9825ee2e9a593c78c6a54ae35b88b54cb\", \"url_unittests\": \"d40284dcc4f48ffc011e2c73a1048075c611c1b3\", \"usage_time_limit_unittests\": \"bbd91edb9627fdab16fed3397fb62d64ee0baa63\", \"views_unittests\": \"a5cea8ac692c4f6f1ee3bdda1f4bdde1e7e8246d\", \"viz_unittests\": \"d6544004d17eea28e1a091d91020807e95afa74e\", \"wayland_client_perftests\": \"f8d232dfdeeb6cc51ab139bde826881ed7a8af47\", \"wayland_client_tests\": \"3096e55ba27a896654a23fb4de7e88dc27bed562\", \"wm_unittests\": \"16a0f16434c67341f6be24e2bb28eb6c02aee86a\", \"wtf_unittests\": \"dedf8c04a9b01c2f9e2e15faad06f5462087fd74\", \"zlib_unittests\": \"41f1d8fdbf0390c74e6d2133d19a39292f2a1c8f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3df726b65531685b338b7c2caf48988c15becc2e6a96e549d7512dce09d4fac6_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_49cfd195f2a0cca8cb73cb69371f0b72c7028f18b7affdf7b58db7400786f84c_v2\", \"builder_61d28ae4242dfdf39401ff089e29474922615b0ef755e75d038c04bc68e6c0fa_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_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-33-5qac\"], \"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\": [\"5744-5c0a4b4\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615208457204015",
"status": "COMPLETED",
"status_changed_ts": "1615211413755337",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45991",
"builder:linux-chromeos-rel",
"buildset:commit/git/2efc53d12f91b445b902a04509f27564687a5ce6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2efc53d12f91b445b902a04509f27564687a5ce6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018754998561225280",
"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/8853324936443729056/+/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:522abe0c8c198010",
"user_agent:luci-scheduler"
],
"updated_ts": "1615211413798770",
"url": "https://ci.chromium.org/b/8853324936443729056",
"utcnow_ts": "1615211415247214"
}
}
[13:50:15.307] Invocation finished in 50m1.187554692s with status SUCCEEDED