[23:00:50.145] New invocation is queued and will start shortly
[23:00:51.277] Starting the invocation (attempt 1)
[23:00:51.330] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:00:51.330] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:00:51.330] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9061116592344594800",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"92906410dffbdbd3596c3b7147492468f0affc01\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9061116592344594800",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/92906410dffbdbd3596c3b7147492468f0affc01",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/92906410dffbdbd3596c3b7147492468f0affc01",
"gitiles_ref:refs/heads/master"
]
}
[23:00:52.884] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1574809251907126",
"id": "8895686529831010160",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"92906410dffbdbd3596c3b7147492468f0affc01\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1574809252560685",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165321",
"builder:Linux Builder (dbg)",
"buildset:commit/git/92906410dffbdbd3596c3b7147492468f0affc01",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/92906410dffbdbd3596c3b7147492468f0affc01",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061116592344594800",
"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/8895686529831010160/+/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": "1574809252560797",
"url": "https://ci.chromium.org/b/8895686529831010160",
"utcnow_ts": "1574809252872999"
}
}
[23:00:52.884] Task URL: https://ci.chromium.org/b/8895686529831010160
[23:00:52.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:2:0) after 1m0s
[23:01:52.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:2:0)
[23:01:52.948] Timer tick, asking Buildbucket for the build status
[23:01:53.119] Build 8895686529831010160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:53.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:3:0) after 1m0s
[23:02:53.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:3:0)
[23:02:53.187] Timer tick, asking Buildbucket for the build status
[23:02:53.359] Build 8895686529831010160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:53.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:4:0) after 1m0s
[23:03:53.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:4:0)
[23:03:53.393] Timer tick, asking Buildbucket for the build status
[23:03:54.163] Build 8895686529831010160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:54.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:5:0) after 1m0s
[23:04:54.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:5:0)
[23:04:54.274] Timer tick, asking Buildbucket for the build status
[23:04:54.595] Build 8895686529831010160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:54.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:6:0) after 1m0s
[23:05:54.862] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:6:0)
[23:05:54.862] Timer tick, asking Buildbucket for the build status
[23:05:55.322] Build 8895686529831010160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:55.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:7:0) after 1m0s
[23:06:02.989] Received PubSub notification, asking Buildbucket for the build status
[23:06:03.567] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:55.544] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:7:0)
[23:06:55.544] Timer tick, asking Buildbucket for the build status
[23:06:55.686] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:55.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:9:0) after 1m0s
[23:07:55.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:9:0)
[23:07:55.818] Timer tick, asking Buildbucket for the build status
[23:07:57.224] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:57.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:10:0) after 1m0s
[23:08:57.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:10:0)
[23:08:57.396] Timer tick, asking Buildbucket for the build status
[23:08:57.890] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:57.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:11:0) after 1m0s
[23:09:58.004] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:11:0)
[23:09:58.005] Timer tick, asking Buildbucket for the build status
[23:09:58.166] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:58.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:12:0) after 1m0s
[23:10:58.493] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:12:0)
[23:10:58.493] Timer tick, asking Buildbucket for the build status
[23:10:59.235] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:59.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:13:0) after 1m0s
[23:11:59.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:13:0)
[23:11:59.312] Timer tick, asking Buildbucket for the build status
[23:11:59.474] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:59.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:14:0) after 1m0s
[23:12:59.515] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:14:0)
[23:12:59.515] Timer tick, asking Buildbucket for the build status
[23:12:59.741] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:59.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:15:0) after 1m0s
[23:13:59.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:15:0)
[23:13:59.990] Timer tick, asking Buildbucket for the build status
[23:14:00.683] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:00.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:16:0) after 1m0s
[23:15:01.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:16:0)
[23:15:01.124] Timer tick, asking Buildbucket for the build status
[23:15:01.335] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:01.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:17:0) after 1m0s
[23:16:01.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:17:0)
[23:16:01.511] Timer tick, asking Buildbucket for the build status
[23:16:01.720] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:01.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:18:0) after 1m0s
[23:17:01.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:18:0)
[23:17:01.848] Timer tick, asking Buildbucket for the build status
[23:17:02.314] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:02.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:19:0) after 1m0s
[23:18:02.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:19:0)
[23:18:02.507] Timer tick, asking Buildbucket for the build status
[23:18:02.715] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:02.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:20:0) after 1m0s
[23:19:02.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:20:0)
[23:19:02.815] Timer tick, asking Buildbucket for the build status
[23:19:05.824] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:05.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:21:0) after 1m0s
[23:20:05.831] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:21:0)
[23:20:05.831] Timer tick, asking Buildbucket for the build status
[23:20:05.978] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:05.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:22:0) after 1m0s
[23:21:06.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:22:0)
[23:21:06.185] Timer tick, asking Buildbucket for the build status
[23:21:06.628] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:06.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:23:0) after 1m0s
[23:22:06.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:23:0)
[23:22:06.960] Timer tick, asking Buildbucket for the build status
[23:22:09.390] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:09.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:24:0) after 1m0s
[23:23:09.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:24:0)
[23:23:09.534] Timer tick, asking Buildbucket for the build status
[23:23:11.706] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:11.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:25:0) after 1m0s
[23:24:11.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:25:0)
[23:24:11.732] Timer tick, asking Buildbucket for the build status
[23:24:12.762] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:12.762] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:26:0) after 1m0s
[23:25:12.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:26:0)
[23:25:12.823] Timer tick, asking Buildbucket for the build status
[23:25:12.972] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:12.972] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:27:0) after 1m0s
[23:26:13.049] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:27:0)
[23:26:13.049] Timer tick, asking Buildbucket for the build status
[23:26:13.233] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:13.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:28:0) after 1m0s
[23:27:13.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:28:0)
[23:27:13.275] Timer tick, asking Buildbucket for the build status
[23:27:13.915] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:13.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:29:0) after 1m0s
[23:28:13.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:29:0)
[23:28:13.976] Timer tick, asking Buildbucket for the build status
[23:28:14.613] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:14.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:30:0) after 1m0s
[23:29:14.690] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:30:0)
[23:29:14.690] Timer tick, asking Buildbucket for the build status
[23:29:15.669] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:15.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:31:0) after 1m0s
[23:30:15.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:31:0)
[23:30:15.707] Timer tick, asking Buildbucket for the build status
[23:30:15.841] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:15.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:32:0) after 1m0s
[23:31:15.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:32:0)
[23:31:15.863] Timer tick, asking Buildbucket for the build status
[23:31:16.127] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:16.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:33:0) after 1m0s
[23:32:16.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:33:0)
[23:32:16.199] Timer tick, asking Buildbucket for the build status
[23:32:16.620] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:16.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:34:0) after 1m0s
[23:33:16.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:34:0)
[23:33:16.771] Timer tick, asking Buildbucket for the build status
[23:33:17.701] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:17.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:35:0) after 1m0s
[23:34:17.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:35:0)
[23:34:17.942] Timer tick, asking Buildbucket for the build status
[23:34:18.111] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:18.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:36:0) after 1m0s
[23:35:18.160] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:36:0)
[23:35:18.160] Timer tick, asking Buildbucket for the build status
[23:35:18.339] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:18.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:37:0) after 1m0s
[23:36:18.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:37:0)
[23:36:18.450] Timer tick, asking Buildbucket for the build status
[23:36:19.054] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:19.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:38:0) after 1m0s
[23:37:19.084] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:38:0)
[23:37:19.084] Timer tick, asking Buildbucket for the build status
[23:37:19.835] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:19.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:39:0) after 1m0s
[23:38:19.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:39:0)
[23:38:19.890] Timer tick, asking Buildbucket for the build status
[23:38:20.213] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:20.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:40:0) after 1m0s
[23:39:20.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:40:0)
[23:39:20.247] Timer tick, asking Buildbucket for the build status
[23:39:20.404] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:20.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:41:0) after 1m0s
[23:40:20.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:41:0)
[23:40:20.588] Timer tick, asking Buildbucket for the build status
[23:40:20.753] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:20.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:42:0) after 1m0s
[23:41:20.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:42:0)
[23:41:20.848] Timer tick, asking Buildbucket for the build status
[23:41:21.369] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:21.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:43:0) after 1m0s
[23:42:21.555] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:43:0)
[23:42:21.555] Timer tick, asking Buildbucket for the build status
[23:42:21.957] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:21.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:44:0) after 1m0s
[23:43:22.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:44:0)
[23:43:22.106] Timer tick, asking Buildbucket for the build status
[23:43:24.281] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:24.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:45:0) after 1m0s
[23:44:24.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:45:0)
[23:44:24.400] Timer tick, asking Buildbucket for the build status
[23:44:26.669] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:26.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:46:0) after 1m0s
[23:45:26.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:46:0)
[23:45:26.804] Timer tick, asking Buildbucket for the build status
[23:45:27.843] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:27.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:47:0) after 1m0s
[23:46:27.894] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:47:0)
[23:46:27.895] Timer tick, asking Buildbucket for the build status
[23:46:28.635] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:28.635] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:48:0) after 1m0s
[23:47:28.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:48:0)
[23:47:28.667] Timer tick, asking Buildbucket for the build status
[23:47:28.945] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:28.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:49:0) after 1m0s
[23:48:28.982] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:49:0)
[23:48:28.982] Timer tick, asking Buildbucket for the build status
[23:48:29.902] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:29.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:50:0) after 1m0s
[23:49:29.926] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:50:0)
[23:49:29.926] Timer tick, asking Buildbucket for the build status
[23:49:30.424] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:30.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:51:0) after 1m0s
[23:50:30.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:51:0)
[23:50:30.552] Timer tick, asking Buildbucket for the build status
[23:50:31.120] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:31.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:52:0) after 1m0s
[23:51:31.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:52:0)
[23:51:31.275] Timer tick, asking Buildbucket for the build status
[23:51:31.418] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:31.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:53:0) after 1m0s
[23:52:31.445] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:53:0)
[23:52:31.445] Timer tick, asking Buildbucket for the build status
[23:52:31.783] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:31.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:54:0) after 1m0s
[23:53:31.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:54:0)
[23:53:31.974] Timer tick, asking Buildbucket for the build status
[23:53:32.275] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:32.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:55:0) after 1m0s
[23:54:32.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:55:0)
[23:54:32.346] Timer tick, asking Buildbucket for the build status
[23:54:32.613] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:32.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:56:0) after 1m0s
[23:55:32.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:56:0)
[23:55:32.650] Timer tick, asking Buildbucket for the build status
[23:55:33.216] Build 8895686529831010160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:33.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061116592344594800:57:0) after 1m0s
[23:56:05.710] Received PubSub notification, asking Buildbucket for the build status
[23:56:05.825] Build 8895686529831010160: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:56:05.825] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1574812564308259",
"created_by": "project:chromium",
"created_ts": "1574809251907126",
"id": "8895686529831010160",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"92906410dffbdbd3596c3b7147492468f0affc01\"}}",
"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-central1-b-8-61-08kz\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165321, \"got_angle_revision\": \"88752889c721c4621dde3e9209dffd60f5fc8d1f\", \"got_dawn_revision\": \"74cebd68792d5788144f50511b3eb35134f9803e\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"92906410dffbdbd3596c3b7147492468f0affc01\", \"got_revision_cp\": \"refs/heads/master@{#719380}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"663dcefa22ea5eec1b108feebaf40a683fb104ff\", \"got_v8_revision\": \"0f1fce1f943b2b050d8e4eba76de948b30c74e4a\", \"got_v8_revision_cp\": \"refs/heads/8.0.380@{#1}\", \"got_webrtc_revision\": \"44d7ec06830ea1103f5a4c4e841980c94942a9aa\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29921}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"92906410dffbdbd3596c3b7147492468f0affc01\", \"swarm_hashes_refs/heads/master(at){#719380}_without_patch\": {\"accessibility_unittests\": \"4a491d35cf8ef646479c64cbce70a0dec88adca1\", \"angle_unittests\": \"dedb36ae9b97a41d45837583c5ef1c9e541e7b63\", \"app_shell_unittests\": \"bb140f6b6aee8e1ec058fa32feb36f8c884052b6\", \"aura_unittests\": \"5f2583748a2855819f27050eb0c9be125a645c2e\", \"base_unittests\": \"3bb1f7e76fd9d385ebd27b13c9a5838628346e9c\", \"base_util_unittests\": \"b84508c7c78dd3d640bc75aef7912533e9bcf5a3\", \"blink_common_unittests\": \"2288e1f3464ed63222fa436cb86902aeecf6d07c\", \"blink_fuzzer_unittests\": \"8aecba217a3e073d2020e3bf038f464ed4869dad\", \"blink_heap_unittests\": \"7084d29294cc30e1413a80d0245325d8969c395a\", \"blink_platform_unittests\": \"b9a4073edddbfe85533c85266186030cefce0378\", \"blink_python_tests\": \"7314f6687aea03da50d8469323e88d975f41fc89\", \"blink_unittests\": \"4b189f592fcb784bdbde882d0cf84ccb68742f38\", \"blink_web_tests_exparchive\": \"d72fdb0d2bb484d7684a869285e67aeaa73031a7\", \"boringssl_crypto_tests\": \"dfa1c1cfcd208472e8fa9772d97c042de192bbad\", \"boringssl_ssl_tests\": \"651244bf035ebd98c491f0c8b653566b2352bcb7\", \"browser_tests\": \"1bbade860a4ac36421121c915046371d8ac64cb1\", \"cacheinvalidation_unittests\": \"0e58352afcaf57446efd084ce378ad087e5dcfea\", \"capture_unittests\": \"af41e51e2c5d4b2eb91a5df4c9d8fabf137f70fe\", \"cast_unittests\": \"f7353b46ba7b1dc6b97d145d7bc71997e4361857\", \"cc_unittests\": \"b6235aa166f339cb48ddf0119991d20bb6e28559\", \"chrome_app_unittests\": \"4b9e3d1cd9b9340f8936db19f019b0f30c8d0e4a\", \"chromedriver_unittests\": \"b830dac4f1a5f3e0f1cce1a15e05b70e54e4d15a\", \"color_unittests\": \"c74ecfec11d83e897d2901b329da8255952dd0ad\", \"components_browsertests\": \"9598b27877c4251efdebe9570367e833a60a5be8\", \"components_unittests\": \"a91cc222042567ffa35da9576f56b806287fcb74\", \"compositor_unittests\": \"8a281c652bf9c69436434b0e7e84f7b0365c18c3\", \"content_browsertests\": \"0d59d16f31fcc742cc47082fef640c84292364f2\", \"content_shell_crash_test\": \"58a676bbebb3333efd569af26db22f1124fea01e\", \"content_unittests\": \"a6076486d0e784174f5568f91ab88ee1ee538040\", \"crashpad_tests\": \"3171d7f5cf33a3cba6944e1c112fdf357658985d\", \"cronet_tests\": \"ff8c4eee4aee8a6894e5f3da24e45490b49e732c\", \"cronet_unittests\": \"61753843360b878ac90f56b070d58d0376902200\", \"crypto_unittests\": \"e8ae19fd84f2811aae0a6199ab5601ee2c91b793\", \"dbus_unittests\": \"affca8485bfe58e1a2b563b8688d13c5e6e2fbc2\", \"device_unittests\": \"058a5c46b6610de2b590e66f31fc0af1b89b4a11\", \"devtools_lint_check\": \"ed971cc571ec38a894ab2fe61dce63c556007470\", \"devtools_type_check\": \"994421d62254771738384d3cc9c8a87c64064890\", \"display_unittests\": \"d1a0d99a3e2ab1028f24ad637b731bf333ab828a\", \"events_unittests\": \"3ea69811c1f929b9678c8193ae5114594f495abc\", \"extensions_browsertests\": \"cf5e99ec5435481bb8002c9028de083159a20646\", \"extensions_unittests\": \"9b7743877dbb9d38a959e4a72f8b38600ab28389\", \"filesystem_service_unittests\": \"80c152317fb8e931e6dc473262de17c8100dbdb3\", \"flatbuffers_unittests\": \"7789eafdfb4cdfa68fc1e31ec23b8fec028610f8\", \"gcm_unit_tests\": \"95e20b731ed146467c8108174072a2a8721f4e08\", \"gfx_unittests\": \"d8604492c8e1ecb30f1c16cdab52f892b4120010\", \"gin_unittests\": \"877245067f185867305f16403c892a0531030871\", \"google_apis_unittests\": \"a95f557a995064f5acee102c2cae11725ad79946\", \"gpu_unittests\": \"7ba047a182a534097b34db8264a703eaf465c114\", \"grit_python_unittests\": \"4267cdfe96cbb5881cc25cc5b15aab4b2f28c5f5\", \"gwp_asan_unittests\": \"3c4fc660c01405b62908653dfc90db13836d9505\", \"headless_browsertests\": \"f7a75c70ccf8dc666cf4e1814ec6f1040cd05354\", \"headless_unittests\": \"db847f24c727533ffc960aafd6e11390c34c09be\", \"interactive_ui_tests\": \"c907e99cbc95f2b917a467a466d9cb6b7987a2dd\", \"ipc_tests\": \"ec939e8b59332f4bee85f99bf60a106dd2469ad0\", \"jingle_unittests\": \"886b2e7f75e92a137dc79901d9008c2ed7d32c93\", \"latency_unittests\": \"b3fb0b8eb7623fab9eea3a147e416dcd23f7f03f\", \"libjingle_xmpp_unittests\": \"5c9ea0142791e54b8cd37095d47f81a7e420035b\", \"media_blink_unittests\": \"ab70dd0b26e2557db7bd663080cdb0c3b058877e\", \"media_service_unittests\": \"4d479bb51b28eed2f18a20a65d63f79819fab734\", \"media_unittests\": \"3ae53121fa578b08f6ad8c22324c92187248899d\", \"message_center_unittests\": \"a00f8ef9a5106de2da9240dbdee58f9a97705f80\", \"metrics_python_tests\": \"5a51973bc57f49bf74f5b97f1500a6bdecdb7eee\", \"midi_unittests\": \"009ccbdc8b131a2baa3aa5986b79a4ef94da129c\", \"mojo_core_unittests\": \"97756b90a54cce3d33693deee6ba282dd62bd6b2\", \"mojo_unittests\": \"a1edee8582bfe15e01b389c3991def5277301f22\", \"nacl_helper_nonsfi_unittests\": \"4b64194a90e7c039649fcfbdb5cf7105b5ffa616\", \"nacl_loader_unittests\": \"609288c1e50a9aa1f4904d0836c1cacca53abf4d\", \"native_theme_unittests\": \"7dabe88e9dd96973f97038acdc883f65c7bce4e4\", \"net_unittests\": \"ff2f02f505d19710f9117c7cc78077dbf5f0aa38\", \"pdf_unittests\": \"555836eaa34684fd3b99fd79007a6763bf3adda3\", \"perfetto_unittests\": \"255757bcc7b72546a5647a0d1bf7547a6feb4972\", \"ppapi_unittests\": \"14a1820cd6b24fce39c84ba482a5caa1c7770be2\", \"printing_unittests\": \"3aefea91ea940028b1db786fe2177d5497b5e891\", \"remoting_unittests\": \"a720c3b4d212c51f67af83af0ae9d318635f0b63\", \"sandbox_linux_unittests\": \"2b644fe1d336b3515910ab304337ed08add3147f\", \"service_manager_unittests\": \"ec84af0398e1dbffc868e0d9163aade3e447778e\", \"services_unittests\": \"eadd12b7d13088dd68449b3bf52c922eeebb79f5\", \"shell_dialogs_unittests\": \"eaa2a7dde924d8d905a305f7972574f912dfc3f3\", \"skia_unittests\": \"d8b5bd84285dec9372667e01031b011f14d22c05\", \"snapshot_unittests\": \"ef4cf0f0618a05d3f5a0d164f764c2202afddbf3\", \"sql_unittests\": \"9662ccc6851a48904584d12630599fdc23212c78\", \"storage_unittests\": \"0e9a5e58457e4716aa87602a67cf739965bd0959\", \"sync_integration_tests\": \"974d5686a89601d2225bb734cd1e359a1feffff7\", \"telemetry_gpu_unittests\": \"9c8cb1340a0495767bbac6ced0454d3d5235f08a\", \"telemetry_perf_unittests\": \"9f7228f3f91122a65bd29de6ad98fd92db08cb9d\", \"telemetry_unittests\": \"1e142444062a43ce5eb512b5d64d21d25e5a7c1e\", \"traffic_annotation_auditor_unittests\": \"a220d04d9e9de7db43578bad3b42bc33b22dc669\", \"ui_base_unittests\": \"2589a49ab1f68c0517a94360355bc7806e2ae4e4\", \"ui_touch_selection_unittests\": \"3e95563cb43b5df8aceab6568ff149e5b956853c\", \"unit_tests\": \"c2f8e836db1538d4ad8ec6401841c6c582f2aef5\", \"url_unittests\": \"7efdff21b6016bc48316d9b8db877e4890a99483\", \"views_perftests\": \"415ba79ac911279790f1c41066cf7ee1d3134ad4\", \"views_unittests\": \"db18f229a9510638a4cbdf7cba3325e479c45033\", \"viz_unittests\": \"6b9c0f130d407586fd0ce2b3a982bca0e2ffa2ba\", \"vr_common_unittests\": \"5d87a95b92dd2aa7c23db7513a3aa25a8d427b8e\", \"vr_pixeltests\": \"1501682e57b0eb7bd5560acc62440b302b6d770e\", \"webdriver_wpt_tests\": \"d2d5f48f7676a15f889942e17c77a88faeafd85a\", \"weblayer_browsertests\": \"6e76d2d4a0a8001ccde602ab564f68d5faa4f29d\", \"wm_unittests\": \"05e622a2995eccecabab4118417b1aa48944a001\", \"wtf_unittests\": \"39b8e21999fa5657addf047e67114f894794298c\", \"xr_browser_tests\": \"2cf9b7014c877e0eda3d6a52aca1d0ce5cff7aa6\"}}, \"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-central1-b-8-61-08kz\"], \"image\": [\"chrome-xenial-19112404-1fe53dcaaf2\"], \"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\": [\"4656-a09e2f8\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1574809562073700",
"status": "COMPLETED",
"status_changed_ts": "1574812564946813",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165321",
"builder:Linux Builder (dbg)",
"buildset:commit/git/92906410dffbdbd3596c3b7147492468f0affc01",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/92906410dffbdbd3596c3b7147492468f0affc01",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061116592344594800",
"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/8895686529831010160/+/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:48c2c3eb02a08710",
"user_agent:luci-scheduler"
],
"updated_ts": "1574812564974041",
"url": "https://ci.chromium.org/b/8895686529831010160",
"utcnow_ts": "1574812565815173"
}
}
[23:56:05.825] Invocation finished in 55m15.699281986s with status SUCCEEDED