[14:09:09.296] New invocation is queued and will start shortly
[14:09:11.035] Starting the invocation (attempt 1)
[14:09:11.079] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:09:11.079] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:09:11.079] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031796625692694736",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b6f71d14c08e11f74cba9a631bfe24542bfd8327\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9031796625692694736",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/b6f71d14c08e11f74cba9a631bfe24542bfd8327",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b6f71d14c08e11f74cba9a631bfe24542bfd8327",
"gitiles_ref:refs/heads/master"
]
}
[14:09:13.918] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602770951412879",
"id": "8866366562810183280",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b6f71d14c08e11f74cba9a631bfe24542bfd8327\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602770953243465",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176697",
"builder:Linux Builder (dbg)",
"buildset:commit/git/b6f71d14c08e11f74cba9a631bfe24542bfd8327",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b6f71d14c08e11f74cba9a631bfe24542bfd8327",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031796625692694736",
"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/8866366562810183280/+/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": "1602770953243600",
"url": "https://ci.chromium.org/b/8866366562810183280",
"utcnow_ts": "1602770953880703"
}
}
[14:09:13.918] Task URL: https://ci.chromium.org/b/8866366562810183280
[14:09:13.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:2:0) after 1m0s
[14:09:16.055] Received PubSub notification, asking Buildbucket for the build status
[14:09:16.130] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:13.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:2:0)
[14:10:13.975] Timer tick, asking Buildbucket for the build status
[14:10:14.085] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:14.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:4:0) after 1m0s
[14:11:14.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:4:0)
[14:11:14.117] Timer tick, asking Buildbucket for the build status
[14:11:14.208] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:14.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:5:0) after 1m0s
[14:12:14.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:5:0)
[14:12:14.291] Timer tick, asking Buildbucket for the build status
[14:12:14.429] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:14.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:6:0) after 1m0s
[14:13:14.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:6:0)
[14:13:14.476] Timer tick, asking Buildbucket for the build status
[14:13:14.967] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:14.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:7:0) after 1m0s
[14:14:14.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:7:0)
[14:14:14.956] Timer tick, asking Buildbucket for the build status
[14:14:15.088] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:15.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:8:0) after 1m0s
[14:15:15.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:8:0)
[14:15:15.112] Timer tick, asking Buildbucket for the build status
[14:15:15.171] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:15.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:9:0) after 1m0s
[14:16:15.239] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:9:0)
[14:16:15.239] Timer tick, asking Buildbucket for the build status
[14:16:15.324] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:15.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:10:0) after 1m0s
[14:17:15.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:10:0)
[14:17:15.387] Timer tick, asking Buildbucket for the build status
[14:17:15.600] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:15.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:11:0) after 1m0s
[14:18:15.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:11:0)
[14:18:15.691] Timer tick, asking Buildbucket for the build status
[14:18:15.800] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:15.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:12:0) after 1m0s
[14:19:15.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:12:0)
[14:19:15.903] Timer tick, asking Buildbucket for the build status
[14:19:16.098] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:16.098] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:13:0) after 1m0s
[14:20:16.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:13:0)
[14:20:16.138] Timer tick, asking Buildbucket for the build status
[14:20:16.313] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:16.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:14:0) after 1m0s
[14:21:16.478] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:14:0)
[14:21:16.478] Timer tick, asking Buildbucket for the build status
[14:21:16.540] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:16.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:15:0) after 1m0s
[14:22:16.692] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:15:0)
[14:22:16.692] Timer tick, asking Buildbucket for the build status
[14:22:16.783] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:16.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:16:0) after 1m0s
[14:23:16.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:16:0)
[14:23:16.942] Timer tick, asking Buildbucket for the build status
[14:23:17.079] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:17.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:17:0) after 1m0s
[14:24:17.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:17:0)
[14:24:17.079] Timer tick, asking Buildbucket for the build status
[14:24:17.192] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:17.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:18:0) after 1m0s
[14:25:17.216] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:18:0)
[14:25:17.216] Timer tick, asking Buildbucket for the build status
[14:25:17.272] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:17.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:19:0) after 1m0s
[14:26:17.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:19:0)
[14:26:17.292] Timer tick, asking Buildbucket for the build status
[14:26:17.348] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:17.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:20:0) after 1m0s
[14:27:17.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:20:0)
[14:27:17.393] Timer tick, asking Buildbucket for the build status
[14:27:17.473] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:17.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:21:0) after 1m0s
[14:28:17.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:21:0)
[14:28:17.531] Timer tick, asking Buildbucket for the build status
[14:28:17.641] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:17.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:22:0) after 1m0s
[14:29:17.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:22:0)
[14:29:17.635] Timer tick, asking Buildbucket for the build status
[14:29:17.762] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:17.762] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:23:0) after 1m0s
[14:30:17.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:23:0)
[14:30:17.884] Timer tick, asking Buildbucket for the build status
[14:30:18.038] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:18.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:24:0) after 1m0s
[14:31:18.089] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:24:0)
[14:31:18.089] Timer tick, asking Buildbucket for the build status
[14:31:18.170] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:18.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:25:0) after 1m0s
[14:32:18.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:25:0)
[14:32:18.211] Timer tick, asking Buildbucket for the build status
[14:32:18.275] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:18.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:26:0) after 1m0s
[14:33:18.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:26:0)
[14:33:18.361] Timer tick, asking Buildbucket for the build status
[14:33:18.426] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:18.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:27:0) after 1m0s
[14:34:18.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:27:0)
[14:34:18.463] Timer tick, asking Buildbucket for the build status
[14:34:18.616] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:18.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:28:0) after 1m0s
[14:35:18.681] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:28:0)
[14:35:18.681] Timer tick, asking Buildbucket for the build status
[14:35:18.788] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:18.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:29:0) after 1m0s
[14:36:18.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:29:0)
[14:36:18.837] Timer tick, asking Buildbucket for the build status
[14:36:18.936] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:18.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:30:0) after 1m0s
[14:37:18.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:30:0)
[14:37:18.952] Timer tick, asking Buildbucket for the build status
[14:37:19.075] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:19.075] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:31:0) after 1m0s
[14:38:19.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:31:0)
[14:38:19.100] Timer tick, asking Buildbucket for the build status
[14:38:19.161] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:19.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:32:0) after 1m0s
[14:39:19.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:32:0)
[14:39:19.211] Timer tick, asking Buildbucket for the build status
[14:39:19.333] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:19.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:33:0) after 1m0s
[14:40:19.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:33:0)
[14:40:19.354] Timer tick, asking Buildbucket for the build status
[14:40:19.486] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:19.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:34:0) after 1m0s
[14:41:19.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:34:0)
[14:41:19.518] Timer tick, asking Buildbucket for the build status
[14:41:19.697] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:19.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:35:0) after 1m0s
[14:42:19.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:35:0)
[14:42:19.835] Timer tick, asking Buildbucket for the build status
[14:42:19.918] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:19.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:36:0) after 1m0s
[14:43:19.922] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:36:0)
[14:43:19.922] Timer tick, asking Buildbucket for the build status
[14:43:19.994] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:19.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:37:0) after 1m0s
[14:44:20.040] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:37:0)
[14:44:20.040] Timer tick, asking Buildbucket for the build status
[14:44:20.140] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:20.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:38:0) after 1m0s
[14:45:20.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:38:0)
[14:45:20.195] Timer tick, asking Buildbucket for the build status
[14:45:20.397] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:20.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:39:0) after 1m0s
[14:46:20.413] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:39:0)
[14:46:20.413] Timer tick, asking Buildbucket for the build status
[14:46:20.808] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:20.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:40:0) after 1m0s
[14:47:20.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:40:0)
[14:47:20.866] Timer tick, asking Buildbucket for the build status
[14:47:20.946] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:20.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:41:0) after 1m0s
[14:48:21.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:41:0)
[14:48:21.006] Timer tick, asking Buildbucket for the build status
[14:48:21.309] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:21.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:42:0) after 1m0s
[14:49:21.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:42:0)
[14:49:21.393] Timer tick, asking Buildbucket for the build status
[14:49:21.830] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:21.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:43:0) after 1m0s
[14:50:21.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:43:0)
[14:50:21.871] Timer tick, asking Buildbucket for the build status
[14:50:21.989] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:21.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:44:0) after 1m0s
[14:51:22.055] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:44:0)
[14:51:22.055] Timer tick, asking Buildbucket for the build status
[14:51:22.135] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:22.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:45:0) after 1m0s
[14:52:22.163] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:45:0)
[14:52:22.163] Timer tick, asking Buildbucket for the build status
[14:52:22.340] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:22.340] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:46:0) after 1m0s
[14:53:22.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:46:0)
[14:53:22.396] Timer tick, asking Buildbucket for the build status
[14:53:22.624] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:22.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:47:0) after 1m0s
[14:54:23.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:47:0)
[14:54:23.066] Timer tick, asking Buildbucket for the build status
[14:54:23.171] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:23.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:48:0) after 1m0s
[14:55:23.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:48:0)
[14:55:23.308] Timer tick, asking Buildbucket for the build status
[14:55:23.578] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:23.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:49:0) after 1m0s
[14:56:23.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:49:0)
[14:56:23.701] Timer tick, asking Buildbucket for the build status
[14:56:23.902] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:23.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:50:0) after 1m0s
[14:57:23.936] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:50:0)
[14:57:23.936] Timer tick, asking Buildbucket for the build status
[14:57:24.003] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:24.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:51:0) after 1m0s
[14:58:24.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:51:0)
[14:58:24.006] Timer tick, asking Buildbucket for the build status
[14:58:24.067] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:24.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:52:0) after 1m0s
[14:59:24.175] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:52:0)
[14:59:24.176] Timer tick, asking Buildbucket for the build status
[14:59:24.294] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:24.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:53:0) after 1m0s
[15:00:24.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:53:0)
[15:00:24.403] Timer tick, asking Buildbucket for the build status
[15:00:24.519] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:24.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:54:0) after 1m0s
[15:01:24.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:54:0)
[15:01:24.546] Timer tick, asking Buildbucket for the build status
[15:01:24.801] Build 8866366562810183280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:24.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031796625692694736:55:0) after 1m0s
[15:02:02.619] Received PubSub notification, asking Buildbucket for the build status
[15:02:02.699] Build 8866366562810183280: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:02:02.699] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602774121786310",
"created_by": "project:chromium",
"created_ts": "1602770951412879",
"id": "8866366562810183280",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b6f71d14c08e11f74cba9a631bfe24542bfd8327\"}}",
"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\": \"b6f71d14c08e11f74cba9a631bfe24542bfd8327\", \"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-18-10vj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 176697, \"got_angle_revision\": \"481fb88fee3376caef75a784fbfca0b8501a686a\", \"got_dawn_revision\": \"6298d2b70cb67bb929f7817f2186f618ec8f1ca1\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"b6f71d14c08e11f74cba9a631bfe24542bfd8327\", \"got_revision_cp\": \"refs/heads/master@{#817476}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"52c1a859d9ebd3adb49e70d1c7a5ac287388445e\", \"got_v8_revision\": \"23b0ebb5ce894d691bce6f969da676930254cff9\", \"got_v8_revision_cp\": \"refs/heads/8.8.86@{#1}\", \"got_webrtc_revision\": \"239f92ecf7fc8ca27e0376dd192b33ce33377b3c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32410}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b6f71d14c08e11f74cba9a631bfe24542bfd8327\", \"swarm_hashes_refs/heads/master(at){#817476}_without_patch\": {\"absl_hardening_tests\": \"3d027043e0db5f17712d4b03b612a9e0b3a9020d\", \"accessibility_unittests\": \"d6c0c05713dd02e011fb9537343d2dae3e9684b2\", \"app_shell_unittests\": \"7fc189ff48a0ffd67a2b57f6e5869cae2a7ef1c3\", \"aura_unittests\": \"a5c016521d0befe0b46fbf810e0b92b83fee1843\", \"base_unittests\": \"1e0b9b981e7189a0544c1f85b54d0182aa80af82\", \"base_util_unittests\": \"68897c179fd1540cb9dfdc77b2aabd8ddfda6e13\", \"blink_common_unittests\": \"17e4e0b9d30005a25c86bf19b6dea20e4470ba80\", \"blink_fuzzer_unittests\": \"6b5a7198d33b4b3302a9cbce798916c10e67482a\", \"blink_heap_unittests\": \"8f493e86d26f53f3a35507a4ab987870fa4d5aa1\", \"blink_platform_unittests\": \"5b09dd61c74ccc5eb8b7207cfcaf3ff80134d50d\", \"blink_python_tests\": \"5af0f24fc5d182e7779fe1fc57926d7d293095ba\", \"blink_unittests\": \"95aa4c57ba4f6dc5725da21aaec9a73634188dcf\", \"blink_web_tests\": \"3514a93b12fa12e8076f27e7fed1d3f46ab8d956\", \"boringssl_crypto_tests\": \"531151535614364f841ccf229d0b05d7919db017\", \"boringssl_ssl_tests\": \"2d98125288245fe217a33486fc232b30a6efc730\", \"browser_tests\": \"5bd4dc5d89a47e095dfd07f439f704cc8632a747\", \"capture_unittests\": \"1bd1c0f4fb72deb3839b7c623d6c7c55ccf8cc2b\", \"cast_unittests\": \"d0332d654ae851b6f786cd3e0f39288813080a00\", \"cc_unittests\": \"45d4dd9215965f00da1673895252643c1d8f45d4\", \"chrome_app_unittests\": \"5fe80af09996a827e6f45fb5b2ee7b927598628b\", \"chromedriver_unittests\": \"673f7aabf3f72060085a2436cbbae607d85299d8\", \"components_browsertests\": \"3286cc92fcfdf1ad73b89a3ec1ac499702c5236a\", \"components_unittests\": \"ca84f445eca8ae05c02698c69283c81e041d8e9b\", \"compositor_unittests\": \"d60a9a260473c3bb76e2b297d3ff5a09ec8121fa\", \"content_browsertests\": \"f85dba27d99927db0e5d9f13035ffc23171020e4\", \"content_shell_crash_test\": \"474e99e75759b735da04d2bab15a09accf5ff1b4\", \"content_unittests\": \"1fadf98ce8657f6495ace81ed27ac4345082eb27\", \"crashpad_tests\": \"d5a285e3e49dd38b0243770b26254540967b3a57\", \"cronet_tests\": \"882e2f8a030066ff08735c7b01d00cbab825221d\", \"cronet_unittests\": \"8c73f6c9f0db88d57ffbf784281de2c811ba0aff\", \"crypto_unittests\": \"9468f036a360d83746c9fa0c540ff9cc23275b78\", \"dbus_unittests\": \"a03c2fd905a76da103aa2376c925cd1b8c5f34a9\", \"device_unittests\": \"56624f5d7571cdb8a639d393eed0f1f29cea471e\", \"display_unittests\": \"49edadcccef02d7d367a6717df53bbcb75dbc4c8\", \"events_unittests\": \"f6c347666926621bab65ce8fd3b80d779d6b994e\", \"extension_docserver_python_unittests\": \"7ce7222ce8adea4bbf40c09290223f7a9598eb03\", \"extensions_browsertests\": \"1d0b84ae6dc4e9e1af3ea4e1e1e1519dde0895b6\", \"extensions_unittests\": \"47d9b0b7451d74cf86b88a28085fc4c9c808f5a0\", \"filesystem_service_unittests\": \"f6c5a59c76e17a257fbcbde2dc35b438a51d133c\", \"flatbuffers_unittests\": \"7c821f13730963d6e07deae074f4fffab315d766\", \"gcm_unit_tests\": \"802bee2ec31ad22fbb5a9d786e1cb763a1251e74\", \"gfx_unittests\": \"ecbcaf49420cb651c6bbde427679e95357b092d1\", \"gin_unittests\": \"5e82077ea6203071208382eeaa719b44e0149f7f\", \"google_apis_unittests\": \"33c0762e0e86d4908132c5422bcfafed8455c840\", \"gpu_unittests\": \"43df180e169cd4ba16069abf97b5674cb09e52f6\", \"grit_python_unittests\": \"55fa961d85005331568451ce869e032331bd4b90\", \"gwp_asan_unittests\": \"748414faf6660736f77eeb869ff5b2c60459922f\", \"headless_browsertests\": \"07a9393138e038664ce589173f880a4d493715da\", \"headless_unittests\": \"198eef0b689083550eb28c8db77dee3b37f696f5\", \"interactive_ui_tests\": \"c795ee9e4d96240e7ac9406bfeec829f7ab01794\", \"ipc_tests\": \"511924dbead19d7a699490fdbd48116ff4fce93f\", \"jingle_unittests\": \"dfe0100c015b01482bcdbf484e4ffb4cb273b61a\", \"latency_unittests\": \"c2ba1e41706e78144b16280310df458429da9a27\", \"libjingle_xmpp_unittests\": \"774856d6cdc127faf7982f4539bbab1be1b50b17\", \"media_blink_unittests\": \"b0aa8b9b61dcc69d0a8ecdfcb8a98191013c66b8\", \"media_unittests\": \"4310feace35b64d31faf079d58fa3e1a8711ecff\", \"message_center_unittests\": \"fb4b83a3955ac747bb262d628152022c313eabba\", \"metrics_python_tests\": \"6251efbb5698b2b51e148259106b1e7b30e4acf1\", \"midi_unittests\": \"852c1d345fcd665a13a2b6dbeae185c3749af947\", \"mojo_core_unittests\": \"dd61540d7b6a60b64a21cfdad3358d135d4299c8\", \"mojo_unittests\": \"eec08c3e629f336a3650e5ec7cd6bfbddb8d6713\", \"nacl_helper_nonsfi_unittests\": \"11970db90eb61579cd194d8c1a40688b8dda39f0\", \"nacl_loader_unittests\": \"6ff1d2fb5e1362f88bd1ca345d1d0d4eb90da101\", \"native_theme_unittests\": \"471e61c76a8c9bb1b54fd7d6c9106e4f524f6246\", \"net_unittests\": \"f4a45b92249c8b0665032294505129aaf889883c\", \"openscreen_unittests\": \"c1b863d69a0fab848f41da85c484b484afea8a37\", \"pdf_unittests\": \"3817beafdd2b559013d701fa1f99671d12b211d9\", \"perfetto_unittests\": \"2322b89d2f14e1095a8da126773eb9b4d00ca7ce\", \"ppapi_unittests\": \"2eeea5a9924ffa40cee65b350cfa0c9e8ee6c355\", \"printing_unittests\": \"8a15177f645a5d60bb781806e4b59dc6e57c8d1f\", \"remoting_unittests\": \"b8b884a779e02915f648f41ac99c6bcec1eae3af\", \"sandbox_linux_unittests\": \"c9aea4ecb6a7f00a435345b32693a7baf578fb5e\", \"service_manager_unittests\": \"5429ad4a930a0246442c5e6a3f65cd4dca8718eb\", \"services_unittests\": \"07c20d0d8d2e4c100d697751b6b7b1df510df60b\", \"shell_dialogs_unittests\": \"4f56ded78d94d55ed4dee4dbb923f58bda1cbafc\", \"skia_unittests\": \"48af1fb8e8a3fc43cb7e5651f01af6c3bd1f8082\", \"snapshot_unittests\": \"8ac4bd25071b134199df60d4a96bf21b4e61abd2\", \"sql_unittests\": \"54f61f0227f2f988e6b2542f926e5413e807cfdf\", \"standalone_angle_unittests\": \"5bb26aa5e5074a2f16922b97c3f8a45c555b4d38\", \"storage_unittests\": \"7f5ebf34c8b40af03571d62bf5753a336e65a3be\", \"sync_integration_tests\": \"73915fc9e6a761d4e6a1453abbf5499f275054ac\", \"telemetry_gpu_unittests\": \"026bdba525a9af114952aa811316466573560f3a\", \"telemetry_perf_unittests\": \"544f814432451189a6bdafe68ba021bd99dfd22f\", \"telemetry_unittests\": \"a4003e1daee4edca6ed2249acadced64a250c5a2\", \"traffic_annotation_auditor_unittests\": \"410a1322b07312b9b5afaa49eb232bdf315dcd1a\", \"ui_base_unittests\": \"4e1892996cb81374e93119d788f4a6c73575029a\", \"ui_touch_selection_unittests\": \"566cab0ce59b3ff7c5aaf80642735048230758bb\", \"unit_tests\": \"2c24093f427ed37dc8eb9d9edab56e3940eadb58\", \"url_unittests\": \"ebffb4b5811a0b4b08a972c085528b3767623358\", \"views_perftests\": \"3c1de58b0bb0d4ab094edd121ab52084fb95858a\", \"views_unittests\": \"a9dddb49673f0c358b2d551d843bf67489004323\", \"viz_unittests\": \"a7a3772b59071b2282378ccb57f51e4b51508e0f\", \"vr_common_unittests\": \"965c6958566b7ad6fab3aa7a18dab0aa749cae40\", \"vr_pixeltests\": \"4cb139f21b1ec8ee28b80a92a9fad95e4dbb9fdd\", \"webdriver_wpt_tests\": \"c7b2efe44a49898d5398114dc7ed438c991ff478\", \"weblayer_browsertests\": \"7ef9b75b4dd6282eb2de00b51265c210d53b772b\", \"weblayer_unittests\": \"465c6ab9d951e0e426aa8357805968dff8af2982\", \"wm_unittests\": \"35e17b3a2f94877a7d4546f627e34cb72c8f43bb\", \"wtf_unittests\": \"ce36547b54742afd029e5f7bc65e34a7948ceaff\", \"x11_unittests\": \"1b559b23537a60fd5cbc77225536116c6f5fc85e\", \"xr_browser_tests\": \"a40ce1f3f521701cc72b722a69a0ec860449cfe1\", \"zlib_unittests\": \"4eac1bb4c8053bfff96593b9f2f74485248f8ddd\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_51829829c31fbaf3768e3309e640f1ed37e0867e138bde8c875431bcab07adc2_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-18-10vj\"], \"image\": [\"chrome-xenial-20101301-f14f52fdd71\"], \"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\": [\"5595-820ff29\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602770954712939",
"status": "COMPLETED",
"status_changed_ts": "1602774122127983",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176697",
"builder:Linux Builder (dbg)",
"buildset:commit/git/b6f71d14c08e11f74cba9a631bfe24542bfd8327",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b6f71d14c08e11f74cba9a631bfe24542bfd8327",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031796625692694736",
"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/8866366562810183280/+/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:4f45696e78dd7410",
"user_agent:luci-scheduler"
],
"updated_ts": "1602774122142216",
"url": "https://ci.chromium.org/b/8866366562810183280",
"utcnow_ts": "1602774122687194"
}
}
[15:02:02.700] Invocation finished in 52m53.419746303s with status SUCCEEDED