[16:14:08.402] New invocation is queued and will start shortly
[16:14:09.698] Starting the invocation (attempt 1)
[16:14:09.772] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:14:09.772] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:14:09.772] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9055162779648105392",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"06429d8bab6a30c59d1474ac8c1411a2fbc44e3d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9055162779648105392",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/06429d8bab6a30c59d1474ac8c1411a2fbc44e3d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/06429d8bab6a30c59d1474ac8c1411a2fbc44e3d",
"gitiles_ref:refs/heads/master"
]
}
[16:14:11.081] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1580487250113482",
"id": "8889732717183364912",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"06429d8bab6a30c59d1474ac8c1411a2fbc44e3d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580487250771449",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168085",
"builder:Linux Builder (dbg)",
"buildset:commit/git/06429d8bab6a30c59d1474ac8c1411a2fbc44e3d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/06429d8bab6a30c59d1474ac8c1411a2fbc44e3d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055162779648105392",
"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/8889732717183364912/+/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": "1580487250771594",
"url": "https://ci.chromium.org/b/8889732717183364912",
"utcnow_ts": "1580487251064597"
}
}
[16:14:11.081] Task URL: https://ci.chromium.org/b/8889732717183364912
[16:14:11.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:2:0) after 1m0s
[16:15:11.197] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:2:0)
[16:15:11.197] Timer tick, asking Buildbucket for the build status
[16:15:11.671] Build 8889732717183364912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:15:11.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:3:0) after 1m0s
[16:16:11.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:3:0)
[16:16:11.771] Timer tick, asking Buildbucket for the build status
[16:16:12.680] Build 8889732717183364912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:16:12.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:4:0) after 1m0s
[16:17:12.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:4:0)
[16:17:12.732] Timer tick, asking Buildbucket for the build status
[16:17:12.912] Build 8889732717183364912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:17:12.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:5:0) after 1m0s
[16:18:12.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:5:0)
[16:18:12.978] Timer tick, asking Buildbucket for the build status
[16:18:13.195] Build 8889732717183364912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:18:13.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:6:0) after 1m0s
[16:19:08.231] Received PubSub notification, asking Buildbucket for the build status
[16:19:08.669] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:13.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:6:0)
[16:19:13.247] Timer tick, asking Buildbucket for the build status
[16:19:13.716] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:13.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:8:0) after 1m0s
[16:20:13.812] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:8:0)
[16:20:13.812] Timer tick, asking Buildbucket for the build status
[16:20:14.328] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:14.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:9:0) after 1m0s
[16:21:14.348] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:9:0)
[16:21:14.348] Timer tick, asking Buildbucket for the build status
[16:21:14.714] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:14.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:10:0) after 1m0s
[16:22:14.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:10:0)
[16:22:14.743] Timer tick, asking Buildbucket for the build status
[16:22:14.884] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:14.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:11:0) after 1m0s
[16:23:14.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:11:0)
[16:23:14.927] Timer tick, asking Buildbucket for the build status
[16:23:15.408] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:15.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:12:0) after 1m0s
[16:24:15.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:12:0)
[16:24:15.442] Timer tick, asking Buildbucket for the build status
[16:24:16.114] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:16.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:13:0) after 1m0s
[16:25:16.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:13:0)
[16:25:16.173] Timer tick, asking Buildbucket for the build status
[16:25:16.343] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:16.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:14:0) after 1m0s
[16:26:16.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:14:0)
[16:26:16.607] Timer tick, asking Buildbucket for the build status
[16:26:17.471] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:17.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:15:0) after 1m0s
[16:27:17.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:15:0)
[16:27:17.568] Timer tick, asking Buildbucket for the build status
[16:27:17.732] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:17.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:16:0) after 1m0s
[16:28:17.788] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:16:0)
[16:28:17.788] Timer tick, asking Buildbucket for the build status
[16:28:18.431] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:18.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:17:0) after 1m0s
[16:29:18.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:17:0)
[16:29:18.498] Timer tick, asking Buildbucket for the build status
[16:29:18.652] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:18.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:18:0) after 1m0s
[16:30:18.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:18:0)
[16:30:18.671] Timer tick, asking Buildbucket for the build status
[16:30:19.335] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:19.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:19:0) after 1m0s
[16:31:19.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:19:0)
[16:31:19.443] Timer tick, asking Buildbucket for the build status
[16:31:19.761] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:19.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:20:0) after 1m0s
[16:32:19.867] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:20:0)
[16:32:19.867] Timer tick, asking Buildbucket for the build status
[16:32:20.063] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:20.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:21:0) after 1m0s
[16:33:20.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:21:0)
[16:33:20.159] Timer tick, asking Buildbucket for the build status
[16:33:20.344] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:20.344] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:22:0) after 1m0s
[16:34:20.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:22:0)
[16:34:20.468] Timer tick, asking Buildbucket for the build status
[16:34:21.341] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:21.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:23:0) after 1m0s
[16:35:21.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:23:0)
[16:35:21.379] Timer tick, asking Buildbucket for the build status
[16:35:21.618] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:21.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:24:0) after 1m0s
[16:36:21.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:24:0)
[16:36:21.875] Timer tick, asking Buildbucket for the build status
[16:36:22.133] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:22.133] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:25:0) after 1m0s
[16:37:22.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:25:0)
[16:37:22.238] Timer tick, asking Buildbucket for the build status
[16:37:22.456] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:22.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:26:0) after 1m0s
[16:38:22.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:26:0)
[16:38:22.512] Timer tick, asking Buildbucket for the build status
[16:38:23.761] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:23.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:27:0) after 1m0s
[16:39:23.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:27:0)
[16:39:23.885] Timer tick, asking Buildbucket for the build status
[16:39:24.015] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:24.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:28:0) after 1m0s
[16:40:24.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:28:0)
[16:40:24.074] Timer tick, asking Buildbucket for the build status
[16:40:24.425] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:24.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:29:0) after 1m0s
[16:41:24.515] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:29:0)
[16:41:24.515] Timer tick, asking Buildbucket for the build status
[16:41:24.801] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:24.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:30:0) after 1m0s
[16:42:24.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:30:0)
[16:42:24.888] Timer tick, asking Buildbucket for the build status
[16:42:25.486] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:25.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:31:0) after 1m0s
[16:43:25.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:31:0)
[16:43:25.534] Timer tick, asking Buildbucket for the build status
[16:43:26.633] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:26.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:32:0) after 1m0s
[16:44:26.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:32:0)
[16:44:26.667] Timer tick, asking Buildbucket for the build status
[16:44:27.194] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:27.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:33:0) after 1m0s
[16:45:27.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:33:0)
[16:45:27.296] Timer tick, asking Buildbucket for the build status
[16:45:27.508] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:27.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:34:0) after 1m0s
[16:46:27.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:34:0)
[16:46:27.951] Timer tick, asking Buildbucket for the build status
[16:46:28.061] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:28.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:35:0) after 1m0s
[16:47:28.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:35:0)
[16:47:28.166] Timer tick, asking Buildbucket for the build status
[16:47:28.462] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:28.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:36:0) after 1m0s
[16:48:33.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:36:0)
[16:48:33.872] Timer tick, asking Buildbucket for the build status
[16:48:34.208] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:34.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:37:0) after 1m0s
[16:49:35.246] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:37:0)
[16:49:35.246] Timer tick, asking Buildbucket for the build status
[16:49:37.304] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:37.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:38:0) after 1m0s
[16:50:37.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:38:0)
[16:50:37.395] Timer tick, asking Buildbucket for the build status
[16:50:37.530] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:37.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:39:0) after 1m0s
[16:51:37.656] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:39:0)
[16:51:37.656] Timer tick, asking Buildbucket for the build status
[16:51:37.907] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:37.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:40:0) after 1m0s
[16:52:38.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:40:0)
[16:52:38.105] Timer tick, asking Buildbucket for the build status
[16:52:38.679] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:38.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:41:0) after 1m0s
[16:53:38.770] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:41:0)
[16:53:38.770] Timer tick, asking Buildbucket for the build status
[16:53:38.903] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:38.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:42:0) after 1m0s
[16:54:38.995] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:42:0)
[16:54:38.995] Timer tick, asking Buildbucket for the build status
[16:54:39.227] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:39.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:43:0) after 1m0s
[16:55:39.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:43:0)
[16:55:39.372] Timer tick, asking Buildbucket for the build status
[16:55:39.830] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:39.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:44:0) after 1m0s
[16:56:39.914] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:44:0)
[16:56:39.914] Timer tick, asking Buildbucket for the build status
[16:56:40.063] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:40.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:45:0) after 1m0s
[16:57:40.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:45:0)
[16:57:40.138] Timer tick, asking Buildbucket for the build status
[16:57:40.560] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:40.560] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:46:0) after 1m0s
[16:58:40.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:46:0)
[16:58:40.597] Timer tick, asking Buildbucket for the build status
[16:58:41.054] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:41.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:47:0) after 1m0s
[16:59:41.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:47:0)
[16:59:41.116] Timer tick, asking Buildbucket for the build status
[16:59:41.349] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:41.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:48:0) after 1m0s
[17:00:41.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:48:0)
[17:00:41.608] Timer tick, asking Buildbucket for the build status
[17:00:42.076] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:42.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:49:0) after 1m0s
[17:01:42.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:49:0)
[17:01:42.167] Timer tick, asking Buildbucket for the build status
[17:01:42.559] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:42.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:50:0) after 1m0s
[17:02:42.594] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:50:0)
[17:02:42.595] Timer tick, asking Buildbucket for the build status
[17:02:42.899] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:42.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:51:0) after 1m0s
[17:03:42.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:51:0)
[17:03:42.978] Timer tick, asking Buildbucket for the build status
[17:03:43.193] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:43.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:52:0) after 1m0s
[17:04:43.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:52:0)
[17:04:43.262] Timer tick, asking Buildbucket for the build status
[17:04:43.505] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:43.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:53:0) after 1m0s
[17:05:43.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:53:0)
[17:05:43.534] Timer tick, asking Buildbucket for the build status
[17:05:43.763] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:43.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:54:0) after 1m0s
[17:06:43.827] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:54:0)
[17:06:43.827] Timer tick, asking Buildbucket for the build status
[17:06:43.995] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:43.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:55:0) after 1m0s
[17:07:44.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:55:0)
[17:07:44.072] Timer tick, asking Buildbucket for the build status
[17:07:44.296] Build 8889732717183364912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:44.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055162779648105392:56:0) after 1m0s
[17:08:25.580] Received PubSub notification, asking Buildbucket for the build status
[17:08:25.697] Build 8889732717183364912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:08:25.697] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1580490504415189",
"created_by": "project:chromium",
"created_ts": "1580487250113482",
"id": "8889732717183364912",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"06429d8bab6a30c59d1474ac8c1411a2fbc44e3d\"}}",
"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-east1-d-8-56-mwiu\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168085, \"got_angle_revision\": \"5de415c5e3f9616298f0d99d2f618e211870a8f2\", \"got_dawn_revision\": \"f44a809f9a3b6506df5cc1105198ed136c6b26ec\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"06429d8bab6a30c59d1474ac8c1411a2fbc44e3d\", \"got_revision_cp\": \"refs/heads/master@{#737336}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"79b36b640692e3b4561642c06ec36a9e02a1636c\", \"got_v8_revision\": \"a4dcd39d521d14c4b1cac020812e44ee04a7f244\", \"got_v8_revision_cp\": \"refs/heads/8.1.307@{#1}\", \"got_webrtc_revision\": \"bfe3ef8feb3b4e351403be38fe626df4e796648c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30435}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"06429d8bab6a30c59d1474ac8c1411a2fbc44e3d\", \"swarm_hashes_refs/heads/master(at){#737336}_without_patch\": {\"accessibility_unittests\": \"d842447e5a61eef3d94b9fea5f4def75572b7c17\", \"angle_unittests\": \"75b596a5d6b71ab6ad90bc48111b997ecd1638d1\", \"app_shell_unittests\": \"2f10c37c4964529a49f78c3ee359fd01a261a16b\", \"aura_unittests\": \"6baddb4313702df875c4154c09105d7fea885b9a\", \"base_unittests\": \"8b8110a51860bd3fd669c365dfbf5a7a611f64c4\", \"base_util_unittests\": \"ce3e6ed19f94230f71d7175c0b398c88dd2453bf\", \"blink_common_unittests\": \"aaa6db5896e07ccc3b4dae825f58f6880c0ed796\", \"blink_fuzzer_unittests\": \"2a5ac89bf7f4cee51ae81a04096a81b88d1013b2\", \"blink_heap_unittests\": \"2d8bcb3d6712603727e1d9641747f705de6a58a4\", \"blink_platform_unittests\": \"b0b6fefde166d69c9f8a2ee4413db36eac0287d3\", \"blink_python_tests\": \"f76255ac518af5d9061c207dfd6e9e9699166fc4\", \"blink_unittests\": \"e70771ec1b2ff12ae3f4fd2eeb16297eb3815bae\", \"blink_web_tests\": \"917c2c45e219cd1ffe33ca2373914b7830a4f869\", \"boringssl_crypto_tests\": \"e60cb206dad980bc52b20988ed60e4131e2b4f35\", \"boringssl_ssl_tests\": \"5e0ad996216b2fbe87837db91db7a680f3c59660\", \"browser_tests\": \"3bb7efcea9c04c4069ccc2f1066381ffcabf4774\", \"cacheinvalidation_unittests\": \"8cda9a5d4bc6e29d362e7e36ec7a48355bc69711\", \"capture_unittests\": \"4478e59776e5449e5ed0d9b7ea69f0241e108555\", \"cast_unittests\": \"ad5728109cd6232209d5d81a48b1df1c0950ee1a\", \"cc_unittests\": \"6b78838fb2c368f351ec95267f0e3e806c79ba4c\", \"chrome_app_unittests\": \"9a9c20049e19a05460608e2b7898a77849faffe6\", \"chromedriver_unittests\": \"6548b5b700665a472111251e7cc0516eb02ea40c\", \"components_browsertests\": \"37defc7770cdb9abe2bb104203ca501150b743f5\", \"components_unittests\": \"88c679b3ce9b1e0a9933c8b1def47944a0ca499c\", \"compositor_unittests\": \"e4707a0badb2d3ace7666e5e1ac8641565fe1a69\", \"content_browsertests\": \"55f6e54482755d43d883969dd91fd811569e99ee\", \"content_shell_crash_test\": \"cc095e572a5530809d41f1dc79fbed582904e2a9\", \"content_unittests\": \"4fc39b3bb484d0f89b87079bd407cb527f122d6d\", \"crashpad_tests\": \"bf46df26f6236024a65cfecfa6256268375935df\", \"cronet_tests\": \"6873cf04b046394774a8040d04745121534e497d\", \"cronet_unittests\": \"30a72fe105849495081c6409ac222e47af952bb2\", \"crypto_unittests\": \"8a1e1e6b52dcf033d0d8df7f986341d9e83994d6\", \"dbus_unittests\": \"5e2ee717f4e52ce942741215636e95bf05033af2\", \"device_unittests\": \"b469500b2256a4ed8d86dc728f4ae715280ad6c3\", \"display_unittests\": \"5929ff202f547acdc9883041c0aa0a3b78128a86\", \"events_unittests\": \"f49c3aa48336ca63ff4c2ef442ad75d940886a0e\", \"extensions_browsertests\": \"34ac299c2e531067c90a7c9ad0df467947bd4eb2\", \"extensions_unittests\": \"0fef181c6fe02561c6676b768b1b33801e0a769c\", \"filesystem_service_unittests\": \"b2198f782c1d4c56db995ca8f1d943a0ddeefcd0\", \"flatbuffers_unittests\": \"ca71348ce5934d53fb892115f8e6e8a2436d5e6c\", \"gcm_unit_tests\": \"7993bad1209bcd85b830959a998099a87048e284\", \"gfx_unittests\": \"9be5a35807cd7449b536a580a4686e738e23f931\", \"gin_unittests\": \"654cb6ee396be4cc6e9a3a77249e11bea9b71515\", \"google_apis_unittests\": \"233e6c4f8b40d918b2ca1b40a86c36187eaea98a\", \"gpu_unittests\": \"041dc9d41caa44815f24116714ce29d027bea870\", \"grit_python_unittests\": \"a906de1211aa1e6d0b6deb8a9a162d6998fb6336\", \"gwp_asan_unittests\": \"b883a83e7c6fd74e3238b9e63e90ebe2fe4024c0\", \"headless_browsertests\": \"d77d07d930f747e4d376a236ef3a5d265c44a363\", \"headless_unittests\": \"8c994742cb04ef5ed3b4f494136fa579088d97fb\", \"interactive_ui_tests\": \"f36a5db1d728218bad40da1dbe48cc4d4c3c3c65\", \"ipc_tests\": \"4a908fd3fbb61d8da2a7384822a0fc4093f822bf\", \"jingle_unittests\": \"828375886e3d06b0a617148044a1ef683cc589bb\", \"latency_unittests\": \"cca7d205f34c83bfa7100d5df07d4cb95c3aef5d\", \"libjingle_xmpp_unittests\": \"e8c47297877418e19629af8b79f59e60c65a1eee\", \"media_blink_unittests\": \"ecef365aef621c366a70f9dbaedd8336f479a0fd\", \"media_service_unittests\": \"56317cf7b05028a78505f11108aca26252a6003b\", \"media_unittests\": \"2ff9904f256e103b159eda8dd5312d22a4744352\", \"message_center_unittests\": \"2e455313716a89f9682d85d1366aeb352d15af6b\", \"metrics_python_tests\": \"9cabc8b7825ed706f0a83463c191f04e11793acc\", \"midi_unittests\": \"0c7de30c30aa41335efce5659f734eecfbc54f57\", \"mojo_core_unittests\": \"0735377d9f7538d710661bc38a66bed12afbb95f\", \"mojo_unittests\": \"1d4041e2ac1105aa0dbdfd948940e1acbe657096\", \"nacl_helper_nonsfi_unittests\": \"67ced45a2359183d2b8a5e84152a657573d97503\", \"nacl_loader_unittests\": \"5ac60fecb82a3eebd5bf8f5cdef817759b6858d3\", \"native_theme_unittests\": \"f2dbd71c585fbb0602fcd097610bd640f38b4a04\", \"net_unittests\": \"b77dbc359378966863b175a2053f59ce60337608\", \"pdf_unittests\": \"e47fc9bd5168e684bab7c82fe859a23ff40b80ec\", \"perfetto_unittests\": \"ecae6f36109017792b0a07e1fa6842e01203a540\", \"ppapi_unittests\": \"5f803bbb5ddc5db2c9f14f1624bce15b7cbaaa4a\", \"printing_unittests\": \"4ab7bbee64889c954b904a482503cce4007862c4\", \"remoting_unittests\": \"66483ea6535054b9699d2d3769a0202560c5d99a\", \"sandbox_linux_unittests\": \"479ad518e6c88f4690d6eaf941bacf5fc843cf9e\", \"service_manager_unittests\": \"ae3cef52f5088bb4ea8f90567bee95d045a9f3ba\", \"services_unittests\": \"985f77af14b6b23ec9684983b6627ecdb8a95a52\", \"shell_dialogs_unittests\": \"85fc253efa7190448b4e9fa0b08501a24b1ebcfb\", \"skia_unittests\": \"a2c431042b95b0fa65b467003eccc03bbe9e0be5\", \"snapshot_unittests\": \"411e5257251aab709048b59c78cfe54e68837f33\", \"sql_unittests\": \"73d01d209b3bbcb05cc916d4bf0a628fbfd64571\", \"storage_unittests\": \"77f461abc127ec28db3b0b88f9cc3806058e9a4a\", \"sync_integration_tests\": \"06ac4b316fb536739a1f566341f61be8a6a73cc2\", \"telemetry_gpu_unittests\": \"9c2a9a0eec9e9fdb71bd03beb3232ee5b3dfb165\", \"telemetry_perf_unittests\": \"f24e5c02bcca1294b3d33aa08e6988062aca13cc\", \"telemetry_unittests\": \"21b71ca3c1ca478ccb9e4d37f3e1cb5022fb91b9\", \"traffic_annotation_auditor_unittests\": \"b16ef6b66ed70024149a4448a3864b99720dd631\", \"ui_base_unittests\": \"1d2a9223e3729fd5b34a0f33ba0b99555c643dd3\", \"ui_touch_selection_unittests\": \"50996221f9c335651031b2e3086198cca3d32d9f\", \"unit_tests\": \"b9628d575cee7cd9788cb88bd1916362410835e7\", \"url_unittests\": \"08a1524a06c2e8a3e0914e4fc76e24ef3f98a1fa\", \"views_perftests\": \"8f42362b0398488a0d60d534b8e1265bbc35cb61\", \"views_unittests\": \"49e996503cff055eb1b63932ce777d63017b7a54\", \"viz_unittests\": \"c4e3843d32ef8f4f2064373e60852839f364cb98\", \"vr_common_unittests\": \"8d16be8d152f249bf27a786f49a925d5549e89cb\", \"vr_pixeltests\": \"e555abfc7a31a87a1ff269dc2615d45c3832f97e\", \"webdriver_wpt_tests\": \"95256f20dd3f144066d8d2493154cebe4eb4cf99\", \"weblayer_browsertests\": \"605bbcf4be65683a5ffcd3435132c9a4ce47961e\", \"wm_unittests\": \"f6493befee23071f0ba9bc706d94546815c9dcf1\", \"wtf_unittests\": \"53ed9632c376cdf9c0f2a3b97ee5f441e0400bfe\", \"xr_browser_tests\": \"85c9c1e2fab85089e4699c28adba5c4a6dad8631\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_06f1ed350fecda52f561db3eb00cb39e105b14f5c02d94078111c7babc8da8c6_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_a3249012ab2e105b4f1a10f0dc352b422f692fd701d889292e5c6170d198db4b_v2\", \"builder_d0ba3cd99c36b697d8651140d51bf4b4f4b9cd9aa25af11363af5ede5f6e35b1_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-56-mwiu\"], \"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\": [\"4804-5c544e0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580487547282002",
"status": "COMPLETED",
"status_changed_ts": "1580490504949747",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168085",
"builder:Linux Builder (dbg)",
"buildset:commit/git/06429d8bab6a30c59d1474ac8c1411a2fbc44e3d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/06429d8bab6a30c59d1474ac8c1411a2fbc44e3d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055162779648105392",
"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/8889732717183364912/+/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:4a15331caf195010",
"user_agent:luci-scheduler"
],
"updated_ts": "1580490504972738",
"url": "https://ci.chromium.org/b/8889732717183364912",
"utcnow_ts": "1580490505689533"
}
}
[17:08:25.697] Invocation finished in 54m17.318475725s with status SUCCEEDED