[20:18:08.597] New invocation is queued and will start shortly
[20:18:10.091] Starting the invocation (attempt 1)
[20:18:10.160] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:18:10.160] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:18:10.160] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030595650392144896",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9030595650392144896",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0",
"gitiles_ref:refs/heads/master"
]
}
[20:19:10.208] Failed to add buildbucket build - Put https://cr-buildbucket.appspot.com/_ah/api/buildbucket/v1/builds?alt=json&prettyPrint=false: API error 5 (urlfetch: DEADLINE_EXCEEDED)
[20:19:10.208] The invocation will be retried
[20:19:15.249] Starting the invocation (attempt 2)
[20:19:15.295] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:19:15.295] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:19:15.295] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030595650392144896",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9030595650392144896",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0",
"gitiles_ref:refs/heads/master"
]
}
[20:19:16.252] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1603916355496348",
"id": "8865165519577835216",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603916356030473",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177118",
"builder:Linux Builder (dbg)",
"buildset:commit/git/aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030595650392144896",
"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/8865165519577835216/+/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": "1603916356030683",
"url": "https://ci.chromium.org/b/8865165519577835216",
"utcnow_ts": "1603916356234023"
}
}
[20:19:16.252] Task URL: https://ci.chromium.org/b/8865165519577835216
[20:19:16.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:5:0) after 1m0s
[20:19:36.971] Received PubSub notification, asking Buildbucket for the build status
[20:19:37.116] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:16.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:5:0)
[20:20:16.368] Timer tick, asking Buildbucket for the build status
[20:20:16.491] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:16.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:7:0) after 1m0s
[20:21:16.567] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:7:0)
[20:21:16.567] Timer tick, asking Buildbucket for the build status
[20:21:16.969] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:16.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:8:0) after 1m0s
[20:22:17.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:8:0)
[20:22:17.036] Timer tick, asking Buildbucket for the build status
[20:22:17.194] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:17.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:9:0) after 1m0s
[20:23:17.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:9:0)
[20:23:17.268] Timer tick, asking Buildbucket for the build status
[20:23:17.348] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:17.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:10:0) after 1m0s
[20:24:17.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:10:0)
[20:24:17.424] Timer tick, asking Buildbucket for the build status
[20:24:17.894] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:17.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:11:0) after 1m0s
[20:25:18.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:11:0)
[20:25:18.082] Timer tick, asking Buildbucket for the build status
[20:25:18.569] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:18.569] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:12:0) after 1m0s
[20:26:18.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:12:0)
[20:26:18.621] Timer tick, asking Buildbucket for the build status
[20:26:18.769] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:18.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:13:0) after 1m0s
[20:27:18.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:13:0)
[20:27:18.791] Timer tick, asking Buildbucket for the build status
[20:27:18.908] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:18.908] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:14:0) after 1m0s
[20:28:18.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:14:0)
[20:28:18.974] Timer tick, asking Buildbucket for the build status
[20:28:19.039] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:19.039] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:15:0) after 1m0s
[20:29:19.096] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:15:0)
[20:29:19.096] Timer tick, asking Buildbucket for the build status
[20:29:19.288] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:19.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:16:0) after 1m0s
[20:30:19.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:16:0)
[20:30:19.403] Timer tick, asking Buildbucket for the build status
[20:30:19.543] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:19.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:17:0) after 1m0s
[20:31:19.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:17:0)
[20:31:19.571] Timer tick, asking Buildbucket for the build status
[20:31:19.641] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:19.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:18:0) after 1m0s
[20:32:19.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:18:0)
[20:32:19.618] Timer tick, asking Buildbucket for the build status
[20:32:19.688] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:19.688] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:19:0) after 1m0s
[20:33:19.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:19:0)
[20:33:19.829] Timer tick, asking Buildbucket for the build status
[20:33:19.903] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:19.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:20:0) after 1m0s
[20:34:20.088] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:20:0)
[20:34:20.088] Timer tick, asking Buildbucket for the build status
[20:34:20.229] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:20.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:21:0) after 1m0s
[20:35:20.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:21:0)
[20:35:20.338] Timer tick, asking Buildbucket for the build status
[20:35:20.402] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:20.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:22:0) after 1m0s
[20:36:20.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:22:0)
[20:36:20.512] Timer tick, asking Buildbucket for the build status
[20:36:20.587] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:20.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:23:0) after 1m0s
[20:37:20.656] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:23:0)
[20:37:20.656] Timer tick, asking Buildbucket for the build status
[20:37:20.754] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:20.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:24:0) after 1m0s
[20:38:20.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:24:0)
[20:38:20.774] Timer tick, asking Buildbucket for the build status
[20:38:21.247] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:21.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:25:0) after 1m0s
[20:39:21.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:25:0)
[20:39:21.293] Timer tick, asking Buildbucket for the build status
[20:39:21.442] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:21.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:26:0) after 1m0s
[20:40:21.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:26:0)
[20:40:21.526] Timer tick, asking Buildbucket for the build status
[20:40:21.614] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:21.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:27:0) after 1m0s
[20:41:21.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:27:0)
[20:41:21.705] Timer tick, asking Buildbucket for the build status
[20:41:21.801] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:21.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:28:0) after 1m0s
[20:42:21.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:28:0)
[20:42:21.829] Timer tick, asking Buildbucket for the build status
[20:42:21.898] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:21.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:29:0) after 1m0s
[20:43:22.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:29:0)
[20:43:22.074] Timer tick, asking Buildbucket for the build status
[20:43:22.144] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:22.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:30:0) after 1m0s
[20:44:22.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:30:0)
[20:44:22.155] Timer tick, asking Buildbucket for the build status
[20:44:22.655] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:22.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:31:0) after 1m0s
[20:45:22.736] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:31:0)
[20:45:22.736] Timer tick, asking Buildbucket for the build status
[20:45:23.111] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:23.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:32:0) after 1m0s
[20:46:23.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:32:0)
[20:46:23.207] Timer tick, asking Buildbucket for the build status
[20:46:23.291] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:23.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:33:0) after 1m0s
[20:47:23.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:33:0)
[20:47:23.484] Timer tick, asking Buildbucket for the build status
[20:47:23.579] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:23.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:34:0) after 1m0s
[20:48:23.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:34:0)
[20:48:23.630] Timer tick, asking Buildbucket for the build status
[20:48:23.968] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:23.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:35:0) after 1m0s
[20:49:23.989] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:35:0)
[20:49:23.989] Timer tick, asking Buildbucket for the build status
[20:49:24.107] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:24.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:36:0) after 1m0s
[20:50:24.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:36:0)
[20:50:24.127] Timer tick, asking Buildbucket for the build status
[20:50:24.200] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:24.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:37:0) after 1m0s
[20:51:24.201] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:37:0)
[20:51:24.201] Timer tick, asking Buildbucket for the build status
[20:51:24.430] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:24.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:38:0) after 1m0s
[20:52:24.435] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:38:0)
[20:52:24.435] Timer tick, asking Buildbucket for the build status
[20:52:24.504] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:24.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:39:0) after 1m0s
[20:53:24.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:39:0)
[20:53:24.575] Timer tick, asking Buildbucket for the build status
[20:53:24.671] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:24.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:40:0) after 1m0s
[20:54:24.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:40:0)
[20:54:24.722] Timer tick, asking Buildbucket for the build status
[20:54:25.344] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:25.344] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:41:0) after 1m0s
[20:55:25.494] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:41:0)
[20:55:25.494] Timer tick, asking Buildbucket for the build status
[20:55:25.591] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:25.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:42:0) after 1m0s
[20:56:25.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:42:0)
[20:56:25.638] Timer tick, asking Buildbucket for the build status
[20:56:25.731] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:25.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:43:0) after 1m0s
[20:57:25.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:43:0)
[20:57:25.810] Timer tick, asking Buildbucket for the build status
[20:57:25.941] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:25.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:44:0) after 1m0s
[20:58:26.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:44:0)
[20:58:26.067] Timer tick, asking Buildbucket for the build status
[20:58:26.187] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:26.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:45:0) after 1m0s
[20:59:26.220] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:45:0)
[20:59:26.220] Timer tick, asking Buildbucket for the build status
[20:59:26.346] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:26.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:46:0) after 1m0s
[21:00:26.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:46:0)
[21:00:26.533] Timer tick, asking Buildbucket for the build status
[21:00:26.962] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:26.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:47:0) after 1m0s
[21:01:27.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:47:0)
[21:01:27.103] Timer tick, asking Buildbucket for the build status
[21:01:27.463] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:27.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:48:0) after 1m0s
[21:02:27.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:48:0)
[21:02:27.545] Timer tick, asking Buildbucket for the build status
[21:02:30.403] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:30.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:49:0) after 1m0s
[21:03:30.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:49:0)
[21:03:30.484] Timer tick, asking Buildbucket for the build status
[21:03:30.554] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:30.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:50:0) after 1m0s
[21:04:30.643] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:50:0)
[21:04:30.643] Timer tick, asking Buildbucket for the build status
[21:04:30.786] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:30.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:51:0) after 1m0s
[21:05:30.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:51:0)
[21:05:30.940] Timer tick, asking Buildbucket for the build status
[21:05:31.033] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:31.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:52:0) after 1m0s
[21:06:31.054] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:52:0)
[21:06:31.054] Timer tick, asking Buildbucket for the build status
[21:06:31.169] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:31.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:53:0) after 1m0s
[21:07:31.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:53:0)
[21:07:31.311] Timer tick, asking Buildbucket for the build status
[21:07:31.422] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:31.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:54:0) after 1m0s
[21:08:31.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:54:0)
[21:08:31.492] Timer tick, asking Buildbucket for the build status
[21:08:32.656] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:32.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:55:0) after 1m0s
[21:09:32.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:55:0)
[21:09:32.684] Timer tick, asking Buildbucket for the build status
[21:09:32.810] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:32.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:56:0) after 1m0s
[21:10:32.900] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:56:0)
[21:10:32.900] Timer tick, asking Buildbucket for the build status
[21:10:32.973] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:32.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:57:0) after 1m0s
[21:11:32.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:57:0)
[21:11:32.978] Timer tick, asking Buildbucket for the build status
[21:11:33.057] Build 8865165519577835216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:33.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030595650392144896:58:0) after 1m0s
[21:11:35.591] Received PubSub notification, asking Buildbucket for the build status
[21:11:35.685] Build 8865165519577835216: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:11:35.685] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1603919495053789",
"created_by": "project:chromium",
"created_ts": "1603916355496348",
"id": "8865165519577835216",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0\"}}",
"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\": \"aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-130-xu9k\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177118, \"got_angle_revision\": \"47e66f22759ac1c2a331e52d9260362c3f502798\", \"got_dawn_revision\": \"47ee61679da09d9ec11f3da5b9b124a0c707c434\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0\", \"got_revision_cp\": \"refs/heads/master@{#821869}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"3542c2cba24373717fbd8c4c98d2ba1929d4ca00\", \"got_v8_revision_cp\": \"refs/heads/8.8.203@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0\", \"swarm_hashes_refs/heads/master(at){#821869}_without_patch\": {\"absl_hardening_tests\": \"cdaa3f1cf82cfba254da2fa4d373fe80fcbfb5d7\", \"accessibility_unittests\": \"791ed97c1971ff12137cb996fb1e4b557cf27c5e\", \"angle_unittests\": \"c7d3750ef26924b10c7e1b0bfa9a5d92348c8153\", \"app_shell_unittests\": \"92f20a3acd27663c29edf4c32b5c72e47bc9e999\", \"aura_unittests\": \"c0b109aaea4068e70448de1dea1c54d48dfa203c\", \"base_unittests\": \"6568f2642b9904ab121b908513ac06315dad60d4\", \"base_util_unittests\": \"54d4ebe2f39ba273674afb510ae81eda130e02dd\", \"blink_common_unittests\": \"227d5009840f538a727ee24b466646f9faa98d2a\", \"blink_fuzzer_unittests\": \"4d5880625eb4262c8ae5cf96c369705e08d4f79d\", \"blink_heap_unittests\": \"0e3de5ab25640673099186a62fb34c3a5ee99c73\", \"blink_platform_unittests\": \"a2787ba6928bbd5a39933fe8ad86abe42cf54d25\", \"blink_python_tests\": \"4a790df9907856c601c31fcb42f5cf942a1ff6ba\", \"blink_unittests\": \"2102dfecc7c4a4f34f7d4b6587dc54411ba68b43\", \"blink_web_tests\": \"327601cc6634dc31d4655fc16b99fa174ab33479\", \"boringssl_crypto_tests\": \"495fbf573a30db8c0835c17af7b755dc478d3948\", \"boringssl_ssl_tests\": \"a32668e5d3a63d8102bc09fa0d58ac083ce073bc\", \"browser_tests\": \"32ea4866692398988ee2c6e05fdcb3b80fa43b51\", \"capture_unittests\": \"235bbf35096a4fb89d6e5c87fc77d1967e2ea7d2\", \"cast_unittests\": \"a36be3644923f41454bcef79d2880820341b446c\", \"cc_unittests\": \"c2d80a8bf35a439d7a48bff049e2b7382dd931f3\", \"chrome_app_unittests\": \"5be6ea21b83a3cfafb1ad6cd14b478ce8764fcfa\", \"chromedriver_unittests\": \"672a92cb4bec2c64c0e5cbce76b6c8752cfef037\", \"components_browsertests\": \"fee37b2225af3e3e75415802f771ae8285fae02e\", \"components_unittests\": \"d5778a3e96102f251c280d5bfaff69e068369f10\", \"compositor_unittests\": \"3aa750b3a1c712e7234b39fab69aff7b70d0fc2a\", \"content_browsertests\": \"cc43edd4e13adfbdbbfb1c106262d576271b2df5\", \"content_shell_crash_test\": \"2e79836a7e7d9f5bcd10e02875b17e927e693b34\", \"content_unittests\": \"ab42a3ca13374106add692db4fa4135cc193563d\", \"crashpad_tests\": \"a079a8340491b6b5b3eed18964fca43c7c314027\", \"cronet_tests\": \"15739a548f5aca7cdcedba3d4db836c85d848c74\", \"cronet_unittests\": \"b54770b06fcfc114d6a5b1fef8fa4348973d4a34\", \"crypto_unittests\": \"b48d7c40b26a7c8328ac6be0e41a3f891bb2c4c7\", \"dbus_unittests\": \"80dd84be1071210081848aab5c4e7f934facd4fb\", \"device_unittests\": \"bda1d139b72af91979e5c8f05cd60857c642ca4d\", \"display_unittests\": \"8384dabca19dbb41a7dc01fc51ca1d329b5fd068\", \"events_unittests\": \"0fbc039e515d6973abab93dd5867b2e29c8bd1bd\", \"extension_docserver_python_unittests\": \"b0db74fb46ffb95502ef14677f435beb9a0b946b\", \"extensions_browsertests\": \"22693ae8cd261f07770426eb0bb2dbe7b71a053e\", \"extensions_unittests\": \"0b16727cee54e193a28eeb047e50f1301b55eb38\", \"filesystem_service_unittests\": \"5100c484b2f6ff796234cec1e18885ab72ceeeef\", \"flatbuffers_unittests\": \"be237720fdbb07e58b96ce0c0382048fec390853\", \"gcm_unit_tests\": \"3fff2916037d366d184f5ec0c8995a1911294491\", \"gfx_unittests\": \"f7cceed9208c7f4e453047bb5ba9c376973467cd\", \"gin_unittests\": \"742e7dcf621f197814c64197c617590d8da81369\", \"google_apis_unittests\": \"2fd083ccd04c8354e33fcbd93e529b04bac2d2fe\", \"gpu_unittests\": \"d2381f8cc9b10be5df60204899b35789fc5616f4\", \"grit_python_unittests\": \"bf36ace3c2ab3a00bd0a70e39eb6728edfd6c473\", \"gwp_asan_unittests\": \"42b97562f06ac02079f596deb55eb791d4abe8fc\", \"headless_browsertests\": \"382417b4467f746f32528b9e1e66565268d67c18\", \"headless_unittests\": \"d6e5ba4bd113355b0b4c54c619025060da8dc151\", \"interactive_ui_tests\": \"70ed2e1480bc3108a31f10a03a18def10760bb7c\", \"ipc_tests\": \"e263396b70a3901adff7c70523f960aac12b6587\", \"jingle_unittests\": \"4b89ae4457d54c8ec680a864d82ceef8825c5c8d\", \"latency_unittests\": \"96190b3b9a729301806a7838e98ac211e5e6f869\", \"libjingle_xmpp_unittests\": \"2833ecc2fe34c78657c2e79b891a0c6c908e5aea\", \"liburlpattern_unittests\": \"c422cdeeb9e5a7690672ad94eab8e2ce5e9c2776\", \"media_blink_unittests\": \"abfe0a1b8cc2d5c176fab6430ea2e8e10d803d27\", \"media_unittests\": \"79f9103af1cecf78ecfb4b49e5471bec018fd248\", \"message_center_unittests\": \"1a9679c5f421528db49e413d3241e69cb87c3bb2\", \"metrics_python_tests\": \"1f8c41561cb9dde075c2c979ec9cc5cb8700850b\", \"midi_unittests\": \"9aba1bcc3ab6b2baa3acb0badc0fa2424e57f524\", \"mojo_core_unittests\": \"5210a2775fe8ced76eb9acd6a97ee6eb2d2fdf07\", \"mojo_unittests\": \"122d97f237de21e24a742b8e720309cec94ed024\", \"nacl_helper_nonsfi_unittests\": \"ecc9e34a4e3d8e1e4cf90a709d86c414bb3ec036\", \"nacl_loader_unittests\": \"24fdbe57e293ef7c42495d7997c12b7eee87b6a7\", \"native_theme_unittests\": \"38778dfc82c37d8a688a8e01735e6d9a6efc574d\", \"net_unittests\": \"1ddecfaa0dcd7d35dc2b813f054ad56eef55b0db\", \"openscreen_unittests\": \"ebf09609a66546311a8b1c2a3dfd0cb5e273508d\", \"pdf_unittests\": \"b100acd1bcbefee1dc2028dd3a287209bad703f1\", \"perfetto_unittests\": \"2e2735f0cbe01962335b9cd8b991988762de969a\", \"ppapi_unittests\": \"bd7a0a9316aad36900523d83455a57ae106961a3\", \"printing_unittests\": \"9f372e06d988acec4e77de9325765c6cc7e18840\", \"remoting_unittests\": \"bb229a5d9429545d6b064a57a5c294c8de09e7b5\", \"sandbox_linux_unittests\": \"392b9d989fec7a8a99b54fda3e8789dcc7f146c2\", \"service_manager_unittests\": \"c840fe62e99605956ac8087d142a4146fd779270\", \"services_unittests\": \"bfcdf4c110e0f10938e828f0b229df21ca8d1cda\", \"shell_dialogs_unittests\": \"487f54acbaa40d3aa19ca46342e9baa1f795d959\", \"skia_unittests\": \"7fe583db8a82d2b86c59bb960d2751adbdb957d2\", \"snapshot_unittests\": \"031c6fa209c41cf3b23813c52ca2086f6193175e\", \"sql_unittests\": \"5b907cae87c366b9d9e2943f9fcd1d1c713e5707\", \"storage_unittests\": \"892b599259e23bbd705ef6e04c541d07f0fb736d\", \"sync_integration_tests\": \"bb452b866ee7a18609a9a8f2cd30c8f24951163c\", \"telemetry_gpu_unittests\": \"3118556e4749e6e28ddbcf6ce95280640889b2c2\", \"telemetry_perf_unittests\": \"6d1b2659fd01345013e560763265ed4536c4b19d\", \"telemetry_unittests\": \"b95479bdb519661d467b8b2ba634eca70434dee1\", \"traffic_annotation_auditor_unittests\": \"476fb5212407d94d3678e2bd7b6222ba06355f1d\", \"ui_base_unittests\": \"3685edae79e60de61aef4c3e4121487093d1da8f\", \"ui_touch_selection_unittests\": \"80839eb37126e01fc66905a29bc4779b1d5dd027\", \"unit_tests\": \"1acd3ea03c426114dd37c91a4f599677a9cb7479\", \"url_unittests\": \"780e63be8c5676c03e5faade8e1ac0ca8e241280\", \"views_perftests\": \"7b5843b7169552915a5de948dc415d521052aedd\", \"views_unittests\": \"1f1c7d82f3131a606deb3aacdf27f4acd1bb97a4\", \"viz_unittests\": \"d2d65b76880d8731d4221d1493a8b72fa2875c24\", \"vr_common_unittests\": \"ea747665957cb7884500ad5bed1685c7613a35cc\", \"vr_pixeltests\": \"85a2d2dd836625dd9893ea4261dbdeb8b7192100\", \"webdriver_wpt_tests\": \"4a63cd33a5c98444452d87f122401c465a938b09\", \"weblayer_browsertests\": \"1311c322a3643c045f2231a96893d3bf4ffabf27\", \"weblayer_unittests\": \"484ab69a9b5758c5658aa587c090ade02d793991\", \"wm_unittests\": \"53a1358189394dc1cfbdfe0ace3e0824c530e41b\", \"wtf_unittests\": \"511bede102a587e7e553f2030de86b1a8e855531\", \"x11_unittests\": \"5ecb5372667c3fc4d080347b75c586f367d415a6\", \"xr_browser_tests\": \"ce5c49573b2e2e9a316cd4fb8f0f90ff2d1a8a3c\", \"zlib_unittests\": \"94cd155826f335c9dd730964c7546df155a8adc2\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_25c22b29ff9525bbfd333bb12e92a9faf5d35886dc9a7dacce03d872c45df5d1_v2\", \"builder_4f840a66a98bcc23913cdceee05d6305bdb9a4a5d39b36f536d725d421d1ee25_v2\", \"builder_d6c402558de63915dde657133f192d995a5b729212ea1587a5d59fbce371e332_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_fe04a82bb3d9c756558e7f777d2f821598f573bdde1afcb57ce60c173fe87653_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-130-xu9k\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603916375675383",
"status": "COMPLETED",
"status_changed_ts": "1603919495327718",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177118",
"builder:Linux Builder (dbg)",
"buildset:commit/git/aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa5c9ce6f5a7859f8a32f44ed65a380abb571eb0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030595650392144896",
"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/8865165519577835216/+/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:4f89aee331c6f210",
"user_agent:luci-scheduler"
],
"updated_ts": "1603919495333808",
"url": "https://ci.chromium.org/b/8865165519577835216",
"utcnow_ts": "1603919495673593"
}
}
[21:11:35.685] Invocation finished in 53m27.106854473s with status SUCCEEDED