[05:04:09.747] New invocation is queued and will start shortly
[05:04:10.891] Starting the invocation (attempt 1)
[05:04:10.930] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:04:10.930] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:04:10.930] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019781517121340416",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"85df7dc4da20fd5043c9e9eb87e42de3eef10321\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9019781517121340416",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/85df7dc4da20fd5043c9e9eb87e42de3eef10321",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/85df7dc4da20fd5043c9e9eb87e42de3eef10321",
"gitiles_ref:refs/heads/master"
]
}
[05:04:13.088] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1614229451210907",
"id": "8854351454925851920",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"85df7dc4da20fd5043c9e9eb87e42de3eef10321\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614229452628363",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180912",
"builder:Linux Builder (dbg)",
"buildset:commit/git/85df7dc4da20fd5043c9e9eb87e42de3eef10321",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/85df7dc4da20fd5043c9e9eb87e42de3eef10321",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019781517121340416",
"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/8854351454925851920/+/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": "1614229452680079",
"url": "https://ci.chromium.org/b/8854351454925851920",
"utcnow_ts": "1614229453023207"
}
}
[05:04:13.088] Task URL: https://ci.chromium.org/b/8854351454925851920
[05:04:13.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:2:0) after 1m0s
[05:04:16.336] Received PubSub notification, asking Buildbucket for the build status
[05:04:16.424] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:13.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:2:0)
[05:05:13.110] Timer tick, asking Buildbucket for the build status
[05:05:13.206] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:13.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:4:0) after 1m0s
[05:06:13.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:4:0)
[05:06:13.268] Timer tick, asking Buildbucket for the build status
[05:06:13.360] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:13.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:5:0) after 1m0s
[05:07:13.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:5:0)
[05:07:13.374] Timer tick, asking Buildbucket for the build status
[05:07:13.481] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:13.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:6:0) after 1m0s
[05:08:13.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:6:0)
[05:08:13.496] Timer tick, asking Buildbucket for the build status
[05:08:13.572] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:13.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:7:0) after 1m0s
[05:09:13.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:7:0)
[05:09:13.596] Timer tick, asking Buildbucket for the build status
[05:09:13.993] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:13.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:8:0) after 1m0s
[05:10:14.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:8:0)
[05:10:14.028] Timer tick, asking Buildbucket for the build status
[05:10:14.123] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:14.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:9:0) after 1m0s
[05:11:14.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:9:0)
[05:11:14.149] Timer tick, asking Buildbucket for the build status
[05:11:14.260] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:14.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:10:0) after 1m0s
[05:12:14.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:10:0)
[05:12:14.281] Timer tick, asking Buildbucket for the build status
[05:12:14.377] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:14.377] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:11:0) after 1m0s
[05:13:14.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:11:0)
[05:13:14.409] Timer tick, asking Buildbucket for the build status
[05:13:14.758] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:14.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:12:0) after 1m0s
[05:14:14.768] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:12:0)
[05:14:14.768] Timer tick, asking Buildbucket for the build status
[05:14:15.020] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:15.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:13:0) after 1m0s
[05:15:15.075] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:13:0)
[05:15:15.075] Timer tick, asking Buildbucket for the build status
[05:15:15.326] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:15.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:14:0) after 1m0s
[05:16:15.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:14:0)
[05:16:15.344] Timer tick, asking Buildbucket for the build status
[05:16:15.503] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:15.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:15:0) after 1m0s
[05:17:15.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:15:0)
[05:17:15.561] Timer tick, asking Buildbucket for the build status
[05:17:15.633] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:15.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:16:0) after 1m0s
[05:18:15.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:16:0)
[05:18:15.655] Timer tick, asking Buildbucket for the build status
[05:18:15.722] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:15.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:17:0) after 1m0s
[05:19:15.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:17:0)
[05:19:15.791] Timer tick, asking Buildbucket for the build status
[05:19:15.881] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:15.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:18:0) after 1m0s
[05:20:15.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:18:0)
[05:20:15.924] Timer tick, asking Buildbucket for the build status
[05:20:16.016] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:16.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:19:0) after 1m0s
[05:21:16.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:19:0)
[05:21:16.056] Timer tick, asking Buildbucket for the build status
[05:21:16.183] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:16.183] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:20:0) after 1m0s
[05:22:16.216] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:20:0)
[05:22:16.216] Timer tick, asking Buildbucket for the build status
[05:22:16.308] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:16.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:21:0) after 1m0s
[05:23:16.348] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:21:0)
[05:23:16.348] Timer tick, asking Buildbucket for the build status
[05:23:16.436] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:16.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:22:0) after 1m0s
[05:24:16.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:22:0)
[05:24:16.442] Timer tick, asking Buildbucket for the build status
[05:24:16.681] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:16.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:23:0) after 1m0s
[05:25:16.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:23:0)
[05:25:16.723] Timer tick, asking Buildbucket for the build status
[05:25:16.819] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:16.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:24:0) after 1m0s
[05:26:16.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:24:0)
[05:26:16.809] Timer tick, asking Buildbucket for the build status
[05:26:16.906] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:16.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:25:0) after 1m0s
[05:27:17.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:25:0)
[05:27:17.002] Timer tick, asking Buildbucket for the build status
[05:27:17.365] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:17.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:26:0) after 1m0s
[05:28:17.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:26:0)
[05:28:17.570] Timer tick, asking Buildbucket for the build status
[05:28:17.682] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:17.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:27:0) after 1m0s
[05:29:17.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:27:0)
[05:29:17.871] Timer tick, asking Buildbucket for the build status
[05:29:17.951] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:17.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:28:0) after 1m0s
[05:30:18.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:28:0)
[05:30:18.065] Timer tick, asking Buildbucket for the build status
[05:30:18.138] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:18.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:29:0) after 1m0s
[05:31:18.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:29:0)
[05:31:18.229] Timer tick, asking Buildbucket for the build status
[05:31:18.297] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:18.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:30:0) after 1m0s
[05:32:18.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:30:0)
[05:32:18.317] Timer tick, asking Buildbucket for the build status
[05:32:18.384] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:18.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:31:0) after 1m0s
[05:33:18.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:31:0)
[05:33:18.461] Timer tick, asking Buildbucket for the build status
[05:33:18.548] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:18.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:32:0) after 1m0s
[05:34:18.746] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:32:0)
[05:34:18.747] Timer tick, asking Buildbucket for the build status
[05:34:19.120] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:19.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:33:0) after 1m0s
[05:35:19.111] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:33:0)
[05:35:19.111] Timer tick, asking Buildbucket for the build status
[05:35:19.211] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:19.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:34:0) after 1m0s
[05:36:19.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:34:0)
[05:36:19.211] Timer tick, asking Buildbucket for the build status
[05:36:20.051] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:20.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:35:0) after 1m0s
[05:37:20.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:35:0)
[05:37:20.108] Timer tick, asking Buildbucket for the build status
[05:37:20.227] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:20.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:36:0) after 1m0s
[05:38:20.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:36:0)
[05:38:20.321] Timer tick, asking Buildbucket for the build status
[05:38:20.418] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:20.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:37:0) after 1m0s
[05:39:20.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:37:0)
[05:39:20.477] Timer tick, asking Buildbucket for the build status
[05:39:20.566] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:20.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:38:0) after 1m0s
[05:40:20.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:38:0)
[05:40:20.651] Timer tick, asking Buildbucket for the build status
[05:40:20.732] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:20.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:39:0) after 1m0s
[05:41:20.886] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:39:0)
[05:41:20.886] Timer tick, asking Buildbucket for the build status
[05:41:20.957] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:20.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:40:0) after 1m0s
[05:42:21.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:40:0)
[05:42:21.056] Timer tick, asking Buildbucket for the build status
[05:42:21.273] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:21.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:41:0) after 1m0s
[05:43:21.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:41:0)
[05:43:21.514] Timer tick, asking Buildbucket for the build status
[05:43:21.584] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:21.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:42:0) after 1m0s
[05:44:21.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:42:0)
[05:44:21.629] Timer tick, asking Buildbucket for the build status
[05:44:21.753] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:21.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:43:0) after 1m0s
[05:45:21.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:43:0)
[05:45:21.851] Timer tick, asking Buildbucket for the build status
[05:45:21.927] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:21.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:44:0) after 1m0s
[05:46:21.985] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:44:0)
[05:46:21.985] Timer tick, asking Buildbucket for the build status
[05:46:22.049] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:22.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:45:0) after 1m0s
[05:47:22.069] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:45:0)
[05:47:22.069] Timer tick, asking Buildbucket for the build status
[05:47:22.163] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:22.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:46:0) after 1m0s
[05:48:22.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:46:0)
[05:48:22.355] Timer tick, asking Buildbucket for the build status
[05:48:22.423] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:22.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:47:0) after 1m0s
[05:49:22.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:47:0)
[05:49:22.541] Timer tick, asking Buildbucket for the build status
[05:49:22.749] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:22.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:48:0) after 1m0s
[05:50:22.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:48:0)
[05:50:22.726] Timer tick, asking Buildbucket for the build status
[05:50:22.836] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:22.836] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:49:0) after 1m0s
[05:51:22.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:49:0)
[05:51:22.877] Timer tick, asking Buildbucket for the build status
[05:51:31.019] Build 8854351454925851920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:31.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019781517121340416:50:0) after 1m0s
[05:51:33.433] Received PubSub notification, asking Buildbucket for the build status
[05:51:33.602] Build 8854351454925851920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:51:33.602] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1614232292417444",
"created_by": "project:chromium",
"created_ts": "1614229451210907",
"id": "8854351454925851920",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"85df7dc4da20fd5043c9e9eb87e42de3eef10321\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"85df7dc4da20fd5043c9e9eb87e42de3eef10321\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-80-a3xm\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180912, \"got_angle_revision\": \"9b1c569b14e90765cdd7c07e449400e88f1d6c45\", \"got_dawn_revision\": \"5eb496b863da5b40dc5c9a713c8ca1e413811f35\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"85df7dc4da20fd5043c9e9eb87e42de3eef10321\", \"got_revision_cp\": \"refs/heads/master@{#857545}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"cd0373f013b5c9672c05e79a48bb1e9fb5f50fa4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33333}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"85df7dc4da20fd5043c9e9eb87e42de3eef10321\", \"swarm_hashes_refs/heads/master(at){#857545}_without_patch\": {\"absl_hardening_tests\": \"b1c424dadb973f36f3e4c15b6f0c97134e277bdc\", \"accessibility_unittests\": \"b5db4feb65e32eefb75904efff793680731c2d4f\", \"angle_unittests\": \"e042ca5ff7e79183c88450e0c50f33c5dc9f9e9f\", \"app_shell_unittests\": \"4a1fb0b868f1ec7cc5fa7026a11b5728fc5d4d17\", \"aura_unittests\": \"e0e842e6599fe0519488231631cb5ebe4ac2fac6\", \"base_unittests\": \"f745f3a775c0bf4033aa351f1cca574662159513\", \"base_util_unittests\": \"486c8fb8ba05c138e927a7b529186e7f810649f8\", \"blink_common_unittests\": \"7c4d021d395ceecd534c4018945ad587b78a0007\", \"blink_fuzzer_unittests\": \"007c01f60f7a426df075520acf00f565de65584f\", \"blink_heap_unittests\": \"5257c4cef189c88374c6144349ea32a73b6b5db4\", \"blink_platform_unittests\": \"7bbae1574057dd8058f10f4102fbb1166a04ff57\", \"blink_python_tests\": \"572c7e0bb214be89cb7ea60360dda3af39c6d1b5\", \"blink_unittests\": \"65bba71d499733f35616886c1107563508ef3a64\", \"blink_web_tests\": \"adfc8c76a00c14cf0cb968f174af97063373f1fd\", \"boringssl_crypto_tests\": \"2a6069ae32b0b0cdbde4f18b32ca6b3972c22ea9\", \"boringssl_ssl_tests\": \"7c60dd68fe2b3bdc687a6a3abb52fe031e0813b7\", \"browser_tests\": \"ed3064d5325962b2cd722e5bd07e7e0e654e22e0\", \"capture_unittests\": \"a67c86c8b9d1317a43529741de387ac67235175b\", \"cast_unittests\": \"e629d19237fcdb7374731da4e8bd5400e04f3eff\", \"cc_unittests\": \"2aa66f83d774dbfda46c87e6802f4d364b38b566\", \"chrome_app_unittests\": \"56a9516c09d7278dbcd1175836cffdd198ff968f\", \"chromedriver_unittests\": \"84660d8cdbb5a1afc5deae8c0c65c3e6e856d4d5\", \"color_unittests\": \"404f3eb4d4e146acdd224d66dc3f41fa0a8f802e\", \"components_browsertests\": \"adaca0700e09f2d91bc250f511f57ae0a246715d\", \"components_unittests\": \"f3675f5235933de1d96c7008043a7eea25682cd5\", \"compositor_unittests\": \"9091d2fd298b146aac07cee7c837565c2a12be4b\", \"content_browsertests\": \"4c7084f6b3059e9a532eec46b3e03362dff0d871\", \"content_shell_crash_test\": \"ef4d255878d0d4c6e05564f7ee86862a4ad67598\", \"content_unittests\": \"52dc585546ae5c6c4946c15c1a2df5b10e34dbf5\", \"crashpad_tests\": \"c93d93974f2c8f919e8049b0a2d955ed311de8e0\", \"cronet_tests\": \"8999d8482b32f5eb52f236e72bd6d910554cca0f\", \"cronet_unittests\": \"63a182b717a724feb762bf50748d505df71d8835\", \"crypto_unittests\": \"74574c188f41335c33ce7209a1d9b1d053628c43\", \"dbus_unittests\": \"9b25c64bb167fcb6c9cc91f080b33da5b20e572c\", \"device_unittests\": \"1a21b9205294f341dce9fc21ce81e88235a1f290\", \"display_unittests\": \"13cfe263e2847c41dff88a36ff0a049e59d4dd6d\", \"events_unittests\": \"7bd22bf78b8a2f3079931fbb492c8d22bcffc8a4\", \"extensions_browsertests\": \"aea3360bca76a800d9bc00099aa1049550454c1b\", \"extensions_unittests\": \"9b503caa854dc8ddaa56371b4a791c6540272e89\", \"filesystem_service_unittests\": \"c1fbc92cebe33d7b09d5504cefc430c1b365fdfa\", \"flatbuffers_unittests\": \"e8e54a71bdd869da6d885f6d9de43244c0b7bf8d\", \"gcm_unit_tests\": \"fadb8ff6d9c45e670081c24dac41177c3ce97310\", \"gfx_unittests\": \"05f729f288e1ddf92581d9337eb9c6bf8de96890\", \"gin_unittests\": \"ae9d1beddc9b98e04747d113ebebe6356a2e50f4\", \"google_apis_unittests\": \"011fe2f2dc99e44a906dc5def6d575ecf77f3389\", \"gpu_unittests\": \"7e539f13c855f3b25d8dc597be98416a4abcb5b0\", \"grit_python_unittests\": \"00738482c42a9310ca0fd96f0709b3d808390403\", \"gwp_asan_unittests\": \"47e81a4ef3c46a5d440fc2ea61fbb7e4c59abd3c\", \"headless_browsertests\": \"41d5fafc985e9de4062e37861ae216f49d30f228\", \"headless_unittests\": \"631b9303ab12dfa063fb655a35164fac60f4a9d1\", \"interactive_ui_tests\": \"1e9aac0ea913f31be243d488c843c85dc4f4a253\", \"ipc_tests\": \"d85a54c4f169295a134cf1d2f2ca4aa221e74729\", \"jingle_unittests\": \"c49ede0f3d4eb45ae226101669170118bad11cf3\", \"latency_unittests\": \"ba544feb12f0c0e24a7fb6b80a98611c6705dad5\", \"libjingle_xmpp_unittests\": \"3b4e0c962feeb47dc1893137ec903c5499d41f4f\", \"liburlpattern_unittests\": \"ff058c5a5772afcf3401fc50942a168e9161c5ef\", \"media_blink_unittests\": \"ad1345a90c1e2bc0eb2e2551e3028406ace3d964\", \"media_unittests\": \"6eaf8e120851274b63d4f18a96ba839ad1398dcc\", \"message_center_unittests\": \"b123e46f1e28149e4e3ff6160401a15b2e807193\", \"metrics_python_tests\": \"decfcc3d90d8ea751689dd5a59a1e98531920825\", \"midi_unittests\": \"bdac9d613cd0a737663e5b318ed836c5e1caa0b2\", \"mojo_core_unittests\": \"6091c68ad498f6498b203ea142355bc13817f65d\", \"mojo_unittests\": \"070f971262bb9fa760d242e23c05eb110ee02b7c\", \"nacl_helper_nonsfi_unittests\": \"9d32d85331e6f3d69fc70447e2a64fec0fc82da2\", \"nacl_loader_unittests\": \"7b293228998dc5c47926284dad5ebec78766460e\", \"native_theme_unittests\": \"c741864c1c3433f49f5f2f6555dce2378eb38912\", \"net_unittests\": \"9388acd47b7d730666750b8f86a9967b24e236d6\", \"openscreen_unittests\": \"452f7ec2df3c0b2f1339e8e5325436466accedc5\", \"pdf_unittests\": \"bfcd138535f69e67caae8183f3b5bb08bf4d243b\", \"perfetto_unittests\": \"582219f3391bafc55e9de13c7fc36f7c18c42116\", \"ppapi_unittests\": \"53e105ad7dec2a360e706699e4c2d9201b058a07\", \"printing_unittests\": \"26829b72f1a475fd7593818916a0aad68f762ac5\", \"remoting_unittests\": \"fcb08211d30a226af88b01f9eb9ee34129b17f7e\", \"sandbox_linux_unittests\": \"ecc72dee4cc0f667c0eca1fc908bb3ccc4de3ab7\", \"service_manager_unittests\": \"6c93d0a0b7ae5e39a6b616e02696656148f07e98\", \"services_unittests\": \"2d758de4e30ebf672a1e1d2dd6b77831755c6bfd\", \"shell_dialogs_unittests\": \"2d578fbb239b739a0c68a5bc9203be23fa4c0537\", \"skia_unittests\": \"4510bf74f83a63e6a9f6070a0a70158e377bc0dc\", \"snapshot_unittests\": \"6b4364fb1f171e143cdbada062558faedcb2b809\", \"sql_unittests\": \"71522217438bb1829946ea6c2e361f1f94ce08b1\", \"storage_unittests\": \"fdf881307baa7d7bf41dfd98f4b913d1c0b280a1\", \"sync_integration_tests\": \"c799780db653635dae480e55ec9b12c7c8651fb9\", \"telemetry_gpu_unittests\": \"5bde40e98605e1127f03b2a82ef0045474bb1054\", \"telemetry_perf_unittests\": \"9a60a1e7597f3951662fcd22b25dae8632ff3e4c\", \"telemetry_unittests\": \"0966cb434ef00999da63fa11fa5552e28f4f56f8\", \"traffic_annotation_auditor_unittests\": \"fe6d14578bd49c1099289ba7443ffd2955fe0fe4\", \"ui_base_unittests\": \"75589b51d25f152656e3c6b93b3f2fbcf3e1f012\", \"ui_touch_selection_unittests\": \"f370ecb0a42bab88eb37a68e53646f8ea9883fc9\", \"unit_tests\": \"f5fc4f4a299de815ef094df85cd15b7ed2c20dc2\", \"url_unittests\": \"012d9c0ac96dc2f0a3007e4b5706f40776d27fb2\", \"views_perftests\": \"9df88440e8f4af975f7474303acabef1408eea9b\", \"views_unittests\": \"5812b1ca29ab3d4ba63d6ebed4c284b9f765febb\", \"viz_unittests\": \"5f3e23f65e31382f320bb8ed1da2e1828b71b709\", \"vr_common_unittests\": \"f6950c858434ccf0a9d51dfef360144d1518aad6\", \"vr_pixeltests\": \"2646ae8929faf4ded865030568241e30cfdbd721\", \"webdriver_wpt_tests\": \"e86304833e605799e992bcff4b2fe70d4a4c89fc\", \"weblayer_browsertests\": \"dd97495f7892e225553074e7e2b9fe1d61a09184\", \"weblayer_unittests\": \"9939340460d807375fe656927951e612f0d34841\", \"wm_unittests\": \"6c1b969dce90ab46d7c7ad3311621bec9c46427f\", \"wtf_unittests\": \"7a8967933f25b7990c156e4df24a58ac278d0faa\", \"x11_unittests\": \"1dd3d26785e9729190d5ba75d1a9ad40e1dac805\", \"xr_browser_tests\": \"630486eeeb015587df71997ce69918e67ae3e9d9\", \"zlib_unittests\": \"d488293040cc15233f01f9734198f8bb0faca44a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_151f80801b9f29276c11c5f05dab27ce5673f9c9ba442aaf2cf20aab9215f522_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_7ddc1ece4c938056809d45345930c5d8ea6799936d2255389af4f16219f397ac_v2\", \"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_fb646d86e88bda56572dff3378a9fa669f47f3a45e650c7783bf21742e524b22_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-80-a3xm\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614229455593071",
"status": "COMPLETED",
"status_changed_ts": "1614232292723414",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180912",
"builder:Linux Builder (dbg)",
"buildset:commit/git/85df7dc4da20fd5043c9e9eb87e42de3eef10321",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/85df7dc4da20fd5043c9e9eb87e42de3eef10321",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019781517121340416",
"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/8854351454925851920/+/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:51f06441173b7910",
"user_agent:luci-scheduler"
],
"updated_ts": "1614232292731932",
"url": "https://ci.chromium.org/b/8854351454925851920",
"utcnow_ts": "1614232293578367"
}
}
[05:51:33.602] Invocation finished in 47m23.869022462s with status SUCCEEDED