[02:12:54.494] New invocation is queued and will start shortly
[02:12:55.573] Starting the invocation (attempt 1)
[02:12:55.624] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:12:55.624] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:12:55.624] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029757957820675136",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"657b47a9eef04e784d0946d196e1a286d85774ab\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029757957820675136",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/657b47a9eef04e784d0946d196e1a286d85774ab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/657b47a9eef04e784d0946d196e1a286d85774ab",
"gitiles_ref:refs/heads/master"
]
}
[02:12:56.234] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604715175711392",
"id": "8864327895872312704",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"657b47a9eef04e784d0946d196e1a286d85774ab\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604715176085497",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42663",
"builder:linux-chromeos-rel",
"buildset:commit/git/657b47a9eef04e784d0946d196e1a286d85774ab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/657b47a9eef04e784d0946d196e1a286d85774ab",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029757957820675136",
"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/8864327895872312704/+/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": "1604715176085702",
"url": "https://ci.chromium.org/b/8864327895872312704",
"utcnow_ts": "1604715176220835"
}
}
[02:12:56.234] Task URL: https://ci.chromium.org/b/8864327895872312704
[02:12:56.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:2:0) after 1m0s
[02:13:03.147] Received PubSub notification, asking Buildbucket for the build status
[02:13:03.282] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:56.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:2:0)
[02:13:56.381] Timer tick, asking Buildbucket for the build status
[02:13:56.518] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:56.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:4:0) after 1m0s
[02:14:56.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:4:0)
[02:14:56.692] Timer tick, asking Buildbucket for the build status
[02:14:57.010] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:57.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:5:0) after 1m0s
[02:15:57.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:5:0)
[02:15:57.058] Timer tick, asking Buildbucket for the build status
[02:15:57.122] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:57.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:6:0) after 1m0s
[02:16:57.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:6:0)
[02:16:57.193] Timer tick, asking Buildbucket for the build status
[02:16:57.303] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:57.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:7:0) after 1m0s
[02:17:57.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:7:0)
[02:17:57.549] Timer tick, asking Buildbucket for the build status
[02:17:57.651] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:57.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:8:0) after 1m0s
[02:18:57.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:8:0)
[02:18:57.812] Timer tick, asking Buildbucket for the build status
[02:18:57.921] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:57.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:9:0) after 1m0s
[02:19:58.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:9:0)
[02:19:58.007] Timer tick, asking Buildbucket for the build status
[02:19:58.117] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:58.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:10:0) after 1m0s
[02:20:58.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:10:0)
[02:20:58.171] Timer tick, asking Buildbucket for the build status
[02:20:58.239] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:58.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:11:0) after 1m0s
[02:21:58.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:11:0)
[02:21:58.516] Timer tick, asking Buildbucket for the build status
[02:21:58.614] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:58.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:12:0) after 1m0s
[02:22:58.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:12:0)
[02:22:58.706] Timer tick, asking Buildbucket for the build status
[02:22:58.833] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:58.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:13:0) after 1m0s
[02:23:58.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:13:0)
[02:23:58.874] Timer tick, asking Buildbucket for the build status
[02:23:58.966] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:58.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:14:0) after 1m0s
[02:24:59.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:14:0)
[02:24:59.094] Timer tick, asking Buildbucket for the build status
[02:24:59.321] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:59.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:15:0) after 1m0s
[02:25:59.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:15:0)
[02:25:59.377] Timer tick, asking Buildbucket for the build status
[02:25:59.552] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:59.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:16:0) after 1m0s
[02:26:59.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:16:0)
[02:26:59.558] Timer tick, asking Buildbucket for the build status
[02:26:59.635] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:59.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:17:0) after 1m0s
[02:27:59.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:17:0)
[02:27:59.771] Timer tick, asking Buildbucket for the build status
[02:27:59.899] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:59.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:18:0) after 1m0s
[02:28:59.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:18:0)
[02:28:59.974] Timer tick, asking Buildbucket for the build status
[02:29:00.237] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:00.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:19:0) after 1m0s
[02:30:00.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:19:0)
[02:30:00.232] Timer tick, asking Buildbucket for the build status
[02:30:00.343] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:00.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:20:0) after 1m0s
[02:31:00.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:20:0)
[02:31:00.413] Timer tick, asking Buildbucket for the build status
[02:31:00.559] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:00.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:21:0) after 1m0s
[02:32:00.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:21:0)
[02:32:00.585] Timer tick, asking Buildbucket for the build status
[02:32:00.648] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:00.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:22:0) after 1m0s
[02:33:00.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:22:0)
[02:33:00.734] Timer tick, asking Buildbucket for the build status
[02:33:00.857] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:00.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:23:0) after 1m0s
[02:34:00.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:23:0)
[02:34:00.843] Timer tick, asking Buildbucket for the build status
[02:34:01.090] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:01.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:24:0) after 1m0s
[02:35:01.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:24:0)
[02:35:01.169] Timer tick, asking Buildbucket for the build status
[02:35:01.336] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:01.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:25:0) after 1m0s
[02:36:01.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:25:0)
[02:36:01.366] Timer tick, asking Buildbucket for the build status
[02:36:01.613] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:01.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:26:0) after 1m0s
[02:37:01.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:26:0)
[02:37:01.650] Timer tick, asking Buildbucket for the build status
[02:37:01.721] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:01.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:27:0) after 1m0s
[02:38:01.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:27:0)
[02:38:01.816] Timer tick, asking Buildbucket for the build status
[02:38:01.943] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:01.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:28:0) after 1m0s
[02:39:01.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:28:0)
[02:39:01.978] Timer tick, asking Buildbucket for the build status
[02:39:02.050] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:02.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:29:0) after 1m0s
[02:40:02.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:29:0)
[02:40:02.240] Timer tick, asking Buildbucket for the build status
[02:40:02.328] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:02.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:30:0) after 1m0s
[02:41:02.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:30:0)
[02:41:02.453] Timer tick, asking Buildbucket for the build status
[02:41:02.575] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:02.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:31:0) after 1m0s
[02:42:02.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:31:0)
[02:42:02.631] Timer tick, asking Buildbucket for the build status
[02:42:02.703] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:02.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:32:0) after 1m0s
[02:43:02.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:32:0)
[02:43:02.848] Timer tick, asking Buildbucket for the build status
[02:43:04.129] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:04.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:33:0) after 1m0s
[02:44:04.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:33:0)
[02:44:04.168] Timer tick, asking Buildbucket for the build status
[02:44:04.247] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:04.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:34:0) after 1m0s
[02:45:04.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:34:0)
[02:45:04.338] Timer tick, asking Buildbucket for the build status
[02:45:04.424] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:04.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:35:0) after 1m0s
[02:46:04.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:35:0)
[02:46:04.584] Timer tick, asking Buildbucket for the build status
[02:46:04.680] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:04.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:36:0) after 1m0s
[02:47:04.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:36:0)
[02:47:04.716] Timer tick, asking Buildbucket for the build status
[02:47:04.785] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:04.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:37:0) after 1m0s
[02:48:04.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:37:0)
[02:48:04.846] Timer tick, asking Buildbucket for the build status
[02:48:05.050] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:05.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:38:0) after 1m0s
[02:49:05.100] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:38:0)
[02:49:05.100] Timer tick, asking Buildbucket for the build status
[02:49:05.170] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:05.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:39:0) after 1m0s
[02:50:05.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:39:0)
[02:50:05.234] Timer tick, asking Buildbucket for the build status
[02:50:05.294] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:05.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:40:0) after 1m0s
[02:51:05.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:40:0)
[02:51:05.364] Timer tick, asking Buildbucket for the build status
[02:51:05.424] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:05.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:41:0) after 1m0s
[02:52:05.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:41:0)
[02:52:05.543] Timer tick, asking Buildbucket for the build status
[02:52:05.616] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:05.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:42:0) after 1m0s
[02:53:05.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:42:0)
[02:53:05.691] Timer tick, asking Buildbucket for the build status
[02:53:05.802] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:05.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:43:0) after 1m0s
[02:54:05.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:43:0)
[02:54:05.879] Timer tick, asking Buildbucket for the build status
[02:54:05.993] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:05.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:44:0) after 1m0s
[02:55:06.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:44:0)
[02:55:06.190] Timer tick, asking Buildbucket for the build status
[02:55:06.448] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:06.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:45:0) after 1m0s
[02:56:06.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:45:0)
[02:56:06.475] Timer tick, asking Buildbucket for the build status
[02:56:06.971] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:06.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:46:0) after 1m0s
[02:57:07.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:46:0)
[02:57:07.067] Timer tick, asking Buildbucket for the build status
[02:57:07.194] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:07.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:47:0) after 1m0s
[02:58:07.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:47:0)
[02:58:07.284] Timer tick, asking Buildbucket for the build status
[02:58:07.449] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:07.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:48:0) after 1m0s
[02:59:07.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:48:0)
[02:59:07.585] Timer tick, asking Buildbucket for the build status
[02:59:07.694] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:07.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:49:0) after 1m0s
[03:00:07.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:49:0)
[03:00:07.857] Timer tick, asking Buildbucket for the build status
[03:00:08.374] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:08.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:50:0) after 1m0s
[03:01:09.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:50:0)
[03:01:09.140] Timer tick, asking Buildbucket for the build status
[03:01:09.316] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:09.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:51:0) after 1m0s
[03:02:09.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:51:0)
[03:02:09.343] Timer tick, asking Buildbucket for the build status
[03:02:09.537] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:09.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:52:0) after 1m0s
[03:03:09.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:52:0)
[03:03:09.642] Timer tick, asking Buildbucket for the build status
[03:03:10.815] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:10.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:53:0) after 1m0s
[03:04:11.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:53:0)
[03:04:11.093] Timer tick, asking Buildbucket for the build status
[03:04:11.221] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:11.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:54:0) after 1m0s
[03:05:11.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:54:0)
[03:05:11.277] Timer tick, asking Buildbucket for the build status
[03:05:14.494] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:14.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:55:0) after 1m0s
[03:06:14.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:55:0)
[03:06:14.754] Timer tick, asking Buildbucket for the build status
[03:06:15.093] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:15.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:56:0) after 1m0s
[03:07:15.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:56:0)
[03:07:15.360] Timer tick, asking Buildbucket for the build status
[03:07:15.599] Build 8864327895872312704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:15.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029757957820675136:57:0) after 1m0s
[03:08:01.470] Received PubSub notification, asking Buildbucket for the build status
[03:08:01.552] Build 8864327895872312704: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:08:01.552] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604718480263412",
"created_by": "project:chromium",
"created_ts": "1604715175711392",
"id": "8864327895872312704",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"657b47a9eef04e784d0946d196e1a286d85774ab\"}}",
"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\": \"657b47a9eef04e784d0946d196e1a286d85774ab\", \"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-41-sjjl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42663, \"got_angle_revision\": \"a481bee281b16c9d16b1c7d2393a4e169514ac39\", \"got_dawn_revision\": \"56af9cbd3f3581fcb2a89d3b4a3b37b328cd00d4\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"657b47a9eef04e784d0946d196e1a286d85774ab\", \"got_revision_cp\": \"refs/heads/master@{#825152}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"a16002b5edb4e0ad297cb7835e984dc9d79fd417\", \"got_v8_revision_cp\": \"refs/heads/8.8.248@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"657b47a9eef04e784d0946d196e1a286d85774ab\", \"swarm_hashes_refs/heads/master(at){#825152}_without_patch\": {\"absl_hardening_tests\": \"2074605e114de0a4823920a419127328a0c26ca6\", \"accessibility_unittests\": \"e185591c718cd62623cdcb52806684330b12241e\", \"angle_unittests\": \"597a865844980c6d2db3c18a929810a85667d82e\", \"app_list_unittests\": \"d030a93b52dcda75f9877c5c28817048bb6cdbfe\", \"app_shell_unittests\": \"a6a37d562e2fa8ab1eba6ac8a184e61286b87ae1\", \"ash_unittests\": \"59eced6d71d07d1106d4a9476bfb854c7bd47488\", \"aura_unittests\": \"64687ab4b964069a3d941b74a23c0deb2df04cb0\", \"base_unittests\": \"451406d53cb8bdc96bf3e62d1e01bbff710ec5cb\", \"base_util_unittests\": \"73d65303556e9b6c01558b4e971741f8d140ae7c\", \"blink_common_unittests\": \"b1483260b792ca691f2828f445662032024dbee2\", \"blink_fuzzer_unittests\": \"69d68935e338a1dc97823461fe46fc727c818135\", \"blink_heap_unittests\": \"e558cc5f219e05ff107d69564156e8a8e2e241ea\", \"blink_platform_unittests\": \"48fd9ba870d9aff132919e7d5e6f386b2833287a\", \"blink_unittests\": \"1c46558d2b7c10132949369944c1b1ca5b2bcea8\", \"boringssl_crypto_tests\": \"da82d9af28503304860b8a500a53365811dd260d\", \"boringssl_ssl_tests\": \"32f562e541f517b30e5b0cfe0333f863f54f0081\", \"browser_tests\": \"60792c564da5ab072da71a3da3b2c65c64b47bb2\", \"capture_unittests\": \"77949bdd5f6ef8d57eba4436f884549a6ce1d5da\", \"cast_unittests\": \"661282cb610f286104a5bf32a598178814016091\", \"cc_unittests\": \"039e010e58d385b050f32bd36a2a285f70403b6b\", \"chrome_app_unittests\": \"591c65f10bb624db4646ed6cf4f313988fe6cc1b\", \"chromedriver_unittests\": \"160f9210d9408bf3540b3f96d7b6035438ca62c9\", \"chromeos_components_unittests\": \"de081dfac50b9dd8623ad2edf565bd3efb34e923\", \"chromeos_unittests\": \"4629f61148dd0b4d52bef0e0c1e71fd81f4e528e\", \"components_browsertests\": \"3b3947bdce27e5f9e98f3633059a2432601637a6\", \"components_unittests\": \"756a61c8fb4fa6870d063af71bc3e0b775dfaba7\", \"compositor_unittests\": \"157386e81d33a1aed7d308a4c9564490a932d9a0\", \"content_browsertests\": \"9be51983d40775292c8b9086dae8d9edc8b5c56d\", \"content_unittests\": \"b4f5455d4963ea80e06c81ac5c7d185075bb516d\", \"crypto_unittests\": \"dfb948bc3e97559be157dd81292bd196ff6d4230\", \"dbus_unittests\": \"ac197c44adc942f054381fefde533ac8a5d7d58e\", \"device_unittests\": \"089102b7bdf5d1bfb4b872f78cfb47fb51828a3e\", \"display_unittests\": \"09df805f599476f5253550d4a8e1c26084f27342\", \"events_unittests\": \"98f3af1c29d049ccb0fbf9d2d30f4156dc12f0b2\", \"exo_unittests\": \"c02b57e94e4aae6bac760511c9c7be1d4e406611\", \"extensions_browsertests\": \"b12ecea878f385ebe154ee55c87fe568bdb046c3\", \"extensions_unittests\": \"368d4d3181f86f6038be682c815f00d052446a7b\", \"filesystem_service_unittests\": \"b6c669dbc3be3065c6b830175a4d03f69bfb8473\", \"gcm_unit_tests\": \"649f02032452c05e31c7cf813fe96d13a27ede95\", \"gfx_unittests\": \"53d1a8746b0daa6e86dfa3504da06889caf62580\", \"gin_unittests\": \"cb698d4168959939d9d633bd40a665beecc9ccd3\", \"gl_unittests_ozone\": \"d1d9b64ac5e4b0e8076bf1bebad723b8edba43ce\", \"google_apis_unittests\": \"3fe73d55a74adf2a6229bd095a9d54b03af3d2d7\", \"gpu_unittests\": \"5f7adcea8232bd22e09d2d5549305f447444c22d\", \"gwp_asan_unittests\": \"bf9a8956edff3016cdcf2525726d7f71302922e1\", \"interactive_ui_tests\": \"c8eb2ebbbd4f0e4350d448a138d8cc1d175892e9\", \"ipc_tests\": \"d9fb0ffee6f023982b771abd2b43a03136c1a865\", \"jingle_unittests\": \"578f18931ffa059aee75843ef4ebb9fcf0ec2a67\", \"keyboard_unittests\": \"c30f7f63d351ab49a3a55012265c69f1fa0b1b99\", \"latency_unittests\": \"28028e096b50f326126d726672d1e9c1e07225c7\", \"libjingle_xmpp_unittests\": \"4a68ee11e9b5ea0a6797bb70fd6c5bfb617d4472\", \"liburlpattern_unittests\": \"fbff824392411fd48b408490d1d505e39a13480d\", \"media_blink_unittests\": \"b1020d8fe00241fd5410c28b0f47b977ee8e8dc3\", \"media_unittests\": \"fb59e670c72df1e37b1cd6e4718a90175444235e\", \"message_center_unittests\": \"cf27b4d56f3f41bfd620bd16e48ff78e2e67a55b\", \"midi_unittests\": \"65d6673a1cf1234a1382d0c4056f371cc024670f\", \"mojo_core_unittests\": \"2ab41669a0028776f60e80b8f8b2c776e5a9162d\", \"mojo_unittests\": \"bad2c9266d8aab63abdcca43c8c83d99fb3cf0af\", \"nacl_helper_nonsfi_unittests\": \"8b1e43df009732433958d8176ddde8cb5984d68c\", \"nacl_loader_unittests\": \"4eda9ccb6c7dae1f713505d75e48de7e611d8b3a\", \"native_theme_unittests\": \"659a1660d6d4ae43b9d8aa5eb51d9e03e66cdd70\", \"net_unittests\": \"b43aad872f3f36c831c4615f3e99de01aac17a5b\", \"ozone_gl_unittests\": \"bb1c31fa75f1c09aef1c2fb8dff1b98dfcfc5978\", \"ozone_unittests\": \"3e650ef8fa3f62cc4ea2a5bdaa11b90b7a73c674\", \"ozone_x11_unittests\": \"c7f82b280fc88f007e36a3e5a4ed0b7101842985\", \"pdf_unittests\": \"024ae6eb760d94919562d65cd406939ab11786fe\", \"perfetto_unittests\": \"875cb367b40786af2622cd5bc4d37095ce1ead67\", \"ppapi_unittests\": \"27b28cf2ad801135c062abfbae26a7e98c995fa4\", \"printing_unittests\": \"5441d52ca90ceb1b81a468aee86c3c34d39756e1\", \"remoting_unittests\": \"9fae6029860e8ba41d05cb6c49cc670b19448b1d\", \"sandbox_linux_unittests\": \"3e3576ee2fca52e1fe6482f55fe2ddfceeadf338\", \"service_manager_unittests\": \"af07ba32339ffc62710f63a8c143aa81ddcaa85b\", \"services_unittests\": \"7cfa2209afbf50c7e18fbadbf29b3d9260eedf03\", \"shell_dialogs_unittests\": \"c7a8e46795e9e65d32ace3a4549f89389b0aa2b1\", \"skia_unittests\": \"c0abad7f8d24260a90147684af2664acaff2e5e2\", \"snapshot_unittests\": \"a4d1f25ff2cbb6cc9c71ef3cfd0ea4edb19d7bbb\", \"sql_unittests\": \"7e51d3a66377aeb982c43a5083d7ab445897378a\", \"storage_unittests\": \"e3a3c559cd38be3337cbdd27fb15de49ddc7c56f\", \"sync_integration_tests\": \"092a310c0b41970d3955deaf8dca4a8e184cdc99\", \"traffic_annotation_auditor_unittests\": \"3c0e04dee4953092103bd0ae7e0636f088d17d6e\", \"ui_base_unittests\": \"3243122b69c2e7706934f77c5a21f4db92f7d81c\", \"ui_chromeos_unittests\": \"e0bcc2b43376816abb26d510dd48149d10993aa4\", \"ui_touch_selection_unittests\": \"7fcc5b796da06260de351acbd86cae6e0e14fe22\", \"unit_tests\": \"23a5f69fa54599055265c4b5afc785d7396b1c4f\", \"url_unittests\": \"53becd604f45d2a831d2200d10890613e17a28c4\", \"usage_time_limit_unittests\": \"ccbef15ec6b7956958977e18a98804207b7d13f3\", \"views_unittests\": \"61a1bb6ea9dbfb7bf506d8f7d2c177fe69a7eb04\", \"viz_unittests\": \"e1e5821445b8fda964696b53becdaf9aee482700\", \"wayland_client_perftests\": \"92ce243b820a05296d6a503895330b009b8e208f\", \"wm_unittests\": \"d082064756a7067fd8dc9babd2553c504c78bc8d\", \"wtf_unittests\": \"f2cf5140ff7c3059b73e4eab1bbb0d4802739222\", \"zlib_unittests\": \"15c10e5cf2428ad934a3659e9d12a002c36e50aa\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-41-sjjl\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604715182341201",
"status": "COMPLETED",
"status_changed_ts": "1604718480699957",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42663",
"builder:linux-chromeos-rel",
"buildset:commit/git/657b47a9eef04e784d0946d196e1a286d85774ab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/657b47a9eef04e784d0946d196e1a286d85774ab",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029757957820675136",
"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/8864327895872312704/+/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:4fb94be979020110",
"user_agent:luci-scheduler"
],
"updated_ts": "1604718480709843",
"url": "https://ci.chromium.org/b/8864327895872312704",
"utcnow_ts": "1604718481540333"
}
}
[03:08:01.552] Invocation finished in 55m7.082979883s with status SUCCEEDED