[16:24:44.586] New invocation is queued and will start shortly
[16:24:45.734] Starting the invocation (attempt 1)
[16:24:45.794] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:24:45.794] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:24:45.794] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059057782109082032",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"03a1f6f231b922322142c780bd6f055e21b72ed5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9059057782109082032",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/03a1f6f231b922322142c780bd6f055e21b72ed5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03a1f6f231b922322142c780bd6f055e21b72ed5",
"gitiles_ref:refs/heads/master"
]
}
[16:24:46.766] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1576772686054104",
"id": "8893627719906691600",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03a1f6f231b922322142c780bd6f055e21b72ed5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576772686611398",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166317",
"builder:Linux Builder (dbg)",
"buildset:commit/git/03a1f6f231b922322142c780bd6f055e21b72ed5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03a1f6f231b922322142c780bd6f055e21b72ed5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059057782109082032",
"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/8893627719906691600/+/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": "1576772686611552",
"url": "https://ci.chromium.org/b/8893627719906691600",
"utcnow_ts": "1576772686755783"
}
}
[16:24:46.766] Task URL: https://ci.chromium.org/b/8893627719906691600
[16:24:46.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:2:0) after 1m0s
[16:25:46.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:2:0)
[16:25:46.814] Timer tick, asking Buildbucket for the build status
[16:25:49.466] Build 8893627719906691600: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:25:49.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:3:0) after 1m0s
[16:26:49.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:3:0)
[16:26:49.604] Timer tick, asking Buildbucket for the build status
[16:26:49.808] Build 8893627719906691600: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:26:49.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:4:0) after 1m0s
[16:27:49.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:4:0)
[16:27:49.921] Timer tick, asking Buildbucket for the build status
[16:27:50.159] Build 8893627719906691600: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:27:50.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:5:0) after 1m0s
[16:28:50.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:5:0)
[16:28:50.267] Timer tick, asking Buildbucket for the build status
[16:28:50.485] Build 8893627719906691600: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:28:50.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:6:0) after 1m0s
[16:29:50.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:6:0)
[16:29:50.580] Timer tick, asking Buildbucket for the build status
[16:29:50.768] Build 8893627719906691600: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:29:50.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:7:0) after 1m0s
[16:30:07.631] Received PubSub notification, asking Buildbucket for the build status
[16:30:08.389] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:51.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:7:0)
[16:30:51.048] Timer tick, asking Buildbucket for the build status
[16:30:51.427] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:51.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:9:0) after 1m0s
[16:31:51.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:9:0)
[16:31:51.457] Timer tick, asking Buildbucket for the build status
[16:31:51.805] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:51.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:10:0) after 1m0s
[16:32:51.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:10:0)
[16:32:51.853] Timer tick, asking Buildbucket for the build status
[16:32:52.030] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:52.030] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:11:0) after 1m0s
[16:33:52.030] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:11:0)
[16:33:52.030] Timer tick, asking Buildbucket for the build status
[16:33:52.733] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:52.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:12:0) after 1m0s
[16:34:53.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:12:0)
[16:34:53.177] Timer tick, asking Buildbucket for the build status
[16:34:53.596] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:53.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:13:0) after 1m0s
[16:35:54.314] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:13:0)
[16:35:54.314] Timer tick, asking Buildbucket for the build status
[16:35:54.672] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:54.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:14:0) after 1m0s
[16:36:54.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:14:0)
[16:36:54.779] Timer tick, asking Buildbucket for the build status
[16:36:55.079] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:55.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:15:0) after 1m0s
[16:37:55.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:15:0)
[16:37:55.196] Timer tick, asking Buildbucket for the build status
[16:37:55.595] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:55.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:16:0) after 1m0s
[16:38:55.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:16:0)
[16:38:55.615] Timer tick, asking Buildbucket for the build status
[16:38:56.414] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:56.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:17:0) after 1m0s
[16:39:56.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:17:0)
[16:39:56.635] Timer tick, asking Buildbucket for the build status
[16:39:56.991] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:56.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:18:0) after 1m0s
[16:40:57.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:18:0)
[16:40:57.113] Timer tick, asking Buildbucket for the build status
[16:40:57.801] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:57.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:19:0) after 1m0s
[16:41:58.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:19:0)
[16:41:58.068] Timer tick, asking Buildbucket for the build status
[16:41:58.302] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:58.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:20:0) after 1m0s
[16:42:58.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:20:0)
[16:42:58.324] Timer tick, asking Buildbucket for the build status
[16:42:58.628] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:58.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:21:0) after 1m0s
[16:43:58.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:21:0)
[16:43:58.664] Timer tick, asking Buildbucket for the build status
[16:43:59.129] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:59.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:22:0) after 1m0s
[16:44:59.172] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:22:0)
[16:44:59.172] Timer tick, asking Buildbucket for the build status
[16:44:59.587] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:59.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:23:0) after 1m0s
[16:45:59.688] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:23:0)
[16:45:59.688] Timer tick, asking Buildbucket for the build status
[16:45:59.921] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:59.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:24:0) after 1m0s
[16:46:59.947] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:24:0)
[16:46:59.947] Timer tick, asking Buildbucket for the build status
[16:47:01.002] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:01.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:25:0) after 1m0s
[16:48:01.063] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:25:0)
[16:48:01.063] Timer tick, asking Buildbucket for the build status
[16:48:01.230] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:01.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:26:0) after 1m0s
[16:49:01.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:26:0)
[16:49:01.253] Timer tick, asking Buildbucket for the build status
[16:49:01.921] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:01.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:27:0) after 1m0s
[16:50:02.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:27:0)
[16:50:02.029] Timer tick, asking Buildbucket for the build status
[16:50:02.315] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:02.315] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:28:0) after 1m0s
[16:51:02.297] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:28:0)
[16:51:02.297] Timer tick, asking Buildbucket for the build status
[16:51:02.451] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:02.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:29:0) after 1m0s
[16:52:02.519] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:29:0)
[16:52:02.519] Timer tick, asking Buildbucket for the build status
[16:52:02.661] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:02.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:30:0) after 1m0s
[16:53:02.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:30:0)
[16:53:02.778] Timer tick, asking Buildbucket for the build status
[16:53:03.691] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:03.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:31:0) after 1m0s
[16:54:03.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:31:0)
[16:54:03.806] Timer tick, asking Buildbucket for the build status
[16:54:04.058] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:04.058] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:32:0) after 1m0s
[16:55:04.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:32:0)
[16:55:04.162] Timer tick, asking Buildbucket for the build status
[16:55:05.160] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:05.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:33:0) after 1m0s
[16:56:05.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:33:0)
[16:56:05.534] Timer tick, asking Buildbucket for the build status
[16:56:05.712] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:05.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:34:0) after 1m0s
[16:57:05.712] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:34:0)
[16:57:05.712] Timer tick, asking Buildbucket for the build status
[16:57:06.011] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:06.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:35:0) after 1m0s
[16:58:06.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:35:0)
[16:58:06.085] Timer tick, asking Buildbucket for the build status
[16:58:06.313] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:06.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:36:0) after 1m0s
[16:59:06.370] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:36:0)
[16:59:06.371] Timer tick, asking Buildbucket for the build status
[16:59:06.760] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:06.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:37:0) after 1m0s
[17:00:06.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:37:0)
[17:00:06.833] Timer tick, asking Buildbucket for the build status
[17:00:06.997] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:06.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:38:0) after 1m0s
[17:01:07.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:38:0)
[17:01:07.298] Timer tick, asking Buildbucket for the build status
[17:01:08.261] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:08.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:39:0) after 1m0s
[17:02:08.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:39:0)
[17:02:08.818] Timer tick, asking Buildbucket for the build status
[17:02:09.406] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:09.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:40:0) after 1m0s
[17:03:09.499] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:40:0)
[17:03:09.499] Timer tick, asking Buildbucket for the build status
[17:03:09.759] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:09.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:41:0) after 1m0s
[17:04:09.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:41:0)
[17:04:09.809] Timer tick, asking Buildbucket for the build status
[17:04:10.578] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:10.578] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:42:0) after 1m0s
[17:05:10.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:42:0)
[17:05:10.881] Timer tick, asking Buildbucket for the build status
[17:05:16.000] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:16.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:43:0) after 1m0s
[17:06:16.030] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:43:0)
[17:06:16.030] Timer tick, asking Buildbucket for the build status
[17:06:18.947] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:18.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:44:0) after 1m0s
[17:07:18.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:44:0)
[17:07:18.935] Timer tick, asking Buildbucket for the build status
[17:07:19.124] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:19.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:45:0) after 1m0s
[17:08:19.191] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:45:0)
[17:08:19.191] Timer tick, asking Buildbucket for the build status
[17:08:19.743] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:19.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:46:0) after 1m0s
[17:09:19.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:46:0)
[17:09:19.851] Timer tick, asking Buildbucket for the build status
[17:09:20.800] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:20.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:47:0) after 1m0s
[17:10:20.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:47:0)
[17:10:20.799] Timer tick, asking Buildbucket for the build status
[17:10:21.347] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:21.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:48:0) after 1m0s
[17:11:21.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:48:0)
[17:11:21.424] Timer tick, asking Buildbucket for the build status
[17:11:21.589] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:21.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:49:0) after 1m0s
[17:12:21.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:49:0)
[17:12:21.671] Timer tick, asking Buildbucket for the build status
[17:12:21.984] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:21.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:50:0) after 1m0s
[17:13:22.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:50:0)
[17:13:22.003] Timer tick, asking Buildbucket for the build status
[17:13:22.147] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:22.147] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:51:0) after 1m0s
[17:14:22.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:51:0)
[17:14:22.336] Timer tick, asking Buildbucket for the build status
[17:14:23.254] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:23.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:52:0) after 1m0s
[17:15:23.279] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:52:0)
[17:15:23.279] Timer tick, asking Buildbucket for the build status
[17:15:23.500] Build 8893627719906691600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:23.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059057782109082032:53:0) after 1m0s
[17:16:00.768] Received PubSub notification, asking Buildbucket for the build status
[17:16:00.980] Build 8893627719906691600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:16:00.980] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1576775759832602",
"created_by": "project:chromium",
"created_ts": "1576772686054104",
"id": "8893627719906691600",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03a1f6f231b922322142c780bd6f055e21b72ed5\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"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-east1-d-8-103-ofox\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 166317, \"got_angle_revision\": \"f321db9a8ea209392a9c6829603e51fb88825f9d\", \"got_dawn_revision\": \"cf788596f480f194de120c49e5780c7a6dcd12f3\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"03a1f6f231b922322142c780bd6f055e21b72ed5\", \"got_revision_cp\": \"refs/heads/master@{#726394}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"4fd7fccd6db5ebb7a1f9cc7853afc2b6fea16b97\", \"got_v8_revision\": \"121ebd0364042208a9324158650f318310fe1007\", \"got_v8_revision_cp\": \"refs/heads/8.1.55@{#1}\", \"got_webrtc_revision\": \"768c5f438cad7b65a05f8a9fe79d4049329e5475\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30108}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03a1f6f231b922322142c780bd6f055e21b72ed5\", \"swarm_hashes_refs/heads/master(at){#726394}_without_patch\": {\"accessibility_unittests\": \"bd5cdf1cbed4ca422b5174d268680ff34729b735\", \"angle_unittests\": \"cd6affa9811f2301a24bf185911059c398f5fef9\", \"app_shell_unittests\": \"9b85f4a2d05186f6b56953fd147c128195860348\", \"aura_unittests\": \"8d9e3ee6695e7c12d8488fc94b57fb0a39c51d93\", \"base_unittests\": \"c5b2aba06577b7d481796d428b8b5965da7ca7f5\", \"base_util_unittests\": \"a5bf9ca465a858508cae379cb333a083d084ce61\", \"blink_common_unittests\": \"d309e68861cffa73e6eb614f4fd491a84d94d59c\", \"blink_fuzzer_unittests\": \"246d9bf2e3e2bdd0c842537513611daac1418eae\", \"blink_heap_unittests\": \"198f6f485caef449a35f7e3e8b4eb61b7681eba2\", \"blink_platform_unittests\": \"7756d76003cf5699d80de635d516fb7043190443\", \"blink_python_tests\": \"5c5a4851ed7a64e58033e77961a98ad504a0a9bc\", \"blink_unittests\": \"f7ec4e8687a5e302318deafb345d60fa51fbb290\", \"blink_web_tests\": \"f5514ae656165176ac0d388f73bfabfeb95106fa\", \"boringssl_crypto_tests\": \"c63eff6fdf4d79424bd684b6d67439361532e37a\", \"boringssl_ssl_tests\": \"1b42190b7a482e4c20940dd0a0a2d1f07da21e61\", \"browser_tests\": \"6d6026c645564bd73c4332330d6e4379b53ad8c9\", \"cacheinvalidation_unittests\": \"817f8dd056c4b7cd0796356471dae58914321824\", \"capture_unittests\": \"75276540c0a94818ac95f602c689d5ee49b40672\", \"cast_unittests\": \"beb784201dfcee6b925ca71a28582caf15a8a431\", \"cc_unittests\": \"5cdc59a02c0ebe1abcb1524082ad71c13e439814\", \"chrome_app_unittests\": \"041c54913d201d4a52dcaf466ff1120e99ac6fce\", \"chromedriver_unittests\": \"d4236e987eaf20d2bb3f872573db2382a342009d\", \"components_browsertests\": \"430bbf27a2f949c361645871308c35c91f6a7a06\", \"components_unittests\": \"812603284eb061723aca2c0055e825c4a95f3ab7\", \"compositor_unittests\": \"8d3f0cba855366657ed1f763b91252cbe2c8c95c\", \"content_browsertests\": \"528addd738a3ff9501f57d65024c92288312c298\", \"content_shell_crash_test\": \"ec2a1c90a8d0a121dbc791473852a57ac5fce57a\", \"content_unittests\": \"5b14f8261f78dfecb77ff219c0cdc88f6788f643\", \"crashpad_tests\": \"6394904028fe1dcbf321d69c3252292548cf00d6\", \"cronet_tests\": \"7e356a8581750a7ac65fc4f7ddba9cbd71851e18\", \"cronet_unittests\": \"72eed97b4b5f918d1e0566413c433cbf17f4bff8\", \"crypto_unittests\": \"8bf4543d8c2eca814919334792cc6a803b89dadc\", \"dbus_unittests\": \"aa10c14dff307a2d4fdc793792657b5e85beda9d\", \"device_unittests\": \"778479c3fa554b1506f2e0f3138f6d77acf6ca62\", \"devtools_lint_check\": \"b66cb90d6831f86a0b7c48b7db4a02146a40927d\", \"devtools_type_check\": \"d54e2528bbf0af2e2bbf173ef128650e32c866fa\", \"display_unittests\": \"7a54027e397d231df79557025bb929fb51b1c248\", \"events_unittests\": \"9c79b3d40ed52e7f4937dee2ea865b009b9b720d\", \"extensions_browsertests\": \"41b57bbd719c7cca994bce0dba607a9c390bcc99\", \"extensions_unittests\": \"72a2be0f435e496cbaee83d3229ec760a47af207\", \"filesystem_service_unittests\": \"2d3335b5171c61ee43ab832d1cee35a823a0cf86\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"f2794a340ae4876349862746843d78c020977e5f\", \"gfx_unittests\": \"17650208b2b7bd761510e58859a9afd8a4b45b3c\", \"gin_unittests\": \"b7ab4f0eb3a81969fa0dca4746a10ff7a2b07421\", \"google_apis_unittests\": \"1b9cb615ac39c7ad7424e863bd34bd3f284fdbc0\", \"gpu_unittests\": \"60db64c47250f62ed3e50fe5c3804f384faf31bd\", \"grit_python_unittests\": \"25dff9ef6327c596609d376409bc1d0e605b6d43\", \"gwp_asan_unittests\": \"b212aa41a345c97e8ec2946a96ae1db6e9e69325\", \"headless_browsertests\": \"c4c98b07ab76ff6b0243bdecc2d7ba7c21be3390\", \"headless_unittests\": \"33fa98b0c96ffe0a14551de2dec1dcb0e5e58aed\", \"interactive_ui_tests\": \"b1e54b9507c60bb68e3bcd3a65988507f744eff3\", \"ipc_tests\": \"a38a8c58bdcc98521d9f40903955892dcd6ea169\", \"jingle_unittests\": \"748a7905ad7523a7839e3fbccce9d8dd25fca7f0\", \"latency_unittests\": \"c54a60fed853dda821d1757760dd8ada84122f9e\", \"libjingle_xmpp_unittests\": \"01fa2ee61ef98c3ef0a2d6782129aa9377eebbfa\", \"media_blink_unittests\": \"0ddc9d7cf074f942f2bdff1ed3b2f0ae685f1081\", \"media_service_unittests\": \"ba84cebbc8fe98bcc28745001dd9b846429151ea\", \"media_unittests\": \"bff7cbb27af769577db496bda22c311de1acc342\", \"message_center_unittests\": \"59ad8e64e0a2e87af0ae536f9920dd7433424503\", \"metrics_python_tests\": \"dd64898545458c78db3a6ce4ddc723b9dcffb857\", \"midi_unittests\": \"e5a070a220a14b1d8e1134802594c46bbc08e496\", \"mojo_core_unittests\": \"21ccb9bf43dfffd2033f386965ba5efb9baea686\", \"mojo_unittests\": \"a69df5d05544accc60dd0bce1516bdf7e18237c9\", \"nacl_helper_nonsfi_unittests\": \"2f67ec06c6469a8fb1f0bc7e8528ed638fe30f1b\", \"nacl_loader_unittests\": \"a7b1107e5f030a6b41269d79f28a35eafed84bff\", \"native_theme_unittests\": \"3b2488deef67d8f6f903816d2924eba65afa4c91\", \"net_unittests\": \"345a33b473107a6a8513746c2ce5b8ffe78bd8aa\", \"pdf_unittests\": \"46dcc797c2ed192ee01383578513e8e06da80f23\", \"perfetto_unittests\": \"79727d7fe85c6ba639fafe92edfd195a185e47ad\", \"ppapi_unittests\": \"4a2559d98476e57cb0a9289fca88892710224e03\", \"printing_unittests\": \"0c0b947934bb9a196b3ae22a851f5aade0c8b2f5\", \"remoting_unittests\": \"9c747171f160f00b1ea1ab7869cfe3a67e38a896\", \"sandbox_linux_unittests\": \"730fd807c9ee6d36b992c1cade89c1482a74e0ac\", \"service_manager_unittests\": \"cc74af51e61e3e9998edf070b2a462d030cf0558\", \"services_unittests\": \"eaed26ff48552e80727bfc5fa22cce8f4ff9b4dc\", \"shell_dialogs_unittests\": \"cd99c972c6343e6faabed4aa229cf114f0e3b9b8\", \"skia_unittests\": \"33e678647b7c5a6ea8d5d68a3aaa30a19e0887c9\", \"snapshot_unittests\": \"08925a1f3975ed46d1094a93c74400c1edc7e68d\", \"sql_unittests\": \"e23def6c284229e04a8f73c4bb8b3f81cd596baa\", \"storage_unittests\": \"741f7efe6c72c3154d192ac0acde8d5b4894400d\", \"sync_integration_tests\": \"d170f45fdde416264ff2dc6a19ae053f759e3268\", \"telemetry_gpu_unittests\": \"e486b90ac0efc1012db6d95e19b99533eca8c4bb\", \"telemetry_perf_unittests\": \"8d8c99784785b8f6b20266e85c94f15810d387f9\", \"telemetry_unittests\": \"be2c9f4ec33bde55d640a779d2d76265c1007685\", \"traffic_annotation_auditor_unittests\": \"a4bccde9a84344ca8e8194831b44beff5bf00d5b\", \"ui_base_unittests\": \"57ab0bd1f90f8873552e9855a27322d165d39ee4\", \"ui_touch_selection_unittests\": \"242a8edd455f869f3e8f3bc635457efb709353a2\", \"unit_tests\": \"6c498a863a9e534e6e3120c362fddfba782542c1\", \"url_unittests\": \"0b1650a7ce5bb2e3183de1933ef3d44cf1c6dfb6\", \"views_perftests\": \"df0812e7907260fa766c5706e2ed0bb6fe4b82b3\", \"views_unittests\": \"6d23ca34bdc734180eb1a784161b9ac9539294ec\", \"viz_unittests\": \"9fa0a909e0c4b3e15f32571ddb5000c1dea2f549\", \"vr_common_unittests\": \"f498be92574875280084df1da899c833833b1520\", \"vr_pixeltests\": \"6ec28bb4cbe7c042c403123ab3513713e25c8a6d\", \"webdriver_wpt_tests\": \"080b22bc2f4644d8d08725f666177c3807dadc3b\", \"weblayer_browsertests\": \"34b8afce29d52b476a7aed6dcf024df29001fb1b\", \"wm_unittests\": \"da0b764f759a80518a7a136fcb3e7411c5391655\", \"wtf_unittests\": \"cc9a55b90e354ccbe786ba9636c454d3e1636566\", \"xr_browser_tests\": \"5eb5f3f398841d9f8650f0c6f4e1aa1716365550\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-103-ofox\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4733-6bd8c41\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1576773001643686",
"status": "COMPLETED",
"status_changed_ts": "1576775760224864",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166317",
"builder:Linux Builder (dbg)",
"buildset:commit/git/03a1f6f231b922322142c780bd6f055e21b72ed5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03a1f6f231b922322142c780bd6f055e21b72ed5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059057782109082032",
"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/8893627719906691600/+/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:4937cba32e9ece10",
"user_agent:luci-scheduler"
],
"updated_ts": "1576775760228234",
"url": "https://ci.chromium.org/b/8893627719906691600",
"utcnow_ts": "1576775760970568"
}
}
[17:16:00.980] Invocation finished in 51m16.410043605s with status SUCCEEDED