[21:35:06.901] New invocation is queued and will start shortly
[21:35:08.233] Starting the invocation (attempt 1)
[21:35:08.278] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:35:08.278] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:35:08.278] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9049706767661727168",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"112eca96640298981d9f2491bf7b04f24fbc1ad7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9049706767661727168",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/112eca96640298981d9f2491bf7b04f24fbc1ad7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/112eca96640298981d9f2491bf7b04f24fbc1ad7",
"gitiles_ref:refs/heads/master"
]
}
[21:35:09.945] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585690508385534",
"id": "8884276705438099104",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"112eca96640298981d9f2491bf7b04f24fbc1ad7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585690509591518",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170457",
"builder:Linux Builder (dbg)",
"buildset:commit/git/112eca96640298981d9f2491bf7b04f24fbc1ad7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/112eca96640298981d9f2491bf7b04f24fbc1ad7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9049706767661727168",
"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/8884276705438099104/+/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": "1585690509591693",
"url": "https://ci.chromium.org/b/8884276705438099104",
"utcnow_ts": "1585690509903003"
}
}
[21:35:09.945] Task URL: https://ci.chromium.org/b/8884276705438099104
[21:35:09.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:2:0) after 1m0s
[21:36:10.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:2:0)
[21:36:10.039] Timer tick, asking Buildbucket for the build status
[21:36:10.259] Build 8884276705438099104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:36:10.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:3:0) after 1m0s
[21:37:10.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:3:0)
[21:37:10.312] Timer tick, asking Buildbucket for the build status
[21:37:10.470] Build 8884276705438099104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:37:10.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:4:0) after 1m0s
[21:38:10.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:4:0)
[21:38:10.663] Timer tick, asking Buildbucket for the build status
[21:38:10.897] Build 8884276705438099104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:38:10.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:5:0) after 1m0s
[21:39:10.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:5:0)
[21:39:10.954] Timer tick, asking Buildbucket for the build status
[21:39:11.162] Build 8884276705438099104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:39:11.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:6:0) after 1m0s
[21:39:59.010] Received PubSub notification, asking Buildbucket for the build status
[21:39:59.312] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:11.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:6:0)
[21:40:11.196] Timer tick, asking Buildbucket for the build status
[21:40:11.282] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:11.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:8:0) after 1m0s
[21:41:11.297] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:8:0)
[21:41:11.297] Timer tick, asking Buildbucket for the build status
[21:41:11.568] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:11.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:9:0) after 1m0s
[21:42:11.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:9:0)
[21:42:11.597] Timer tick, asking Buildbucket for the build status
[21:42:11.987] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:11.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:10:0) after 1m0s
[21:43:12.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:10:0)
[21:43:12.154] Timer tick, asking Buildbucket for the build status
[21:43:12.346] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:12.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:11:0) after 1m0s
[21:44:12.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:11:0)
[21:44:12.388] Timer tick, asking Buildbucket for the build status
[21:44:12.527] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:12.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:12:0) after 1m0s
[21:45:12.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:12:0)
[21:45:12.557] Timer tick, asking Buildbucket for the build status
[21:45:12.696] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:12.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:13:0) after 1m0s
[21:46:12.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:13:0)
[21:46:12.848] Timer tick, asking Buildbucket for the build status
[21:46:13.216] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:13.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:14:0) after 1m0s
[21:47:13.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:14:0)
[21:47:13.229] Timer tick, asking Buildbucket for the build status
[21:47:13.304] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:13.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:15:0) after 1m0s
[21:48:13.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:15:0)
[21:48:13.351] Timer tick, asking Buildbucket for the build status
[21:48:13.437] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:13.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:16:0) after 1m0s
[21:49:13.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:16:0)
[21:49:13.463] Timer tick, asking Buildbucket for the build status
[21:49:13.605] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:13.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:17:0) after 1m0s
[21:50:13.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:17:0)
[21:50:13.658] Timer tick, asking Buildbucket for the build status
[21:50:13.779] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:13.779] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:18:0) after 1m0s
[21:51:13.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:18:0)
[21:51:13.791] Timer tick, asking Buildbucket for the build status
[21:51:14.727] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:14.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:19:0) after 1m0s
[21:52:14.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:19:0)
[21:52:14.744] Timer tick, asking Buildbucket for the build status
[21:52:15.157] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:15.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:20:0) after 1m0s
[21:53:15.181] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:20:0)
[21:53:15.181] Timer tick, asking Buildbucket for the build status
[21:53:15.606] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:15.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:21:0) after 1m0s
[21:54:15.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:21:0)
[21:54:15.630] Timer tick, asking Buildbucket for the build status
[21:54:15.713] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:15.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:22:0) after 1m0s
[21:55:15.735] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:22:0)
[21:55:15.735] Timer tick, asking Buildbucket for the build status
[21:55:15.974] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:15.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:23:0) after 1m0s
[21:56:16.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:23:0)
[21:56:16.014] Timer tick, asking Buildbucket for the build status
[21:56:16.175] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:16.175] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:24:0) after 1m0s
[21:57:16.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:24:0)
[21:57:16.296] Timer tick, asking Buildbucket for the build status
[21:57:19.703] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:19.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:25:0) after 1m0s
[21:58:19.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:25:0)
[21:58:19.707] Timer tick, asking Buildbucket for the build status
[21:58:19.911] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:19.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:26:0) after 1m0s
[21:59:19.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:26:0)
[21:59:19.938] Timer tick, asking Buildbucket for the build status
[21:59:20.091] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:20.091] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:27:0) after 1m0s
[22:00:20.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:27:0)
[22:00:20.134] Timer tick, asking Buildbucket for the build status
[22:00:21.859] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:21.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:28:0) after 1m0s
[22:01:21.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:28:0)
[22:01:21.901] Timer tick, asking Buildbucket for the build status
[22:01:22.511] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:22.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:29:0) after 1m0s
[22:02:22.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:29:0)
[22:02:22.561] Timer tick, asking Buildbucket for the build status
[22:02:23.370] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:23.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:30:0) after 1m0s
[22:03:23.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:30:0)
[22:03:23.409] Timer tick, asking Buildbucket for the build status
[22:03:23.763] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:23.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:31:0) after 1m0s
[22:04:23.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:31:0)
[22:04:23.785] Timer tick, asking Buildbucket for the build status
[22:04:25.524] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:25.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:32:0) after 1m0s
[22:05:25.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:32:0)
[22:05:25.596] Timer tick, asking Buildbucket for the build status
[22:05:25.815] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:25.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:33:0) after 1m0s
[22:06:25.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:33:0)
[22:06:25.881] Timer tick, asking Buildbucket for the build status
[22:06:26.796] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:26.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:34:0) after 1m0s
[22:07:26.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:34:0)
[22:07:26.851] Timer tick, asking Buildbucket for the build status
[22:07:27.021] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:27.021] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:35:0) after 1m0s
[22:08:27.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:35:0)
[22:08:27.105] Timer tick, asking Buildbucket for the build status
[22:08:28.863] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:28.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:36:0) after 1m0s
[22:09:28.972] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:36:0)
[22:09:28.972] Timer tick, asking Buildbucket for the build status
[22:09:29.162] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:29.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:37:0) after 1m0s
[22:10:29.282] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:37:0)
[22:10:29.282] Timer tick, asking Buildbucket for the build status
[22:10:29.423] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:29.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:38:0) after 1m0s
[22:11:29.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:38:0)
[22:11:29.517] Timer tick, asking Buildbucket for the build status
[22:11:29.738] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:29.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:39:0) after 1m0s
[22:12:29.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:39:0)
[22:12:29.869] Timer tick, asking Buildbucket for the build status
[22:12:30.339] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:30.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:40:0) after 1m0s
[22:13:30.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:40:0)
[22:13:30.457] Timer tick, asking Buildbucket for the build status
[22:13:31.117] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:31.117] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:41:0) after 1m0s
[22:14:31.152] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:41:0)
[22:14:31.153] Timer tick, asking Buildbucket for the build status
[22:14:31.348] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:31.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:42:0) after 1m0s
[22:15:31.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:42:0)
[22:15:31.371] Timer tick, asking Buildbucket for the build status
[22:15:32.233] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:32.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:43:0) after 1m0s
[22:16:32.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:43:0)
[22:16:32.266] Timer tick, asking Buildbucket for the build status
[22:16:32.453] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:32.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:44:0) after 1m0s
[22:17:32.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:44:0)
[22:17:32.536] Timer tick, asking Buildbucket for the build status
[22:17:32.765] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:32.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:45:0) after 1m0s
[22:18:32.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:45:0)
[22:18:32.801] Timer tick, asking Buildbucket for the build status
[22:18:33.205] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:33.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:46:0) after 1m0s
[22:19:33.325] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:46:0)
[22:19:33.325] Timer tick, asking Buildbucket for the build status
[22:19:33.584] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:33.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:47:0) after 1m0s
[22:20:33.703] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:47:0)
[22:20:33.703] Timer tick, asking Buildbucket for the build status
[22:20:33.866] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:33.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:48:0) after 1m0s
[22:21:33.926] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:48:0)
[22:21:33.926] Timer tick, asking Buildbucket for the build status
[22:21:34.162] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:34.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:49:0) after 1m0s
[22:22:34.190] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:49:0)
[22:22:34.190] Timer tick, asking Buildbucket for the build status
[22:22:34.311] Build 8884276705438099104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:34.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049706767661727168:50:0) after 1m0s
[22:22:55.043] Received PubSub notification, asking Buildbucket for the build status
[22:22:55.221] Build 8884276705438099104: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:22:55.221] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585693374137576",
"created_by": "project:chromium",
"created_ts": "1585690508385534",
"id": "8884276705438099104",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"112eca96640298981d9f2491bf7b04f24fbc1ad7\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-2-kh5a\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 170457, \"got_angle_revision\": \"06f4f3e13c49e0c879d6479f940d0f26b5faa190\", \"got_dawn_revision\": \"7982cc0527630f123bd844cf5bb97ad0c3e0041c\", \"got_nacl_revision\": \"ebf11aaad97fde7f91b1c72e0dddaf1653d41f77\", \"got_revision\": \"112eca96640298981d9f2491bf7b04f24fbc1ad7\", \"got_revision_cp\": \"refs/heads/master@{#755122}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"5cf1e9a31c90ccd9ec40d0c5ef1357f6e0ec1cfd\", \"got_v8_revision\": \"3acfab72626ef49ba5977bd1c27f80ba012a1ac8\", \"got_v8_revision_cp\": \"refs/heads/8.3.108@{#1}\", \"got_webrtc_revision\": \"4b425aeef9cded872488aea32aa5d711be43b935\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30947}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"112eca96640298981d9f2491bf7b04f24fbc1ad7\", \"swarm_hashes_refs/heads/master(at){#755122}_without_patch\": {\"accessibility_unittests\": \"557296062e0466054b72d416de6d7a9d1a5481f4\", \"angle_unittests\": \"85218a6c207257304b6a1977bf9279c84b4cb3e1\", \"app_shell_unittests\": \"063eeba98d12f341f9852611918363956e041fa9\", \"aura_unittests\": \"dadc67c3b651609a7b5d20ee05d65a4c67c4c52e\", \"base_unittests\": \"af390e4f693d9e47f6ab53275a3b75deddeedeaa\", \"base_util_unittests\": \"aa168aed0620feb66cc25c412ee41bd8c2b8c92f\", \"blink_common_unittests\": \"ae22a0b59beb2273055bf3295851e972de7d38cd\", \"blink_fuzzer_unittests\": \"d292a67ba786aee21bd9667a31fe4ef47d3b7e7b\", \"blink_heap_unittests\": \"5c8fff83b5a440929c13076dc27d7e7160769678\", \"blink_platform_unittests\": \"9bbc31a5c2626d59bdb7d580fcf4169534b2c442\", \"blink_python_tests\": \"9c8bd2b8ce37632207ecd8228637ab736075a8c3\", \"blink_unittests\": \"2b6e8324a0bdefde7ab6c37611e3c5a07c3b1631\", \"blink_web_tests\": \"c99bc463a40718126f0288055ce7bfb88909fe1e\", \"boringssl_crypto_tests\": \"7f9de850b7a5ab0a1a93e604f5d889b9f14f5d0f\", \"boringssl_ssl_tests\": \"e5af9e444d98d5bc5d744188388c7c0b410ed201\", \"browser_tests\": \"e005f9c234884827f846c3d371aa45054aa3f0c9\", \"cacheinvalidation_unittests\": \"4b98a4108bd5c5a7239303d5c57d91b7653536d1\", \"capture_unittests\": \"67ce8cad7af6e4f6d9480e68e8a9c1cd80a074a5\", \"cast_unittests\": \"8efa19a225bf0de3cdb0d68eaed5a76db7539915\", \"cc_unittests\": \"43abf696967dc113ef41e465e34675303bf576e0\", \"chrome_app_unittests\": \"4cd9198c549f9c23d29cd31de515a02196aa1fa2\", \"chromedriver_unittests\": \"03c92445a3de0c8216d060e3acc15f937a3d24ff\", \"components_browsertests\": \"dacac16e2f4bc21aead9a77697108cf3cb569e32\", \"components_unittests\": \"0df1b29f72dfdf9f55748bdd06f851fee13f8f8c\", \"compositor_unittests\": \"d9b9585f829b2a1f08f65f6fcfbba76aa162c6d4\", \"content_browsertests\": \"14c5633e2faa9beb14828b82a8160b9715195d83\", \"content_shell_crash_test\": \"61e3490b615bfdef096e44d2cfa88e09cb30190c\", \"content_unittests\": \"3b6a7c47fe7f6830f720333bd690b421884678fd\", \"crashpad_tests\": \"a2efbc72fd8023030a5d0d81fffe268ea5dcb6f1\", \"cronet_tests\": \"09e25f77b4e7e6706f149c9dcb5904427b1774b6\", \"cronet_unittests\": \"d1400be6ba34361f5c5fa2ff67300bf665a671c6\", \"crypto_unittests\": \"01fb1a1abb8111b04c565b84b4f757843a93dfbe\", \"dbus_unittests\": \"f6694760e0c2f4c8e47f019b18e0557d1cf0f837\", \"device_unittests\": \"e6b11c762197b2ffdda7c057e7f1688d774d2181\", \"display_unittests\": \"64bbe4494b2a49b018007bf4259d4f6c1d420a97\", \"events_unittests\": \"6fe18a1eb971e0698fa1a6a96a5424d626f487c0\", \"extensions_browsertests\": \"9ab26ef6d4e913620ef11fea15b88a421778881e\", \"extensions_unittests\": \"985bd2f75f368ffe0acd09b9e796cbd5e973252c\", \"filesystem_service_unittests\": \"3f5ee6b7430ae35e410ffc71acd386d299e25526\", \"flatbuffers_unittests\": \"72ac4f314db80fab790f3135fe10fde26e7da08e\", \"gcm_unit_tests\": \"54b0287f885a24482a6b6c3a34151465bbc892d1\", \"gfx_unittests\": \"e5fd1ea73a6c3b747bd6f8b2a1ba7b627044599b\", \"gin_unittests\": \"aaab591e5cc6d25af75434cfd60feef8c281c875\", \"google_apis_unittests\": \"5b3ac4bd95164cf5e821fd70e857e921cc6d923d\", \"gpu_unittests\": \"88e68cdd2bbcabcf9982d387c14773aa2fe7d8ca\", \"grit_python_unittests\": \"8c3aba08684a4851b7eb5e55316c1cdda2ef1701\", \"gwp_asan_unittests\": \"7fcb45f548716cbce47e24453b5ba0f5d141df9a\", \"headless_browsertests\": \"1cd3ed2d377279228b8d1f2a80211a599034798a\", \"headless_unittests\": \"063ee077357ad9e77af6b10ad204934369990630\", \"interactive_ui_tests\": \"a22070c1605ec7f17bc76cdce1a12a427422290c\", \"ipc_tests\": \"33a64a2e620daa1f5c42e3dee35a93afe8fc81aa\", \"jingle_unittests\": \"7e24ad345efa9abafdc7aad96ac61bf21b9e8339\", \"latency_unittests\": \"0e609fdbf153cadadd517bdaf6fae4e0da8bd08e\", \"libjingle_xmpp_unittests\": \"1237258323ac45a5926dd16d5df707fab3d1bb34\", \"media_blink_unittests\": \"a78f414181cdd2992b02c05b52cfc4d63969cfaa\", \"media_unittests\": \"4a1f26cb7554ac5d57afb0abd46ace0641eb0a4a\", \"message_center_unittests\": \"2240765d1bb73e2facef2375e587efb1ee5500f6\", \"metrics_python_tests\": \"c332d2eacfc8b27719e113ac8a0c2efa230888ec\", \"midi_unittests\": \"28b55dace835a07fb4fc575ee6f1ed3d70faa0bb\", \"mojo_core_unittests\": \"a2d2adecc2912703773d43f71893ff8473bb538e\", \"mojo_unittests\": \"9c2b866b7c5f20c21fe21f5de6f599c02198c6bf\", \"nacl_helper_nonsfi_unittests\": \"b76ca1a9a4cc6814463e5ff06938323884c46f24\", \"nacl_loader_unittests\": \"7300882ac93272a79d4bd4f567921c1659f219ec\", \"native_theme_unittests\": \"df12b9a0c474a7b9775f87bcaf9180b2d72450f8\", \"net_unittests\": \"a754c20cc9c20d49507a903902a0c19597918987\", \"pdf_unittests\": \"c60836574b160fef11fa49c0692bc7db2dff22fa\", \"perfetto_unittests\": \"289332789e032dbb9c62a786f4da82fc537ec458\", \"ppapi_unittests\": \"ae9b969fe8aacdbcb284020a41a8dfdd3bc29211\", \"printing_unittests\": \"475a13deabf48b677b1b66a0e70b810653f37b68\", \"remoting_unittests\": \"4ef72bf43fa05b4ff117c29451ab1ec2b12e252c\", \"sandbox_linux_unittests\": \"715be64a56dfd17827caf23449d6d87e31f55468\", \"service_manager_unittests\": \"82a1098ea258e2bda684e43348ecbb732459c02d\", \"services_unittests\": \"dc5399d174b558ba184ed0ca0ed89b53786a7536\", \"shell_dialogs_unittests\": \"ff6508aa1ed139c63b244837153b627e8a0efd80\", \"skia_unittests\": \"5bd71167d52e75b7989d71c11fe26c0d4db4e147\", \"snapshot_unittests\": \"93f4a0fa22464544b7b589693ad66169e6feed6e\", \"sql_unittests\": \"960f5c99863029dbc2ca51b21270a61b460efca3\", \"storage_unittests\": \"0694d43535c388d32b1b764b4b1e4fc4f46e13f3\", \"sync_integration_tests\": \"e9277408ad0efe15523e2f4035762083e45cc9b9\", \"telemetry_gpu_unittests\": \"24140838220a8a4d4c932483e0213c75f9a86bff\", \"telemetry_perf_unittests\": \"8e6a426c4412075f595c26aa55df7ca9faffab6b\", \"telemetry_unittests\": \"2357dd447567235b7bda0cb5d5d00191948be16a\", \"traffic_annotation_auditor_unittests\": \"2affaa8adc310f9b30081601af425256173749fd\", \"ui_base_unittests\": \"dac61c1ce5cb38bf9f1f8f7823d7e2186bd64a1b\", \"ui_touch_selection_unittests\": \"f38b07c9e559b3b8f0cc489b270cbdcc647b3122\", \"unit_tests\": \"8b1ab1d131db3ff605603d7a3deb6d739384ebea\", \"url_unittests\": \"e480a0beeb3d8dbaaefd7a18eb76496ec74c28aa\", \"views_perftests\": \"262d1330e45b3f4f1e7b2c6b3780db0688bb76d7\", \"views_unittests\": \"9cec983689a4e5b5e722dbcaf5fded46fa0dc431\", \"viz_unittests\": \"39e869c2b90e4d99d8b93915113f606abafad6c2\", \"vr_common_unittests\": \"90beebfa96924491e42fe505097d47cdf3cdc780\", \"vr_pixeltests\": \"b865dd99687bbd52fd428fa56c56ddc8631a3a33\", \"webdriver_wpt_tests\": \"eff33e7df7b46dd99173ed5f27f2d2ae907c57f2\", \"weblayer_browsertests\": \"f823bf6f982b33d770aefff4dfee06ef39c03664\", \"wm_unittests\": \"1bf49ae8c505d11ab46f7d5f6d6d92ddd074e1b4\", \"wtf_unittests\": \"6a6ed4bed58bab138df6fcb6cb3d6d72390318c9\", \"xr_browser_tests\": \"4b2033528fd3601af846b2a4defdecf63b464e1a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1313787165392eb219c57f145b1b9e0fbbb62d544385caa60e27617303515107_v2\", \"builder_578c225c2c50d5653cce8ddfaab266952737b31d66b6113fbb64cc6f5229aebd_v2\", \"builder_a050691f36f3646c8cc368108f8edcf844a0d1683dc4a3731c64b1c7527ccb94_v2\", \"builder_d0ba3cd99c36b697d8651140d51bf4b4f4b9cd9aa25af11363af5ede5f6e35b1_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-2-kh5a\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"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\": [\"4910-0007b8d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585690798092070",
"status": "COMPLETED",
"status_changed_ts": "1585693374557473",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170457",
"builder:Linux Builder (dbg)",
"buildset:commit/git/112eca96640298981d9f2491bf7b04f24fbc1ad7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/112eca96640298981d9f2491bf7b04f24fbc1ad7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9049706767661727168",
"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/8884276705438099104/+/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:4b4b568add7bfd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1585693374579729",
"url": "https://ci.chromium.org/b/8884276705438099104",
"utcnow_ts": "1585693375209206"
}
}
[22:22:55.221] Invocation finished in 47m48.339772815s with status SUCCEEDED