[17:43:20.826] New invocation is queued and will start shortly
[17:43:22.522] Starting the invocation (attempt 1)
[17:43:22.586] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:43:22.586] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:43:22.586] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052801646096574912",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cf95a282fc61756e28716e9161f7633c16d2c260\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052801646096574912",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/cf95a282fc61756e28716e9161f7633c16d2c260",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cf95a282fc61756e28716e9161f7633c16d2c260",
"gitiles_ref:refs/heads/master"
]
}
[17:43:24.264] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582739002842553",
"id": "8887371583314414592",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cf95a282fc61756e28716e9161f7633c16d2c260\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582739003985444",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169055",
"builder:Linux Builder (dbg)",
"buildset:commit/git/cf95a282fc61756e28716e9161f7633c16d2c260",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cf95a282fc61756e28716e9161f7633c16d2c260",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052801646096574912",
"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/8887371583314414592/+/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": "1582739003985557",
"url": "https://ci.chromium.org/b/8887371583314414592",
"utcnow_ts": "1582739004245855"
}
}
[17:43:24.264] Task URL: https://ci.chromium.org/b/8887371583314414592
[17:43:24.264] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:2:0) after 1m0s
[17:44:24.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:2:0)
[17:44:24.305] Timer tick, asking Buildbucket for the build status
[17:44:24.403] Build 8887371583314414592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:44:24.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:3:0) after 1m0s
[17:45:24.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:3:0)
[17:45:24.497] Timer tick, asking Buildbucket for the build status
[17:45:24.655] Build 8887371583314414592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:45:24.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:4:0) after 1m0s
[17:46:24.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:4:0)
[17:46:24.710] Timer tick, asking Buildbucket for the build status
[17:46:24.974] Build 8887371583314414592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:46:24.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:5:0) after 1m0s
[17:47:25.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:5:0)
[17:47:25.027] Timer tick, asking Buildbucket for the build status
[17:47:25.260] Build 8887371583314414592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:47:25.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:6:0) after 1m0s
[17:48:02.898] Received PubSub notification, asking Buildbucket for the build status
[17:48:02.976] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:25.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:6:0)
[17:48:25.338] Timer tick, asking Buildbucket for the build status
[17:48:25.445] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:25.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:8:0) after 1m0s
[17:49:25.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:8:0)
[17:49:25.462] Timer tick, asking Buildbucket for the build status
[17:49:25.561] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:25.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:9:0) after 1m0s
[17:50:25.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:9:0)
[17:50:25.561] Timer tick, asking Buildbucket for the build status
[17:50:25.897] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:25.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:10:0) after 1m0s
[17:51:26.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:10:0)
[17:51:26.003] Timer tick, asking Buildbucket for the build status
[17:51:26.194] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:26.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:11:0) after 1m0s
[17:52:26.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:11:0)
[17:52:26.222] Timer tick, asking Buildbucket for the build status
[17:52:27.375] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:27.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:12:0) after 1m0s
[17:53:27.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:12:0)
[17:53:27.433] Timer tick, asking Buildbucket for the build status
[17:53:27.672] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:27.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:13:0) after 1m0s
[17:54:27.798] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:13:0)
[17:54:27.798] Timer tick, asking Buildbucket for the build status
[17:54:28.017] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:28.017] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:14:0) after 1m0s
[17:55:28.243] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:14:0)
[17:55:28.243] Timer tick, asking Buildbucket for the build status
[17:55:29.517] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:29.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:15:0) after 1m0s
[17:56:29.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:15:0)
[17:56:29.580] Timer tick, asking Buildbucket for the build status
[17:56:29.696] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:29.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:16:0) after 1m0s
[17:57:29.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:16:0)
[17:57:29.792] Timer tick, asking Buildbucket for the build status
[17:57:29.958] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:29.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:17:0) after 1m0s
[17:58:30.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:17:0)
[17:58:30.015] Timer tick, asking Buildbucket for the build status
[17:58:30.339] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:30.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:18:0) after 1m0s
[17:59:30.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:18:0)
[17:59:30.535] Timer tick, asking Buildbucket for the build status
[17:59:30.892] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:30.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:19:0) after 1m0s
[18:00:31.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:19:0)
[18:00:31.003] Timer tick, asking Buildbucket for the build status
[18:00:32.589] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:32.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:20:0) after 1m0s
[18:01:32.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:20:0)
[18:01:32.626] Timer tick, asking Buildbucket for the build status
[18:01:32.789] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:32.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:21:0) after 1m0s
[18:02:33.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:21:0)
[18:02:33.009] Timer tick, asking Buildbucket for the build status
[18:02:33.229] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:33.232] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:22:0) after 1m0s
[18:03:33.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:22:0)
[18:03:33.364] Timer tick, asking Buildbucket for the build status
[18:03:33.466] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:33.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:23:0) after 1m0s
[18:04:33.515] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:23:0)
[18:04:33.515] Timer tick, asking Buildbucket for the build status
[18:04:33.610] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:33.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:24:0) after 1m0s
[18:05:33.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:24:0)
[18:05:33.609] Timer tick, asking Buildbucket for the build status
[18:05:33.996] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:33.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:25:0) after 1m0s
[18:06:34.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:25:0)
[18:06:34.092] Timer tick, asking Buildbucket for the build status
[18:06:34.358] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:34.358] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:26:0) after 1m0s
[18:07:34.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:26:0)
[18:07:34.369] Timer tick, asking Buildbucket for the build status
[18:07:34.495] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:34.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:27:0) after 1m0s
[18:08:34.583] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:27:0)
[18:08:34.583] Timer tick, asking Buildbucket for the build status
[18:08:34.694] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:34.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:28:0) after 1m0s
[18:09:34.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:28:0)
[18:09:34.729] Timer tick, asking Buildbucket for the build status
[18:09:34.903] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:34.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:29:0) after 1m0s
[18:10:34.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:29:0)
[18:10:34.923] Timer tick, asking Buildbucket for the build status
[18:10:35.286] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:35.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:30:0) after 1m0s
[18:11:35.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:30:0)
[18:11:35.388] Timer tick, asking Buildbucket for the build status
[18:11:35.480] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:35.480] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:31:0) after 1m0s
[18:12:35.486] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:31:0)
[18:12:35.486] Timer tick, asking Buildbucket for the build status
[18:12:35.642] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:35.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:32:0) after 1m0s
[18:13:35.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:32:0)
[18:13:35.791] Timer tick, asking Buildbucket for the build status
[18:13:35.949] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:35.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:33:0) after 1m0s
[18:14:36.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:33:0)
[18:14:36.032] Timer tick, asking Buildbucket for the build status
[18:14:36.183] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:36.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:34:0) after 1m0s
[18:15:36.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:34:0)
[18:15:36.241] Timer tick, asking Buildbucket for the build status
[18:15:36.362] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:36.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:35:0) after 1m0s
[18:16:36.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:35:0)
[18:16:36.387] Timer tick, asking Buildbucket for the build status
[18:16:36.510] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:36.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:36:0) after 1m0s
[18:17:36.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:36:0)
[18:17:36.589] Timer tick, asking Buildbucket for the build status
[18:17:37.004] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:37.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:37:0) after 1m0s
[18:18:37.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:37:0)
[18:18:37.091] Timer tick, asking Buildbucket for the build status
[18:18:37.207] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:37.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:38:0) after 1m0s
[18:19:37.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:38:0)
[18:19:37.245] Timer tick, asking Buildbucket for the build status
[18:19:37.403] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:37.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:39:0) after 1m0s
[18:20:37.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:39:0)
[18:20:37.458] Timer tick, asking Buildbucket for the build status
[18:20:37.583] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:37.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:40:0) after 1m0s
[18:21:37.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:40:0)
[18:21:37.622] Timer tick, asking Buildbucket for the build status
[18:21:37.745] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:37.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:41:0) after 1m0s
[18:22:37.733] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:41:0)
[18:22:37.733] Timer tick, asking Buildbucket for the build status
[18:22:37.845] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:37.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:42:0) after 1m0s
[18:23:37.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:42:0)
[18:23:37.927] Timer tick, asking Buildbucket for the build status
[18:23:38.674] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:38.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:43:0) after 1m0s
[18:24:38.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:43:0)
[18:24:38.698] Timer tick, asking Buildbucket for the build status
[18:24:38.890] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:38.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:44:0) after 1m0s
[18:25:40.340] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:44:0)
[18:25:40.340] Timer tick, asking Buildbucket for the build status
[18:25:40.465] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:40.465] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:45:0) after 1m0s
[18:26:41.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:45:0)
[18:26:41.348] Timer tick, asking Buildbucket for the build status
[18:26:41.510] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:41.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:46:0) after 1m0s
[18:27:41.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:46:0)
[18:27:41.978] Timer tick, asking Buildbucket for the build status
[18:27:42.101] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:42.101] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:47:0) after 1m0s
[18:28:42.349] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:47:0)
[18:28:42.349] Timer tick, asking Buildbucket for the build status
[18:28:42.463] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:42.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:48:0) after 1m0s
[18:29:42.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:48:0)
[18:29:42.694] Timer tick, asking Buildbucket for the build status
[18:29:43.181] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:43.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:49:0) after 1m0s
[18:30:43.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:49:0)
[18:30:43.302] Timer tick, asking Buildbucket for the build status
[18:30:44.559] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:44.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:50:0) after 1m0s
[18:31:44.831] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:50:0)
[18:31:44.831] Timer tick, asking Buildbucket for the build status
[18:31:44.954] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:44.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:51:0) after 1m0s
[18:32:45.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:51:0)
[18:32:45.105] Timer tick, asking Buildbucket for the build status
[18:32:45.237] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:45.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:52:0) after 1m0s
[18:33:45.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:52:0)
[18:33:45.432] Timer tick, asking Buildbucket for the build status
[18:33:45.545] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:45.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:53:0) after 1m0s
[18:34:45.646] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:53:0)
[18:34:45.646] Timer tick, asking Buildbucket for the build status
[18:34:45.846] Build 8887371583314414592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:45.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052801646096574912:54:0) after 1m0s
[18:35:10.752] Received PubSub notification, asking Buildbucket for the build status
[18:35:11.095] Build 8887371583314414592: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:35:11.095] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582742109911699",
"created_by": "project:chromium",
"created_ts": "1582739002842553",
"id": "8887371583314414592",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cf95a282fc61756e28716e9161f7633c16d2c260\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-29-42gl\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169055, \"got_angle_revision\": \"de3b97eb1f52349eddfe81fa8cff91db378860a1\", \"got_dawn_revision\": \"a9d7d478429d8deaac52a0578826783877cd556a\", \"got_nacl_revision\": \"021c8b6784ea41113fe6d54f36359a0c329a5cc5\", \"got_revision\": \"cf95a282fc61756e28716e9161f7633c16d2c260\", \"got_revision_cp\": \"refs/heads/master@{#744707}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"da659b3741132fe6a6904e45d96112eef776bc28\", \"got_v8_revision\": \"6426a06cf8e7fd93c3cc5391a9a4a17ed1fe1403\", \"got_v8_revision_cp\": \"refs/heads/8.2.191@{#1}\", \"got_webrtc_revision\": \"c310889ec79167896e1d7b4b401c397fe1f51032\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30616}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cf95a282fc61756e28716e9161f7633c16d2c260\", \"swarm_hashes_refs/heads/master(at){#744707}_without_patch\": {\"accessibility_unittests\": \"0703bc285a415184c43e2716cf641250d1184736\", \"angle_unittests\": \"33bf1ca59c566e97817b0548b81958782aba1f3e\", \"app_shell_unittests\": \"19ed29c769544553755327cf0be0f1d01d51d53a\", \"aura_unittests\": \"7c05d87e83b36dea257387439ed4bc73b9f9530f\", \"base_unittests\": \"492dcc8bc1f875322648fc4e6128f88d08948a68\", \"base_util_unittests\": \"f2a3e5fe02659a290668e9eddbfa56387c9496c4\", \"blink_common_unittests\": \"ef3836fb062d2fed4411b2574b7f5ae521fabc4d\", \"blink_fuzzer_unittests\": \"9bda3831193a4db509da720c99390bc7869206d4\", \"blink_heap_unittests\": \"eb1dadae8cf38c3a8fee55056a0c87f571e654ca\", \"blink_platform_unittests\": \"a04e45b2b5e77404ef9199d1ab636f03842457e8\", \"blink_python_tests\": \"74ff0d17c71028fbb82c5c36254c9544b89ea31d\", \"blink_unittests\": \"5d142121f7433a3219ba727d340343821f6aee34\", \"blink_web_tests\": \"326b006c4ec3e52d373ba7e30984011c26551094\", \"boringssl_crypto_tests\": \"645c02bf39dae19547f5513dc91cf3121f370bc5\", \"boringssl_ssl_tests\": \"680b545f58a53d5f14df6792969b6bf4226f2cd6\", \"browser_tests\": \"760dcdf1a90964ac303139145382332c1026a2d4\", \"cacheinvalidation_unittests\": \"0340a0ffea3aa6050f1283cc35b9bae0ae565951\", \"capture_unittests\": \"df33517e27bce6f7347b68eedc56ff02953251ad\", \"cast_unittests\": \"361cb34ca8a2fa2b80c6348098d4aa0136875cfb\", \"cc_unittests\": \"d6d41365ce27e8b2e1ecc688e78d7238eb08250d\", \"chrome_app_unittests\": \"d33961857ca347c040677f6fe0c8bd999a99a61a\", \"chromedriver_unittests\": \"9f680483e2dd344ec8bfa81765740df193ad72c4\", \"components_browsertests\": \"4f82d68fa2f30d4c05e88956c94b3ead6a610d5c\", \"components_unittests\": \"669265205c2e1d81f53f273a6985ca50de1fc553\", \"compositor_unittests\": \"2267ede9559fca120c0a8b5a62cd54e6bcaee40a\", \"content_browsertests\": \"bf01c2744a3e66f653c790de795e6b56d2e552e0\", \"content_shell_crash_test\": \"6e22efe236f8be1726f6c5d32ceaab33c8651510\", \"content_unittests\": \"61b4379dbac0854aadec0edf7e283b17ed229959\", \"crashpad_tests\": \"52335fcbe2846a4f04c4973574ff2c35ba7695f4\", \"cronet_tests\": \"f2a047db0ea8768a9b12e206c6bfaf5d7275a00c\", \"cronet_unittests\": \"08c8c042264f0747b62eb94ebb627ab89f27a73f\", \"crypto_unittests\": \"4209ffb1829140412c01b5fb5dfc9db66cdc5a64\", \"dbus_unittests\": \"a1faf5babb02551015ccba38832091bca700a399\", \"device_unittests\": \"975a04520111357cd8e341362f809d6dc4207fb4\", \"display_unittests\": \"a68ada64d5be664a575b7a394512103e2e077428\", \"events_unittests\": \"ae4d43af51705149c72adfab512093964ebe128a\", \"extensions_browsertests\": \"81c3651aacb7bf2ae41a544c0dd6ea7658015b23\", \"extensions_unittests\": \"9313d84357e4b3716e5ff60cb3284e21580c24b4\", \"filesystem_service_unittests\": \"6d3c7c4ed81cec8c0b274c58123b72dbd57c9574\", \"flatbuffers_unittests\": \"fddfee5d9c5c5357203fa42dff8f3c357607bc22\", \"gcm_unit_tests\": \"c63c1deb17ae9deef4f0b1e94923a752e9839f26\", \"gfx_unittests\": \"8c904d6edfbb7addefb9d743fae04c02185d7873\", \"gin_unittests\": \"109e25c957928698d6d9f5c74ea39e3ce6379e6b\", \"google_apis_unittests\": \"ac4bd90afd0823086ba570938260eec5874315a5\", \"gpu_unittests\": \"bdab411f90b74b1be3d9802d89e285960e75905d\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"f9931a1c16bf0385d9a1e68694ebb3efa12b0be6\", \"headless_browsertests\": \"42616f3de0a38defc9c2baf08ca0742a637ba06a\", \"headless_unittests\": \"9113d56901f7bf12f1af579214f2f75846185ce7\", \"interactive_ui_tests\": \"899b6757b80633f20d7032eb23f9c49dfd61d93d\", \"ipc_tests\": \"f1a2cb44afda1051d237f6be9ea13d977fe1c62b\", \"jingle_unittests\": \"05f73a1e02963f2a2fa256be608563a162b0b911\", \"latency_unittests\": \"9ad37f9e00214aa113e6cf35405b118a9dcc4d61\", \"libjingle_xmpp_unittests\": \"a6192510b48e78dd082342f38a435fd829dc0607\", \"media_blink_unittests\": \"b8fb9af4f8f05754aaa5bda38ee552cdf2321e00\", \"media_service_unittests\": \"4ba7beb24685e64424b97531d10b2138cc36cedd\", \"media_unittests\": \"625c54b0a18056ebe27880d3b30888249439a359\", \"message_center_unittests\": \"c136e68e9800270e7fb7e648e67710ea2884dc42\", \"metrics_python_tests\": \"cd05a0f4210d90821b48b50eeb401b7e9b62aed5\", \"midi_unittests\": \"8da7a23acfffaf23aa7621f306996f5aeac9e0f3\", \"mojo_core_unittests\": \"953585c2f57192662f99728ee99ea3dc1d04f9f7\", \"mojo_unittests\": \"7f780125a35074f33446c4e7b94c35dde813c3ad\", \"nacl_helper_nonsfi_unittests\": \"f2e81d6cb41bb06d2bdca4a2ed0d77f22a887857\", \"nacl_loader_unittests\": \"27617df95eed61d33a1c928f71db5e075a6e845c\", \"native_theme_unittests\": \"d32ecf973f55eb63d3e54a6f14bb3452b810790e\", \"net_unittests\": \"c40d8275af0f313ca336ae64067a9e2a051e3e6c\", \"pdf_unittests\": \"1e352b31fbb6657d4cacf79c58ba9a9bfb1378cb\", \"perfetto_unittests\": \"a342937254cacf69269a4fc2c69c97c27ac25a92\", \"ppapi_unittests\": \"11f506c51d72d93abe0e4423e78eddce6e1f7a20\", \"printing_unittests\": \"a1248c5afbfff34796aab22e117e8bf895d924c0\", \"remoting_unittests\": \"9f3ce9405d5060c7dc451f0381b4a32e1e2b0046\", \"sandbox_linux_unittests\": \"982bef5f630b96d488bb8d52d6c3a0af9d30a657\", \"service_manager_unittests\": \"6bfe8f02823d77e20bda7ff38777f71b84b23549\", \"services_unittests\": \"190ba841b3c8d010746ad1be3b37c4b7619932ed\", \"shell_dialogs_unittests\": \"c79250e387dd560a002d18ab9e84763e8a142867\", \"skia_unittests\": \"89a3b4767fd771cba8a014cfb5c9ae78bf32fdb4\", \"snapshot_unittests\": \"26deb1f078a74025163799d23bd573e33d572ffc\", \"sql_unittests\": \"3e3bc20e2d831bae044cd01f0f80041320572d1e\", \"storage_unittests\": \"872e1696b2fb86231ce6128a1718e083f6ace36c\", \"sync_integration_tests\": \"91e86094fd74bdbea379a35154b771031481d1fd\", \"telemetry_gpu_unittests\": \"1a76a6af7196486868411002f9a54bc2c9b21bf3\", \"telemetry_perf_unittests\": \"840607bf8ad7e936a3df0127dab414cd0c316d3a\", \"telemetry_unittests\": \"dd845581a2a7a490dff6c6b32944c5957001c958\", \"traffic_annotation_auditor_unittests\": \"7bac54b8d589cf726834e4c483137365f97bf2dd\", \"ui_base_unittests\": \"4837a3020d556208d54bd62aaa25efc0f81d2d9a\", \"ui_touch_selection_unittests\": \"42016652deede864cfc4810d57f6e7274048a1bf\", \"unit_tests\": \"a8fde4e1c8fc580f1b7b63bb6937d4d18c19d4d6\", \"url_unittests\": \"a711942ec9b26ca224d2f0bbe5959c5e85e2f674\", \"views_perftests\": \"414994a32a90ae9f69532c8205843e81f20dc411\", \"views_unittests\": \"8d3fb7c98440d2f2231e0ca3a319c9fa287b01a8\", \"viz_unittests\": \"3f1b029f9eabdb9fbb8830771b5eff2f9f2eee93\", \"vr_common_unittests\": \"0a645d9aa0949811b1c52cf4f951959ad8ee1bf1\", \"vr_pixeltests\": \"e0ed0dddbde7501a970646313508335c06d865f0\", \"webdriver_wpt_tests\": \"4b80b76dbeeb5fe3d2155be181a9ba9d3367df68\", \"weblayer_browsertests\": \"3e4b291f42e74a2db1cb01525ff9871cf5a78710\", \"wm_unittests\": \"8efed243007929ce37a0214933e79c341ca978b1\", \"wtf_unittests\": \"6bffdeb5bfa523f4cba826a2ca87005a57208d0f\", \"xr_browser_tests\": \"e1bb050c36f10586a9cb9cb240b6d66134ed18b1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_51603c189459d949c9f9b05c6193f37cd30704e77931c7dc651854102fbe3f3d_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-29-42gl\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4838-b69615e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582739281886067",
"status": "COMPLETED",
"status_changed_ts": "1582742110397783",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169055",
"builder:Linux Builder (dbg)",
"buildset:commit/git/cf95a282fc61756e28716e9161f7633c16d2c260",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cf95a282fc61756e28716e9161f7633c16d2c260",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052801646096574912",
"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/8887371583314414592/+/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:4a9b6a238e4c8710",
"user_agent:luci-scheduler"
],
"updated_ts": "1582742110402010",
"url": "https://ci.chromium.org/b/8887371583314414592",
"utcnow_ts": "1582742111075837"
}
}
[18:35:11.095] Invocation finished in 51m50.2907327s with status SUCCEEDED