[21:27:56.243] New invocation is queued and will start shortly
[21:27:57.350] Starting the invocation (attempt 1)
[21:27:57.417] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:27:57.417] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:27:57.417] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031950213822255680",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"53ba2e06f727cb26518faada38996cb74c375771\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9031950213822255680",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/53ba2e06f727cb26518faada38996cb74c375771",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53ba2e06f727cb26518faada38996cb74c375771",
"gitiles_ref:refs/heads/master"
]
}
[21:27:58.160] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602624477510305",
"id": "8866520151829129104",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53ba2e06f727cb26518faada38996cb74c375771\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602624478038206",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176631",
"builder:Linux Builder (dbg)",
"buildset:commit/git/53ba2e06f727cb26518faada38996cb74c375771",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53ba2e06f727cb26518faada38996cb74c375771",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031950213822255680",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8866520151829129104/+/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": "1602624478038360",
"url": "https://ci.chromium.org/b/8866520151829129104",
"utcnow_ts": "1602624478151459"
}
}
[21:27:58.160] Task URL: https://ci.chromium.org/b/8866520151829129104
[21:27:58.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:2:0) after 1m0s
[21:28:18.025] Received PubSub notification, asking Buildbucket for the build status
[21:28:18.117] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:58.225] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:2:0)
[21:28:58.225] Timer tick, asking Buildbucket for the build status
[21:28:58.382] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:58.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:4:0) after 1m0s
[21:29:58.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:4:0)
[21:29:58.415] Timer tick, asking Buildbucket for the build status
[21:30:00.919] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:00.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:5:0) after 1m0s
[21:31:01.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:5:0)
[21:31:01.740] Timer tick, asking Buildbucket for the build status
[21:31:02.176] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:02.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:6:0) after 1m0s
[21:32:02.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:6:0)
[21:32:02.199] Timer tick, asking Buildbucket for the build status
[21:32:02.352] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:02.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:7:0) after 1m0s
[21:33:02.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:7:0)
[21:33:02.506] Timer tick, asking Buildbucket for the build status
[21:33:02.656] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:02.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:8:0) after 1m0s
[21:34:02.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:8:0)
[21:34:02.706] Timer tick, asking Buildbucket for the build status
[21:34:02.819] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:02.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:9:0) after 1m0s
[21:35:02.949] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:9:0)
[21:35:02.949] Timer tick, asking Buildbucket for the build status
[21:35:03.140] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:03.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:10:0) after 1m0s
[21:36:03.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:10:0)
[21:36:03.176] Timer tick, asking Buildbucket for the build status
[21:36:03.276] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:03.276] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:11:0) after 1m0s
[21:37:03.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:11:0)
[21:37:03.326] Timer tick, asking Buildbucket for the build status
[21:37:03.413] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:03.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:12:0) after 1m0s
[21:38:03.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:12:0)
[21:38:03.462] Timer tick, asking Buildbucket for the build status
[21:38:03.550] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:03.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:13:0) after 1m0s
[21:39:03.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:13:0)
[21:39:03.578] Timer tick, asking Buildbucket for the build status
[21:39:03.979] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:03.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:14:0) after 1m0s
[21:40:04.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:14:0)
[21:40:04.024] Timer tick, asking Buildbucket for the build status
[21:40:04.097] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:04.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:15:0) after 1m0s
[21:41:04.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:15:0)
[21:41:04.291] Timer tick, asking Buildbucket for the build status
[21:41:04.392] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:04.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:16:0) after 1m0s
[21:42:04.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:16:0)
[21:42:04.470] Timer tick, asking Buildbucket for the build status
[21:42:04.538] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:04.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:17:0) after 1m0s
[21:43:04.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:17:0)
[21:43:04.628] Timer tick, asking Buildbucket for the build status
[21:43:04.833] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:04.833] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:18:0) after 1m0s
[21:44:04.904] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:18:0)
[21:44:04.905] Timer tick, asking Buildbucket for the build status
[21:44:05.015] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:05.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:19:0) after 1m0s
[21:45:05.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:19:0)
[21:45:05.071] Timer tick, asking Buildbucket for the build status
[21:45:05.142] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:05.142] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:20:0) after 1m0s
[21:46:05.297] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:20:0)
[21:46:05.297] Timer tick, asking Buildbucket for the build status
[21:46:05.404] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:05.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:21:0) after 1m0s
[21:47:05.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:21:0)
[21:47:05.426] Timer tick, asking Buildbucket for the build status
[21:47:05.486] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:05.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:22:0) after 1m0s
[21:48:05.555] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:22:0)
[21:48:05.555] Timer tick, asking Buildbucket for the build status
[21:48:05.629] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:05.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:23:0) after 1m0s
[21:49:05.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:23:0)
[21:49:05.699] Timer tick, asking Buildbucket for the build status
[21:49:05.984] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:05.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:24:0) after 1m0s
[21:50:05.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:24:0)
[21:50:05.990] Timer tick, asking Buildbucket for the build status
[21:50:06.156] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:06.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:25:0) after 1m0s
[21:51:06.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:25:0)
[21:51:06.187] Timer tick, asking Buildbucket for the build status
[21:51:06.252] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:06.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:26:0) after 1m0s
[21:52:06.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:26:0)
[21:52:06.327] Timer tick, asking Buildbucket for the build status
[21:52:06.395] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:06.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:27:0) after 1m0s
[21:53:06.427] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:27:0)
[21:53:06.427] Timer tick, asking Buildbucket for the build status
[21:53:06.910] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:06.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:28:0) after 1m0s
[21:54:07.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:28:0)
[21:54:07.051] Timer tick, asking Buildbucket for the build status
[21:54:07.212] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:07.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:29:0) after 1m0s
[21:55:07.285] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:29:0)
[21:55:07.285] Timer tick, asking Buildbucket for the build status
[21:55:07.337] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:07.337] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:30:0) after 1m0s
[21:56:07.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:30:0)
[21:56:07.362] Timer tick, asking Buildbucket for the build status
[21:56:07.423] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:07.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:31:0) after 1m0s
[21:57:07.692] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:31:0)
[21:57:07.692] Timer tick, asking Buildbucket for the build status
[21:57:07.748] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:07.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:32:0) after 1m0s
[21:58:07.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:32:0)
[21:58:07.837] Timer tick, asking Buildbucket for the build status
[21:58:07.916] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:07.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:33:0) after 1m0s
[21:59:07.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:33:0)
[21:59:07.919] Timer tick, asking Buildbucket for the build status
[21:59:08.308] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:08.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:34:0) after 1m0s
[22:00:08.469] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:34:0)
[22:00:08.469] Timer tick, asking Buildbucket for the build status
[22:00:08.705] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:08.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:35:0) after 1m0s
[22:01:08.831] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:35:0)
[22:01:08.831] Timer tick, asking Buildbucket for the build status
[22:01:09.103] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:09.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:36:0) after 1m0s
[22:02:09.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:36:0)
[22:02:09.177] Timer tick, asking Buildbucket for the build status
[22:02:09.240] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:09.240] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:37:0) after 1m0s
[22:03:09.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:37:0)
[22:03:09.308] Timer tick, asking Buildbucket for the build status
[22:03:09.386] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:09.386] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:38:0) after 1m0s
[22:04:09.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:38:0)
[22:04:09.459] Timer tick, asking Buildbucket for the build status
[22:04:09.557] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:09.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:39:0) after 1m0s
[22:05:09.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:39:0)
[22:05:09.608] Timer tick, asking Buildbucket for the build status
[22:05:09.660] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:09.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:40:0) after 1m0s
[22:06:09.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:40:0)
[22:06:09.685] Timer tick, asking Buildbucket for the build status
[22:06:09.885] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:09.885] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:41:0) after 1m0s
[22:07:09.969] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:41:0)
[22:07:09.969] Timer tick, asking Buildbucket for the build status
[22:07:10.155] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:10.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:42:0) after 1m0s
[22:08:10.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:42:0)
[22:08:10.185] Timer tick, asking Buildbucket for the build status
[22:08:10.294] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:10.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:43:0) after 1m0s
[22:09:10.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:43:0)
[22:09:10.292] Timer tick, asking Buildbucket for the build status
[22:09:10.405] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:10.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:44:0) after 1m0s
[22:10:10.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:44:0)
[22:10:10.465] Timer tick, asking Buildbucket for the build status
[22:10:10.531] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:10.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:45:0) after 1m0s
[22:11:10.505] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:45:0)
[22:11:10.505] Timer tick, asking Buildbucket for the build status
[22:11:10.570] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:10.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:46:0) after 1m0s
[22:12:10.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:46:0)
[22:12:10.620] Timer tick, asking Buildbucket for the build status
[22:12:10.711] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:10.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:47:0) after 1m0s
[22:13:10.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:47:0)
[22:13:10.743] Timer tick, asking Buildbucket for the build status
[22:13:10.817] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:10.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:48:0) after 1m0s
[22:14:10.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:48:0)
[22:14:10.930] Timer tick, asking Buildbucket for the build status
[22:14:11.038] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:11.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:49:0) after 1m0s
[22:15:11.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:49:0)
[22:15:11.346] Timer tick, asking Buildbucket for the build status
[22:15:11.520] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:11.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:50:0) after 1m0s
[22:16:11.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:50:0)
[22:16:11.622] Timer tick, asking Buildbucket for the build status
[22:16:11.683] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:11.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:51:0) after 1m0s
[22:17:11.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:51:0)
[22:17:11.825] Timer tick, asking Buildbucket for the build status
[22:17:11.943] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:11.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:52:0) after 1m0s
[22:18:12.020] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:52:0)
[22:18:12.020] Timer tick, asking Buildbucket for the build status
[22:18:12.256] Build 8866520151829129104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:12.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031950213822255680:53:0) after 1m0s
[22:18:25.673] Received PubSub notification, asking Buildbucket for the build status
[22:18:25.911] Build 8866520151829129104: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:18:25.914] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602627505014300",
"created_by": "project:chromium",
"created_ts": "1602624477510305",
"id": "8866520151829129104",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53ba2e06f727cb26518faada38996cb74c375771\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"53ba2e06f727cb26518faada38996cb74c375771\", \"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-24-hder\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 176631, \"got_angle_revision\": \"bc2dd313cf94ead827ba01d2e47e10e284047408\", \"got_dawn_revision\": \"ccaef8525710f27db60adcc7e9778c2caac1bada\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"53ba2e06f727cb26518faada38996cb74c375771\", \"got_revision_cp\": \"refs/heads/master@{#816770}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e72c6099f9465df73f888a92071b70c924d74b0d\", \"got_v8_revision\": \"7bb48090258056285eefddebf26d55a22121fe5a\", \"got_v8_revision_cp\": \"refs/heads/8.8.74@{#1}\", \"got_webrtc_revision\": \"46129e98d33a4d97c7d24252b1e67e83844112fa\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32387}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53ba2e06f727cb26518faada38996cb74c375771\", \"swarm_hashes_refs/heads/master(at){#816770}_without_patch\": {\"absl_hardening_tests\": \"55c79a31ddcfa8b55c7c524fb0aaaee0cf7a1bc8\", \"accessibility_unittests\": \"aaa54a54d93792e735416783c9f1afa41fb7746b\", \"app_shell_unittests\": \"2b1aeefe6e341080f0b35777facf1fd385a3e3fa\", \"aura_unittests\": \"892ccde818141afcd2bcdd6422bf2c838f5a10e0\", \"base_unittests\": \"c83ce2890d470486faa2122257ea927c5c3c26d2\", \"base_util_unittests\": \"5a50d90c3f65671aaeb19a92d00ecbc9e94b124a\", \"blink_common_unittests\": \"4115b325b8f06f5ae7afba92008c2cfb0aafa1e4\", \"blink_fuzzer_unittests\": \"ab53c06606e38f53a6fc2ed05d9e785498fd80ee\", \"blink_heap_unittests\": \"1f1e354a2ec5168d55dc5d600a680922ce3806fd\", \"blink_platform_unittests\": \"7822d105429325e47126e574ddc18cebd7428e5e\", \"blink_python_tests\": \"7eabf5a5f089da0c6d648c87413005cf5972f7b0\", \"blink_unittests\": \"b933dbb6f8d423b65043410cdf859ff552b1c7ac\", \"blink_web_tests\": \"1a6282262d7fc819b7e6849b2b778ad6f95b9de0\", \"boringssl_crypto_tests\": \"dd98fcfcdc0dc698e1cccc6d38bb625798e6be0c\", \"boringssl_ssl_tests\": \"600adf052a5490705b68ffa9e509d74c64c56007\", \"browser_tests\": \"f716090b4f3d36a1286dbd8363d291bdffaf36a4\", \"capture_unittests\": \"a23d85c142560a896636dca7f52df4a1ba655ab6\", \"cast_unittests\": \"9382e73ec6eb8cb37df224c2f0831ebace29d358\", \"cc_unittests\": \"c632a982fb4cb81c424b850925b8dbe7966d7891\", \"chrome_app_unittests\": \"5d6619033dc31e3cf8dff0063063b5d9055f7ade\", \"chromedriver_unittests\": \"1ea51f6b294373336aa403394e6c8fd1f5d1d175\", \"components_browsertests\": \"61b50ce10b57ffdb379d2164088373f491452e58\", \"components_unittests\": \"5704f45ec9d5162fd71ad72a5bf1292f95246f1f\", \"compositor_unittests\": \"3d0168142e7093d9efcf8cfde9f4dc240a5b0a25\", \"content_browsertests\": \"219175e62d63ab4ef69846204dcd74fca6bf4e03\", \"content_shell_crash_test\": \"0db51940b03fff05d6a5fa0e17457956d064b5b0\", \"content_unittests\": \"e715b59746b093524f3dba0639784d9229e2c300\", \"crashpad_tests\": \"34e91eab72019c777349ab8f95347d4ff4bb4529\", \"cronet_tests\": \"7664e0fc6a444108b5cc94c66e9a49329b6103f1\", \"cronet_unittests\": \"9f5ebc3834c2615ce3bf87a13cdc4e85401c989c\", \"crypto_unittests\": \"670dd452210982d8cc72c4bbc86ab5de9aaf2d8d\", \"dbus_unittests\": \"5c6457cc11288f418ffe8f2dc24ec0c6303b657b\", \"device_unittests\": \"efe3023e5bb10d083bb8218317096aa34342d22d\", \"display_unittests\": \"8a3e4fd0ff16c006055224645232e6eebb5b2647\", \"events_unittests\": \"70a32469e165656c2a499348ab8b05aa67df0e83\", \"extension_docserver_python_unittests\": \"3bb36b9879d82c387994226d07bb6385f1e06b8e\", \"extensions_browsertests\": \"fc584b078b13e33984fad9c89b11b43a12162164\", \"extensions_unittests\": \"8c52132d7ded88e6c2aac9ce5db4a4ce71ca871c\", \"filesystem_service_unittests\": \"e832104fd268fbabd6d2c63c1a568fd7ef0904c9\", \"flatbuffers_unittests\": \"7c821f13730963d6e07deae074f4fffab315d766\", \"gcm_unit_tests\": \"3f5b5fd6098822a88b8bbd9e5853ac93ec097b34\", \"gfx_unittests\": \"ea3d0fcfa3a53111aebfd6beac982daeb350c91d\", \"gin_unittests\": \"7f5885fbc522b47ac0a294cd8e976c3783bfef85\", \"google_apis_unittests\": \"aead978696dfaaa44614424f7abe14283a209707\", \"gpu_unittests\": \"198a3f673623b767fe99f33fa6506b79b9175245\", \"grit_python_unittests\": \"55fa961d85005331568451ce869e032331bd4b90\", \"gwp_asan_unittests\": \"fbbe9c6f60520947f02d1f24b2187bd5513c4f04\", \"headless_browsertests\": \"4c32f51ad64febbc4392ae97d9c7a9940a64f6b9\", \"headless_unittests\": \"650dddb774014f68a25aa20c2db24a9df56562a1\", \"interactive_ui_tests\": \"6cad94b69342fbca8aa24d90b5f3803564a21bf1\", \"ipc_tests\": \"058b9d435ce972cfd6ec106eec409e69fad36f2d\", \"jingle_unittests\": \"4aee8adf52a2ad33e2f347c9c2d1553c3349bc85\", \"latency_unittests\": \"958d9892617d4bd3b369268eebebdbb0814233e5\", \"libjingle_xmpp_unittests\": \"348866fd3ca3dc6052d9a4c2563897da59d8f91a\", \"media_blink_unittests\": \"380ecbff7270413da779fc38fa1c0f170866f825\", \"media_unittests\": \"febd4f99f62493dc6cb79dbb8ebc1c45c1620623\", \"message_center_unittests\": \"9b7f91035a8f1e415cd93c0b2caa1bd45a6bb03f\", \"metrics_python_tests\": \"2ca6268da2e67705d5ff6228f419ae5ba5c0d801\", \"midi_unittests\": \"641a3ef458eae7a25a99e305d4f8956c5bdc47c1\", \"mojo_core_unittests\": \"c791dd7806218e17e3afe028304f109ac4fbf931\", \"mojo_unittests\": \"745f440b08c48a8793d851bda0f18cfb3dc30b2d\", \"nacl_helper_nonsfi_unittests\": \"1cedf3eb9e2f337291f14730c172f5edce7bbd7a\", \"nacl_loader_unittests\": \"8701bd283e9633f946904fc094539f873c2cbf15\", \"native_theme_unittests\": \"052688969ebb01c36f50753efbd99607035baecb\", \"net_unittests\": \"7cec0c2a9987afd1f6d733c528a5d616bfc3f6a8\", \"openscreen_unittests\": \"ba1f4050d2f3fbf4b75be9232c01ba32f64bbf33\", \"pdf_unittests\": \"e70e52dff1b78ff978179a2d7418d775b4906aba\", \"perfetto_unittests\": \"7b11797f11b1eff4fd818ad0ec6de745fbc5a43a\", \"ppapi_unittests\": \"8ea4bc03923cc834ff3ae5246f53d3dd8761e098\", \"printing_unittests\": \"71fcb6a5fff506d04fd71fbdbee0a651056bf35d\", \"remoting_unittests\": \"8e7b969b22d84abf489945ad924bddb6dbd71ce5\", \"sandbox_linux_unittests\": \"85937ea2c790a4cbdb1d843d90f807f06caff888\", \"service_manager_unittests\": \"6c1d7615dfe352396bfc8f96d1858068ebda0d0c\", \"services_unittests\": \"5f87fbf6f0015d4852a75e0d7a9133f603c77b23\", \"shell_dialogs_unittests\": \"7bd3b5600bc740fd0cb4e45f44e9b4d7c7bc3130\", \"skia_unittests\": \"c6c3475e4e33512fa13230433745bb0f9af717cd\", \"snapshot_unittests\": \"61b6387a72a87bff516931f7fe5372f2c78160b3\", \"sql_unittests\": \"b1c756783f3e2767100ab2527bb166afc7dec225\", \"standalone_angle_unittests\": \"1316ffa59a3564983adaf55862eaa893b504de79\", \"storage_unittests\": \"aa913c251f31aa730658f108e652c48b5e2ee84b\", \"sync_integration_tests\": \"cdf038dec0204a186cd39411b68e4d3cd4b1fdac\", \"telemetry_gpu_unittests\": \"fbb49cefb215b769a77dae76112bdd01c27b11e3\", \"telemetry_perf_unittests\": \"cf934107ae0dc6b1e780bd49f64a00a63092217d\", \"telemetry_unittests\": \"f5388eb6d552690ee5f51366672ea400a232681a\", \"traffic_annotation_auditor_unittests\": \"6866b89b5cf8e60c43dc215db5516bac04c098f7\", \"ui_base_unittests\": \"925e68dd604993ebfab692fd5da27c1ecae0dfb6\", \"ui_touch_selection_unittests\": \"8419b9801342893b6569601ba1d8d5968b537e9d\", \"unit_tests\": \"67476b2bdb092220692f34e7599706afe8e97cc8\", \"url_unittests\": \"216df2609e8da314ce1df325a0583bd976e520a9\", \"views_perftests\": \"29724da5bfee75890207cf48dc27bbbfe21446a2\", \"views_unittests\": \"ad6cb32f32b3710513b3ff593f54bf8e826d2442\", \"viz_unittests\": \"5ea52bc2400c9e6d506eaeff3848c811d30d5ae3\", \"vr_common_unittests\": \"ff9a579f213b4c3f6f9949af03419badc3523b53\", \"vr_pixeltests\": \"987789a10f9d44989fc2f4140d9a994074aafbbd\", \"webdriver_wpt_tests\": \"701bddd40575a12c16008e68e097cc311de78255\", \"weblayer_browsertests\": \"1dab30f8afd04cc0e8b7152552d152ee80001261\", \"weblayer_unittests\": \"1cb36ec715a11da32de7345a700ac86768b98c78\", \"wm_unittests\": \"1e5deb4c06b7a179aa355f229fb6410fe1a436f9\", \"wtf_unittests\": \"546ede7bf60c485a628871589532459d5227c694\", \"x11_unittests\": \"0021f97a6012d6eeed9d32ef97188f125c371cad\", \"xr_browser_tests\": \"e4a5145056e0ebf06211e060659ed1fa28f377ec\", \"zlib_unittests\": \"4e5fbb43d1de90ed51fd3c8b5c8b3643e059118e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_08506e22a0e0fdc29bd318165699b599f0671cf91287ea7a96642b02d7ff24e4_v2\", \"builder_304607b978b8f4bcd63bac0f543c3a69f6b4c7cf202dcd2d3c5b8d4a70be201e_v2\", \"builder_3e35691df8e10f0f9a2876627ba5bcbf70dc06793975d132d4535f10bccc6635_v2\", \"builder_3f701152d865ce3ec8feb15f973214ad980aeace5cbda24477548a965269fca6_v2\", \"builder_5c906bad1aaeae24a2a7f043536626a3e8df9b2c7401ab4a0dd83c120911bddd_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_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-24-hder\"], \"image\": [\"chrome-xenial-20100700-ace2c028da3\"], \"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\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602624494854729",
"status": "COMPLETED",
"status_changed_ts": "1602627505309031",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176631",
"builder:Linux Builder (dbg)",
"buildset:commit/git/53ba2e06f727cb26518faada38996cb74c375771",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53ba2e06f727cb26518faada38996cb74c375771",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031950213822255680",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8866520151829129104/+/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:4f3cae975bb3c310",
"user_agent:luci-scheduler"
],
"updated_ts": "1602627505316574",
"url": "https://ci.chromium.org/b/8866520151829129104",
"utcnow_ts": "1602627505890394"
}
}
[22:18:25.915] Invocation finished in 50m29.690126424s with status SUCCEEDED