[09:13:16.946] New invocation is queued and will start shortly
[09:13:18.675] Starting the invocation (attempt 1)
[09:13:18.760] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:13:18.760] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:13:18.760] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052833736588052672",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4f532ce3aa1b011ede54cd6c467fccaeaf3ba8c9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052833736588052672",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/4f532ce3aa1b011ede54cd6c467fccaeaf3ba8c9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f532ce3aa1b011ede54cd6c467fccaeaf3ba8c9",
"gitiles_ref:refs/heads/master"
]
}
[09:13:19.614] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582708398934186",
"id": "8887403673837562448",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4f532ce3aa1b011ede54cd6c467fccaeaf3ba8c9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582708399372024",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169039",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4f532ce3aa1b011ede54cd6c467fccaeaf3ba8c9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f532ce3aa1b011ede54cd6c467fccaeaf3ba8c9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052833736588052672",
"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/8887403673837562448/+/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": "1582708399372136",
"url": "https://ci.chromium.org/b/8887403673837562448",
"utcnow_ts": "1582708399605556"
}
}
[09:13:19.614] Task URL: https://ci.chromium.org/b/8887403673837562448
[09:13:19.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:2:0) after 1m0s
[09:14:19.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:2:0)
[09:14:19.641] Timer tick, asking Buildbucket for the build status
[09:14:19.825] Build 8887403673837562448: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:14:19.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:3:0) after 1m0s
[09:15:19.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:3:0)
[09:15:19.951] Timer tick, asking Buildbucket for the build status
[09:15:20.074] Build 8887403673837562448: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:15:20.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:4:0) after 1m0s
[09:16:20.141] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:4:0)
[09:16:20.141] Timer tick, asking Buildbucket for the build status
[09:16:20.299] Build 8887403673837562448: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:16:20.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:5:0) after 1m0s
[09:17:20.349] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:5:0)
[09:17:20.349] Timer tick, asking Buildbucket for the build status
[09:17:20.744] Build 8887403673837562448: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:17:20.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:6:0) after 1m0s
[09:18:03.974] Received PubSub notification, asking Buildbucket for the build status
[09:18:04.103] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:20.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:6:0)
[09:18:20.786] Timer tick, asking Buildbucket for the build status
[09:18:21.105] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:21.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:8:0) after 1m0s
[09:19:21.156] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:8:0)
[09:19:21.156] Timer tick, asking Buildbucket for the build status
[09:19:21.371] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:21.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:9:0) after 1m0s
[09:20:21.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:9:0)
[09:20:21.462] Timer tick, asking Buildbucket for the build status
[09:20:21.613] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:21.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:10:0) after 1m0s
[09:21:21.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:10:0)
[09:21:21.659] Timer tick, asking Buildbucket for the build status
[09:21:21.758] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:21.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:11:0) after 1m0s
[09:22:21.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:11:0)
[09:22:21.779] Timer tick, asking Buildbucket for the build status
[09:22:22.161] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:22.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:12:0) after 1m0s
[09:23:22.280] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:12:0)
[09:23:22.280] Timer tick, asking Buildbucket for the build status
[09:23:22.401] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:22.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:13:0) after 1m0s
[09:24:22.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:13:0)
[09:24:22.472] Timer tick, asking Buildbucket for the build status
[09:24:22.557] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:22.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:14:0) after 1m0s
[09:25:22.623] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:14:0)
[09:25:22.623] Timer tick, asking Buildbucket for the build status
[09:25:22.721] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:22.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:15:0) after 1m0s
[09:26:22.762] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:15:0)
[09:26:22.762] Timer tick, asking Buildbucket for the build status
[09:26:22.857] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:22.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:16:0) after 1m0s
[09:27:22.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:16:0)
[09:27:22.935] Timer tick, asking Buildbucket for the build status
[09:27:23.022] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:23.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:17:0) after 1m0s
[09:28:23.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:17:0)
[09:28:23.680] Timer tick, asking Buildbucket for the build status
[09:28:23.887] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:23.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:18:0) after 1m0s
[09:29:24.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:18:0)
[09:29:24.048] Timer tick, asking Buildbucket for the build status
[09:29:24.248] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:24.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:19:0) after 1m0s
[09:30:24.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:19:0)
[09:30:24.405] Timer tick, asking Buildbucket for the build status
[09:30:24.513] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:24.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:20:0) after 1m0s
[09:31:24.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:20:0)
[09:31:24.529] Timer tick, asking Buildbucket for the build status
[09:31:24.647] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:24.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:21:0) after 1m0s
[09:32:24.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:21:0)
[09:32:24.698] Timer tick, asking Buildbucket for the build status
[09:32:25.065] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:25.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:22:0) after 1m0s
[09:33:25.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:22:0)
[09:33:25.125] Timer tick, asking Buildbucket for the build status
[09:33:25.432] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:25.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:23:0) after 1m0s
[09:34:25.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:23:0)
[09:34:25.560] Timer tick, asking Buildbucket for the build status
[09:34:25.734] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:25.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:24:0) after 1m0s
[09:35:25.773] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:24:0)
[09:35:25.773] Timer tick, asking Buildbucket for the build status
[09:35:25.906] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:25.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:25:0) after 1m0s
[09:36:26.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:25:0)
[09:36:26.065] Timer tick, asking Buildbucket for the build status
[09:36:26.397] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:26.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:26:0) after 1m0s
[09:37:26.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:26:0)
[09:37:26.444] Timer tick, asking Buildbucket for the build status
[09:37:26.600] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:26.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:27:0) after 1m0s
[09:38:26.643] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:27:0)
[09:38:26.643] Timer tick, asking Buildbucket for the build status
[09:38:26.782] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:26.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:28:0) after 1m0s
[09:39:26.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:28:0)
[09:39:26.791] Timer tick, asking Buildbucket for the build status
[09:39:27.014] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:27.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:29:0) after 1m0s
[09:40:27.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:29:0)
[09:40:27.136] Timer tick, asking Buildbucket for the build status
[09:40:27.247] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:27.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:30:0) after 1m0s
[09:41:27.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:30:0)
[09:41:27.395] Timer tick, asking Buildbucket for the build status
[09:41:27.550] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:27.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:31:0) after 1m0s
[09:42:27.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:31:0)
[09:42:27.638] Timer tick, asking Buildbucket for the build status
[09:42:27.744] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:27.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:32:0) after 1m0s
[09:43:27.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:32:0)
[09:43:27.805] Timer tick, asking Buildbucket for the build status
[09:43:27.991] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:27.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:33:0) after 1m0s
[09:44:28.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:33:0)
[09:44:28.142] Timer tick, asking Buildbucket for the build status
[09:44:28.236] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:28.236] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:34:0) after 1m0s
[09:45:28.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:34:0)
[09:45:28.479] Timer tick, asking Buildbucket for the build status
[09:45:28.575] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:28.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:35:0) after 1m0s
[09:46:28.733] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:35:0)
[09:46:28.733] Timer tick, asking Buildbucket for the build status
[09:46:28.967] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:28.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:36:0) after 1m0s
[09:47:29.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:36:0)
[09:47:29.105] Timer tick, asking Buildbucket for the build status
[09:47:29.544] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:29.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:37:0) after 1m0s
[09:48:29.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:37:0)
[09:48:29.776] Timer tick, asking Buildbucket for the build status
[09:48:30.318] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:30.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:38:0) after 1m0s
[09:49:30.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:38:0)
[09:49:30.384] Timer tick, asking Buildbucket for the build status
[09:49:30.534] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:30.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:39:0) after 1m0s
[09:50:30.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:39:0)
[09:50:30.578] Timer tick, asking Buildbucket for the build status
[09:50:30.664] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:30.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:40:0) after 1m0s
[09:51:30.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:40:0)
[09:51:30.744] Timer tick, asking Buildbucket for the build status
[09:51:30.916] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:30.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:41:0) after 1m0s
[09:52:30.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:41:0)
[09:52:30.919] Timer tick, asking Buildbucket for the build status
[09:52:31.041] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:31.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:42:0) after 1m0s
[09:53:31.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:42:0)
[09:53:31.158] Timer tick, asking Buildbucket for the build status
[09:53:31.374] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:31.374] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:43:0) after 1m0s
[09:54:31.505] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:43:0)
[09:54:31.505] Timer tick, asking Buildbucket for the build status
[09:54:32.226] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:32.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:44:0) after 1m0s
[09:55:32.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:44:0)
[09:55:32.333] Timer tick, asking Buildbucket for the build status
[09:55:32.437] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:32.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:45:0) after 1m0s
[09:56:32.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:45:0)
[09:56:32.622] Timer tick, asking Buildbucket for the build status
[09:56:32.788] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:32.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:46:0) after 1m0s
[09:57:32.949] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:46:0)
[09:57:32.949] Timer tick, asking Buildbucket for the build status
[09:57:33.114] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:33.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:47:0) after 1m0s
[09:58:33.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:47:0)
[09:58:33.281] Timer tick, asking Buildbucket for the build status
[09:58:33.669] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:33.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:48:0) after 1m0s
[09:59:33.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:48:0)
[09:59:33.728] Timer tick, asking Buildbucket for the build status
[09:59:33.844] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:33.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:49:0) after 1m0s
[10:00:33.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:49:0)
[10:00:33.951] Timer tick, asking Buildbucket for the build status
[10:00:34.207] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:34.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:50:0) after 1m0s
[10:01:34.303] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:50:0)
[10:01:34.303] Timer tick, asking Buildbucket for the build status
[10:01:34.451] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:34.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:51:0) after 1m0s
[10:02:34.513] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:51:0)
[10:02:34.513] Timer tick, asking Buildbucket for the build status
[10:02:34.621] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:34.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:52:0) after 1m0s
[10:03:34.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:52:0)
[10:03:34.695] Timer tick, asking Buildbucket for the build status
[10:03:35.112] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:35.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:53:0) after 1m0s
[10:04:35.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:53:0)
[10:04:35.253] Timer tick, asking Buildbucket for the build status
[10:04:35.541] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:35.541] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:54:0) after 1m0s
[10:05:35.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:54:0)
[10:05:35.559] Timer tick, asking Buildbucket for the build status
[10:05:36.010] Build 8887403673837562448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:36.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052833736588052672:55:0) after 1m0s
[10:06:30.857] Received PubSub notification, asking Buildbucket for the build status
[10:06:30.967] Build 8887403673837562448: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:06:30.967] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582711590119018",
"created_by": "project:chromium",
"created_ts": "1582708398934186",
"id": "8887403673837562448",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4f532ce3aa1b011ede54cd6c467fccaeaf3ba8c9\"}}",
"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\"}, \"$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-109-dijb\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169039, \"got_angle_revision\": \"4a9ec2ef6f2a70f7758b0e57658089bbb40f22ac\", \"got_dawn_revision\": \"227568451b442ae16873ec23cd4b86cf28d00b2a\", \"got_nacl_revision\": \"021c8b6784ea41113fe6d54f36359a0c329a5cc5\", \"got_revision\": \"4f532ce3aa1b011ede54cd6c467fccaeaf3ba8c9\", \"got_revision_cp\": \"refs/heads/master@{#744583}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"da659b3741132fe6a6904e45d96112eef776bc28\", \"got_v8_revision\": \"54f0b120057ebcd0993ad20548922b940e43623a\", \"got_v8_revision_cp\": \"refs/heads/8.2.177@{#1}\", \"got_webrtc_revision\": \"a6db9c8fe9276774e3939d577c9320ad00fddd83\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30613}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4f532ce3aa1b011ede54cd6c467fccaeaf3ba8c9\", \"swarm_hashes_refs/heads/master(at){#744583}_without_patch\": {\"accessibility_unittests\": \"a97b5b238e5028ea7d0ac70c99ff273ecd92c339\", \"angle_unittests\": \"8f583728d88fb631d0ec2e9d561708191b853720\", \"app_shell_unittests\": \"0028d50b7a4633cc8d3a14b9de2cf0178f8cd2f3\", \"aura_unittests\": \"16dd44ea0c5e35eb77a15559a2a306e919c6cf42\", \"base_unittests\": \"cf469023444bbcb1b8b8795c08404de91272d34d\", \"base_util_unittests\": \"f2a3e5fe02659a290668e9eddbfa56387c9496c4\", \"blink_common_unittests\": \"0e814114438e787fa7f33076e28dd3c3ca7e2209\", \"blink_fuzzer_unittests\": \"f5c0bfa027144328755e52768f0021f1e279bb6e\", \"blink_heap_unittests\": \"ad533ef9a4e1b635c8316c9a3852bd70a220c4ed\", \"blink_platform_unittests\": \"4ee602f29783258f2b4797ad8bdb3df427de6d97\", \"blink_python_tests\": \"bca77ab4a3bdc4ca763dca829c6baee146cac25c\", \"blink_unittests\": \"ed69de309c7164e87594355400f38fa0b690ae47\", \"blink_web_tests\": \"66ee8b24e52a1e5e6064ffd6b85cf5e9a24f0f0b\", \"boringssl_crypto_tests\": \"645c02bf39dae19547f5513dc91cf3121f370bc5\", \"boringssl_ssl_tests\": \"680b545f58a53d5f14df6792969b6bf4226f2cd6\", \"browser_tests\": \"52c9492b48348c9ddc04766b5c1a33b43dc5d5de\", \"cacheinvalidation_unittests\": \"0340a0ffea3aa6050f1283cc35b9bae0ae565951\", \"capture_unittests\": \"b22970dd948bda79c78c6f6436104ef898b77ab4\", \"cast_unittests\": \"c07ca1004dea2e573d72f677e746723f85e20d3d\", \"cc_unittests\": \"6b1af69b6eba2231b8919378b8a7844a5cb86226\", \"chrome_app_unittests\": \"dd095d0b0210e3901a0f840c52bd31d67ca0616c\", \"chromedriver_unittests\": \"c9211d46f0a5ee1c7762fdd946804063ce24ba90\", \"components_browsertests\": \"21622341533638fa53c1ca34bc92c5e896edcd64\", \"components_unittests\": \"63eefa8ddcea73e2c6f944630de9c7cbcc57c6d5\", \"compositor_unittests\": \"7210823dbd38fe523a95ba2d15b0237c10fcc1f2\", \"content_browsertests\": \"08b20a3b0d5eaee67edcb95a29c9f6c2f9bb3c9d\", \"content_shell_crash_test\": \"49d61c78c3e176e9aed6d691bcb777a29d2a6052\", \"content_unittests\": \"62201dfa16f95edf250eb57c13635ffc060e9451\", \"crashpad_tests\": \"52335fcbe2846a4f04c4973574ff2c35ba7695f4\", \"cronet_tests\": \"e29f5972eb14162c80f789166474dc5aa89b408d\", \"cronet_unittests\": \"08c9d60a55c36f1ed551e5a8327ffb2ad6855d37\", \"crypto_unittests\": \"4209ffb1829140412c01b5fb5dfc9db66cdc5a64\", \"dbus_unittests\": \"a1faf5babb02551015ccba38832091bca700a399\", \"device_unittests\": \"ee2ad38841c1f38f90dc1d5af60eb75b8f58b5ec\", \"display_unittests\": \"aa040e39fafb85edfa8c581fe0ed81d7bff0d318\", \"events_unittests\": \"516a2ea805de7433f862271aabc3549f8f2385bf\", \"extensions_browsertests\": \"39f31e7df6f4d756906f56fbe47d3a10a6d20be6\", \"extensions_unittests\": \"9fd789c3f40d31cf9fd0e306939f8c26bf248775\", \"filesystem_service_unittests\": \"4342b3e6831e2743ebbd619269ec5d9b2c1edd15\", \"flatbuffers_unittests\": \"fddfee5d9c5c5357203fa42dff8f3c357607bc22\", \"gcm_unit_tests\": \"9cf9c7e02528b88f4b807d4ab36fc0ca441b8017\", \"gfx_unittests\": \"a3d205e91cdc002f21a20fd938ae13861033db50\", \"gin_unittests\": \"18fd2d2ba9baad54ba676ec0fe166f6610dc96a2\", \"google_apis_unittests\": \"32d704b37e874e85e4fa0f4e57ef06f5f7279d6a\", \"gpu_unittests\": \"6b9af1fd2fe00a46455dd876d4a3a102a8c01cf0\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"f9931a1c16bf0385d9a1e68694ebb3efa12b0be6\", \"headless_browsertests\": \"e6b1c1f8c08c31bcf7c59bc309f7452f6715b28e\", \"headless_unittests\": \"2dfe0407e218d1890a92f0afc4f2daa03a2dfe1f\", \"interactive_ui_tests\": \"7f33979d3a268edeab939a1897741362698cbb97\", \"ipc_tests\": \"e0f7b187ef2401acfa60df4d22f697e52091f20d\", \"jingle_unittests\": \"f3cf98c2ff377a669bbb62b0e51de8bad8e727d5\", \"latency_unittests\": \"261a0e01a3662796e54f6f9b88383293a1bcceb7\", \"libjingle_xmpp_unittests\": \"f161e3c75b454e72ff0fc0b413426003ef953725\", \"media_blink_unittests\": \"0b7768eb5d3c507c33ed83283625e49f01916e18\", \"media_service_unittests\": \"d7a59b944e7d5d7e3af29857201264f0b7fdd11a\", \"media_unittests\": \"936392f7a8abaee5f308d1693ffabb90f53d2dba\", \"message_center_unittests\": \"254f3d98a1e191a1be53ebc344936f7307bc7f14\", \"metrics_python_tests\": \"d62dea0e23e7f9b8a0a187789af6a0346e65b912\", \"midi_unittests\": \"92e38fcae417ef84dc10be69add165231ccf5ba2\", \"mojo_core_unittests\": \"1bb1e648ef92fa8977968ad2744e53982c4ec9b6\", \"mojo_unittests\": \"54ac740ed8af6e8342629ed1bd8ccff2ffc95e42\", \"nacl_helper_nonsfi_unittests\": \"f2e81d6cb41bb06d2bdca4a2ed0d77f22a887857\", \"nacl_loader_unittests\": \"3b62a4a42bd2afe1cac62552bc6a8c4eb583c39a\", \"native_theme_unittests\": \"170fc4d4414ba302cfe2d95fc36962a4ee3ea779\", \"net_unittests\": \"f18992e58b06a316d3e90495502cd84ae43c6f6b\", \"pdf_unittests\": \"613d383266ca85da5cfcbed06a0d73f815ac3cdb\", \"perfetto_unittests\": \"a342937254cacf69269a4fc2c69c97c27ac25a92\", \"ppapi_unittests\": \"0c45d5dd456675c897dff29175b6ea44481abeab\", \"printing_unittests\": \"0bb2734ed4f63a3d52b0b2ad653680a31ab275c7\", \"remoting_unittests\": \"66b2ccb87f0c00ac98ddf5c44394265d73789346\", \"sandbox_linux_unittests\": \"982bef5f630b96d488bb8d52d6c3a0af9d30a657\", \"service_manager_unittests\": \"745d2bd96cbd26b1fbc6d471b20a7b6a36b2372a\", \"services_unittests\": \"a7d3f3679dd706115f2818e4b06b817e54277ec7\", \"shell_dialogs_unittests\": \"8f28c00db53d8951f330d5382c6d60c8b86c2648\", \"skia_unittests\": \"bfb29de4f21d6c7d4a0b800688532ad19753cda7\", \"snapshot_unittests\": \"06f70ceb4c350af51f2f6d127f420c02fb3b149d\", \"sql_unittests\": \"3e3bc20e2d831bae044cd01f0f80041320572d1e\", \"storage_unittests\": \"39a16f06d7729ff92edc0169283a405dc146ef61\", \"sync_integration_tests\": \"0c901574bbb21e66652965e79b61f58df1a78f87\", \"telemetry_gpu_unittests\": \"e222a79e1794a365ecac16862de476a745f54dae\", \"telemetry_perf_unittests\": \"d815f846a891f837480d7847d1b8a42ecb98de07\", \"telemetry_unittests\": \"320552444df7ac42fa10a9794b1c1e998f22eb69\", \"traffic_annotation_auditor_unittests\": \"7bac54b8d589cf726834e4c483137365f97bf2dd\", \"ui_base_unittests\": \"3ac0c9a416ff10aae62cefa1b7eeaf236425ecca\", \"ui_touch_selection_unittests\": \"056396b71ef043caa0b3e3dc9d2004b5b16c3344\", \"unit_tests\": \"a51246b799efac825582a67b22c1894426feabec\", \"url_unittests\": \"3f5171bd43e3cac3eaac90164cae30b03b570e9c\", \"views_perftests\": \"cedd676dd5abb7248fd1cde226b1a553bc716164\", \"views_unittests\": \"23515681d99f1fafc1d27be17b7232338e834216\", \"viz_unittests\": \"51ea32b1704428a9b68ed0c107bd1101bf335030\", \"vr_common_unittests\": \"2fdd604a633e47d6c0a701c42558fc656018fcd0\", \"vr_pixeltests\": \"714bc12539d66bb69e726d483ecb2f2c6147b313\", \"webdriver_wpt_tests\": \"4608f42a248c7dd21e6cd78eb5fc6c570021c63f\", \"weblayer_browsertests\": \"6d9058c97a06c13585540a8b49cc59f09df1adf7\", \"wm_unittests\": \"c6a25998cb61bfc1b53071e439f589d06b34a7aa\", \"wtf_unittests\": \"6bffdeb5bfa523f4cba826a2ca87005a57208d0f\", \"xr_browser_tests\": \"ac71808966eb713ac36638c7728591c17849899b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_26ee0c713798d591dc066c3b18aba10c428b81e49e5d430ca5b1f8f50ef6f654_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_341c32bd45a59798b0d31a376a872da37ddfa394c44785a08305266670677548_v2\", \"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-109-dijb\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4838-b69615e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582708683063544",
"status": "COMPLETED",
"status_changed_ts": "1582711590395025",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169039",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4f532ce3aa1b011ede54cd6c467fccaeaf3ba8c9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f532ce3aa1b011ede54cd6c467fccaeaf3ba8c9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052833736588052672",
"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/8887403673837562448/+/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:4a9997268e45aa10",
"user_agent:luci-scheduler"
],
"updated_ts": "1582711590398653",
"url": "https://ci.chromium.org/b/8887403673837562448",
"utcnow_ts": "1582711590948657"
}
}
[10:06:30.967] Invocation finished in 53m14.040114271s with status SUCCEEDED