[02:40:01.883] New invocation is queued and will start shortly
[02:40:08.217] Starting the invocation (attempt 1)
[02:40:08.332] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:40:08.332] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:40:08.332] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052858477826381968",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"278d3bce53433a0031ea38d327a78b08b67549ed\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052858477826381968",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/278d3bce53433a0031ea38d327a78b08b67549ed",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/278d3bce53433a0031ea38d327a78b08b67549ed",
"gitiles_ref:refs/heads/master"
]
}
[02:40:09.187] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582684808476691",
"id": "8887428410226019248",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"278d3bce53433a0031ea38d327a78b08b67549ed\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582684808903876",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169027",
"builder:Linux Builder (dbg)",
"buildset:commit/git/278d3bce53433a0031ea38d327a78b08b67549ed",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/278d3bce53433a0031ea38d327a78b08b67549ed",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052858477826381968",
"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/8887428410226019248/+/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": "1582684808904042",
"url": "https://ci.chromium.org/b/8887428410226019248",
"utcnow_ts": "1582684809172844"
}
}
[02:40:09.187] Task URL: https://ci.chromium.org/b/8887428410226019248
[02:40:09.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:2:0) after 1m0s
[02:41:09.957] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:2:0)
[02:41:09.957] Timer tick, asking Buildbucket for the build status
[02:41:11.648] Build 8887428410226019248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:11.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:3:0) after 1m0s
[02:42:11.820] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:3:0)
[02:42:11.820] Timer tick, asking Buildbucket for the build status
[02:42:11.986] Build 8887428410226019248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:11.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:4:0) after 1m0s
[02:43:12.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:4:0)
[02:43:12.212] Timer tick, asking Buildbucket for the build status
[02:43:12.493] Build 8887428410226019248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:12.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:5:0) after 1m0s
[02:44:12.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:5:0)
[02:44:12.682] Timer tick, asking Buildbucket for the build status
[02:44:12.781] Build 8887428410226019248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:12.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:6:0) after 1m0s
[02:45:13.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:6:0)
[02:45:13.213] Timer tick, asking Buildbucket for the build status
[02:45:13.423] Build 8887428410226019248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:13.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:7:0) after 1m0s
[02:45:17.039] Received PubSub notification, asking Buildbucket for the build status
[02:45:17.116] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:13.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:7:0)
[02:46:13.489] Timer tick, asking Buildbucket for the build status
[02:46:13.588] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:13.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:9:0) after 1m0s
[02:47:13.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:9:0)
[02:47:13.698] Timer tick, asking Buildbucket for the build status
[02:47:13.936] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:13.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:10:0) after 1m0s
[02:48:13.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:10:0)
[02:48:13.987] Timer tick, asking Buildbucket for the build status
[02:48:14.082] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:14.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:11:0) after 1m0s
[02:49:14.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:11:0)
[02:49:14.204] Timer tick, asking Buildbucket for the build status
[02:49:14.447] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:14.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:12:0) after 1m0s
[02:50:14.494] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:12:0)
[02:50:14.494] Timer tick, asking Buildbucket for the build status
[02:50:14.600] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:14.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:13:0) after 1m0s
[02:51:14.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:13:0)
[02:51:14.833] Timer tick, asking Buildbucket for the build status
[02:51:15.159] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:15.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:14:0) after 1m0s
[02:52:15.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:14:0)
[02:52:15.299] Timer tick, asking Buildbucket for the build status
[02:52:15.501] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:15.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:15:0) after 1m0s
[02:53:15.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:15:0)
[02:53:15.575] Timer tick, asking Buildbucket for the build status
[02:53:15.886] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:15.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:16:0) after 1m0s
[02:54:16.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:16:0)
[02:54:16.025] Timer tick, asking Buildbucket for the build status
[02:54:16.288] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:16.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:17:0) after 1m0s
[02:55:16.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:17:0)
[02:55:16.383] Timer tick, asking Buildbucket for the build status
[02:55:16.689] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:16.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:18:0) after 1m0s
[02:56:16.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:18:0)
[02:56:16.792] Timer tick, asking Buildbucket for the build status
[02:56:16.933] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:16.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:19:0) after 1m0s
[02:57:16.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:19:0)
[02:57:16.955] Timer tick, asking Buildbucket for the build status
[02:57:17.153] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:17.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:20:0) after 1m0s
[02:58:17.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:20:0)
[02:58:17.257] Timer tick, asking Buildbucket for the build status
[02:58:17.462] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:17.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:21:0) after 1m0s
[02:59:17.678] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:21:0)
[02:59:17.678] Timer tick, asking Buildbucket for the build status
[02:59:17.786] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:17.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:22:0) after 1m0s
[03:00:18.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:22:0)
[03:00:18.061] Timer tick, asking Buildbucket for the build status
[03:00:18.357] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:18.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:23:0) after 1m0s
[03:01:18.451] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:23:0)
[03:01:18.451] Timer tick, asking Buildbucket for the build status
[03:01:18.638] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:18.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:24:0) after 1m0s
[03:02:18.668] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:24:0)
[03:02:18.668] Timer tick, asking Buildbucket for the build status
[03:02:18.796] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:18.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:25:0) after 1m0s
[03:03:18.943] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:25:0)
[03:03:18.943] Timer tick, asking Buildbucket for the build status
[03:03:19.128] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:19.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:26:0) after 1m0s
[03:04:19.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:26:0)
[03:04:19.209] Timer tick, asking Buildbucket for the build status
[03:04:19.321] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:19.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:27:0) after 1m0s
[03:05:19.385] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:27:0)
[03:05:19.385] Timer tick, asking Buildbucket for the build status
[03:05:19.827] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:19.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:28:0) after 1m0s
[03:06:19.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:28:0)
[03:06:19.872] Timer tick, asking Buildbucket for the build status
[03:06:19.994] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:19.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:29:0) after 1m0s
[03:07:20.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:29:0)
[03:07:20.059] Timer tick, asking Buildbucket for the build status
[03:07:20.215] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:20.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:30:0) after 1m0s
[03:08:20.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:30:0)
[03:08:20.283] Timer tick, asking Buildbucket for the build status
[03:08:20.386] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:20.386] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:31:0) after 1m0s
[03:09:20.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:31:0)
[03:09:20.482] Timer tick, asking Buildbucket for the build status
[03:09:20.620] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:20.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:32:0) after 1m0s
[03:10:20.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:32:0)
[03:10:20.842] Timer tick, asking Buildbucket for the build status
[03:10:20.929] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:20.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:33:0) after 1m0s
[03:11:20.998] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:33:0)
[03:11:20.998] Timer tick, asking Buildbucket for the build status
[03:11:21.106] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:21.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:34:0) after 1m0s
[03:12:22.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:34:0)
[03:12:22.143] Timer tick, asking Buildbucket for the build status
[03:12:22.331] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:22.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:35:0) after 1m0s
[03:13:22.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:35:0)
[03:13:22.650] Timer tick, asking Buildbucket for the build status
[03:13:23.042] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:23.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:36:0) after 1m0s
[03:14:23.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:36:0)
[03:14:23.261] Timer tick, asking Buildbucket for the build status
[03:14:23.492] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:23.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:37:0) after 1m0s
[03:15:23.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:37:0)
[03:15:23.685] Timer tick, asking Buildbucket for the build status
[03:15:24.055] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:24.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:38:0) after 1m0s
[03:16:24.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:38:0)
[03:16:24.142] Timer tick, asking Buildbucket for the build status
[03:16:24.361] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:24.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:39:0) after 1m0s
[03:17:24.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:39:0)
[03:17:24.474] Timer tick, asking Buildbucket for the build status
[03:17:24.565] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:24.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:40:0) after 1m0s
[03:18:24.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:40:0)
[03:18:24.620] Timer tick, asking Buildbucket for the build status
[03:18:24.699] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:24.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:41:0) after 1m0s
[03:19:24.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:41:0)
[03:19:24.937] Timer tick, asking Buildbucket for the build status
[03:19:25.207] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:25.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:42:0) after 1m0s
[03:20:25.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:42:0)
[03:20:25.276] Timer tick, asking Buildbucket for the build status
[03:20:25.631] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:25.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:43:0) after 1m0s
[03:21:25.665] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:43:0)
[03:21:25.665] Timer tick, asking Buildbucket for the build status
[03:21:26.208] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:26.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:44:0) after 1m0s
[03:22:26.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:44:0)
[03:22:26.312] Timer tick, asking Buildbucket for the build status
[03:22:26.539] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:26.539] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:45:0) after 1m0s
[03:23:26.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:45:0)
[03:23:26.751] Timer tick, asking Buildbucket for the build status
[03:23:26.871] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:26.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:46:0) after 1m0s
[03:24:27.131] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:46:0)
[03:24:27.131] Timer tick, asking Buildbucket for the build status
[03:24:27.252] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:27.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:47:0) after 1m0s
[03:25:27.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:47:0)
[03:25:27.417] Timer tick, asking Buildbucket for the build status
[03:25:27.553] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:27.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:48:0) after 1m0s
[03:26:27.783] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:48:0)
[03:26:27.783] Timer tick, asking Buildbucket for the build status
[03:26:28.041] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:28.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:49:0) after 1m0s
[03:27:28.382] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:49:0)
[03:27:28.382] Timer tick, asking Buildbucket for the build status
[03:27:28.482] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:28.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:50:0) after 1m0s
[03:28:28.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:50:0)
[03:28:28.545] Timer tick, asking Buildbucket for the build status
[03:28:28.647] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:28.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:51:0) after 1m0s
[03:29:28.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:51:0)
[03:29:28.716] Timer tick, asking Buildbucket for the build status
[03:29:28.851] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:28.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:52:0) after 1m0s
[03:30:28.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:52:0)
[03:30:28.906] Timer tick, asking Buildbucket for the build status
[03:30:29.004] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:29.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:53:0) after 1m0s
[03:31:29.063] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:53:0)
[03:31:29.063] Timer tick, asking Buildbucket for the build status
[03:31:29.287] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:29.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:54:0) after 1m0s
[03:32:29.392] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:54:0)
[03:32:29.392] Timer tick, asking Buildbucket for the build status
[03:32:29.501] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:29.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:55:0) after 1m0s
[03:33:29.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:55:0)
[03:33:29.604] Timer tick, asking Buildbucket for the build status
[03:33:29.819] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:29.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:56:0) after 1m0s
[03:34:29.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:56:0)
[03:34:29.844] Timer tick, asking Buildbucket for the build status
[03:34:30.001] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:30.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:57:0) after 1m0s
[03:35:30.605] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:57:0)
[03:35:30.606] Timer tick, asking Buildbucket for the build status
[03:35:30.783] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:30.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:58:0) after 1m0s
[03:36:31.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:58:0)
[03:36:31.066] Timer tick, asking Buildbucket for the build status
[03:36:31.155] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:31.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:59:0) after 1m0s
[03:37:31.328] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:59:0)
[03:37:31.328] Timer tick, asking Buildbucket for the build status
[03:37:31.983] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:31.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:60:0) after 1m0s
[03:38:32.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:60:0)
[03:38:32.194] Timer tick, asking Buildbucket for the build status
[03:38:32.288] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:32.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:61:0) after 1m0s
[03:39:32.500] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:61:0)
[03:39:32.500] Timer tick, asking Buildbucket for the build status
[03:39:32.703] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:32.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:62:0) after 1m0s
[03:40:32.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:62:0)
[03:40:32.793] Timer tick, asking Buildbucket for the build status
[03:40:32.888] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:32.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:63:0) after 1m0s
[03:41:33.083] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:63:0)
[03:41:33.083] Timer tick, asking Buildbucket for the build status
[03:41:33.195] Build 8887428410226019248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:33.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052858477826381968:64:0) after 1m0s
[03:41:35.636] Received PubSub notification, asking Buildbucket for the build status
[03:41:37.501] Build 8887428410226019248: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:41:37.501] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582688495112465",
"created_by": "project:chromium",
"created_ts": "1582684808476691",
"id": "8887428410226019248",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"278d3bce53433a0031ea38d327a78b08b67549ed\"}}",
"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-110-fu9v\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169027, \"got_angle_revision\": \"27cb806ca81951b702740f3cb3a5193a9135e65b\", \"got_dawn_revision\": \"227568451b442ae16873ec23cd4b86cf28d00b2a\", \"got_nacl_revision\": \"e2b3df265ebed5bccb0f5f670494bc800e7e3c1a\", \"got_revision\": \"278d3bce53433a0031ea38d327a78b08b67549ed\", \"got_revision_cp\": \"refs/heads/master@{#744516}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"da659b3741132fe6a6904e45d96112eef776bc28\", \"got_v8_revision\": \"57083a22efbe63d75af8adb979583fa3aa0ff0d4\", \"got_v8_revision_cp\": \"refs/heads/8.2.173@{#1}\", \"got_webrtc_revision\": \"a6db9c8fe9276774e3939d577c9320ad00fddd83\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30613}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"278d3bce53433a0031ea38d327a78b08b67549ed\", \"swarm_hashes_refs/heads/master(at){#744516}_without_patch\": {\"accessibility_unittests\": \"d14c66ed78194ff220569a95fda1c960113d3ce5\", \"angle_unittests\": \"f338b38085ed3cf9674fb76c10fa643846c88dcf\", \"app_shell_unittests\": \"263ac008144e9dce1b13a1ef05642375de1e316e\", \"aura_unittests\": \"20503f80afc956dad0057bdb6aa61809bdb4c662\", \"base_unittests\": \"1e4c2b7aa313abc19f4e9d7187fbfbb81c627492\", \"base_util_unittests\": \"f2a3e5fe02659a290668e9eddbfa56387c9496c4\", \"blink_common_unittests\": \"06fda157538fd4ef47dce30865b3fdeeccf71120\", \"blink_fuzzer_unittests\": \"8f0d76b2d011ce44681dd1643d551ec61903851d\", \"blink_heap_unittests\": \"e48ade52c0d66e9e05c2d37e823891560f6c1a2f\", \"blink_platform_unittests\": \"f8b51a1191fd64a28a84dfdf7b565af28a44bb97\", \"blink_python_tests\": \"bca77ab4a3bdc4ca763dca829c6baee146cac25c\", \"blink_unittests\": \"1cd1734e12ad80c2978b9bbd996f7d02e41ee61a\", \"blink_web_tests\": \"e4f8e6cbcb5d9a920145e1c3a0177dac3888106d\", \"boringssl_crypto_tests\": \"645c02bf39dae19547f5513dc91cf3121f370bc5\", \"boringssl_ssl_tests\": \"680b545f58a53d5f14df6792969b6bf4226f2cd6\", \"browser_tests\": \"b80e961e7a2d6964f39bee80d2fdebc348bf2499\", \"cacheinvalidation_unittests\": \"0340a0ffea3aa6050f1283cc35b9bae0ae565951\", \"capture_unittests\": \"d2499df43455580d862573fce65d6a7ca409221b\", \"cast_unittests\": \"ba61468e756c21ae32fae0733d15c30deeda39d1\", \"cc_unittests\": \"0824499f03db44dc11cf8f6e736958413cf4117f\", \"chrome_app_unittests\": \"ea67018dd48907cc2145c7d074551ae2734bb93d\", \"chromedriver_unittests\": \"4c343a00ad1e4e50617a02b7b6556aeab3ddcc22\", \"components_browsertests\": \"647462a59e568a036d8e59be203a1ab3f8ee683a\", \"components_unittests\": \"26cbac2fd5d97992e77327df06872056246af166\", \"compositor_unittests\": \"b74baa5d08bff204a7428f65c171d6136a82b082\", \"content_browsertests\": \"b2fc01726cc07a1d7bfa5f9a4650f57fd8d07863\", \"content_shell_crash_test\": \"5b5bf75b77981fc2c6b2a266c39e33c7ed791d59\", \"content_unittests\": \"98c278187f0e495d1987f4781235f3f03a42d15a\", \"crashpad_tests\": \"52335fcbe2846a4f04c4973574ff2c35ba7695f4\", \"cronet_tests\": \"8182c3a7c9f5618aeb02246076cd2c2282ed6960\", \"cronet_unittests\": \"5ed0016a290004c9d7f4ba534b6aa5b803d666e6\", \"crypto_unittests\": \"4209ffb1829140412c01b5fb5dfc9db66cdc5a64\", \"dbus_unittests\": \"a1faf5babb02551015ccba38832091bca700a399\", \"device_unittests\": \"bbe8f275fbaceb75692a4bc9617b200aa3386c4c\", \"display_unittests\": \"a2522d2ef73cb96e9edde6edfb4d1ff62a7203bd\", \"events_unittests\": \"9cd357a228ed5cb5922609e17381d8f1bc669f0a\", \"extensions_browsertests\": \"2cf094114afa71ff39f1d8f9a22ebd394c7a16f6\", \"extensions_unittests\": \"52e35f042fba2527c3f3f0dd608d413b308515d7\", \"filesystem_service_unittests\": \"808deb351fb3bd88db7c537dfcfc4f758e58a49c\", \"flatbuffers_unittests\": \"fddfee5d9c5c5357203fa42dff8f3c357607bc22\", \"gcm_unit_tests\": \"a5b1cf3d55fef39ee0a22288cc42e12d34ebf864\", \"gfx_unittests\": \"10f2e521580e56bc70fac8943974d54b23a493d7\", \"gin_unittests\": \"f85f930f4c7e2700709157f4e7fd65bbaa841aa9\", \"google_apis_unittests\": \"a3b6de3be3890cdd9d93f53d36766e290ad90960\", \"gpu_unittests\": \"73adc8604c64e1bf81d8975883580815afdc67e1\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"f9931a1c16bf0385d9a1e68694ebb3efa12b0be6\", \"headless_browsertests\": \"85de0ba2a6818a1d7262088b876dd20717a645ac\", \"headless_unittests\": \"08a563b4f3c51d1263b07bf444a152501e6261ce\", \"interactive_ui_tests\": \"f66db1d2187a75a46d33b9502e12f2cb999cf77d\", \"ipc_tests\": \"9fc0e8262c9515f2f90026e87294f31fb169c81c\", \"jingle_unittests\": \"27da3a7fab88511dca87a784f2cc07282baa7921\", \"latency_unittests\": \"d047ddb8cc79a750814853f0570b10242bbda35f\", \"libjingle_xmpp_unittests\": \"f161e3c75b454e72ff0fc0b413426003ef953725\", \"media_blink_unittests\": \"33c1465043415a607668cfa01273b49cc10d9c3b\", \"media_service_unittests\": \"58f7c6386a1d5fadfc8997ca50284b8ba3461bfc\", \"media_unittests\": \"1e6c6ecd8024c10a772b47cb902716922e366e69\", \"message_center_unittests\": \"fae35df4073d3721b0c809f2757ac9cb72ecd50d\", \"metrics_python_tests\": \"b5f11165c6a1599ef53c7627e6be78e5b0f93b49\", \"midi_unittests\": \"ea3b618a64212a0875e21f9de3d5e42bbc7e3350\", \"mojo_core_unittests\": \"1bb1e648ef92fa8977968ad2744e53982c4ec9b6\", \"mojo_unittests\": \"7c0bcf6cf6f84772abdbfc131d7beb11dc26c66e\", \"nacl_helper_nonsfi_unittests\": \"f2e81d6cb41bb06d2bdca4a2ed0d77f22a887857\", \"nacl_loader_unittests\": \"ce83162adddc59df4e24015e43fbdc48f700079d\", \"native_theme_unittests\": \"695dc9d6c0f80e8db8a3b70fce8bb2a6fd179088\", \"net_unittests\": \"f18992e58b06a316d3e90495502cd84ae43c6f6b\", \"pdf_unittests\": \"08561b34b90cf69fc1ef4bed6f17e789c2f2b6fd\", \"perfetto_unittests\": \"a342937254cacf69269a4fc2c69c97c27ac25a92\", \"ppapi_unittests\": \"11c2a6c43191b1da1850abb6386b0a16206633bf\", \"printing_unittests\": \"5ac8d266d5a99586f91528567acd06bfe85ec316\", \"remoting_unittests\": \"87a21033e427e3c0000b3b4b454aa4d05ecdc831\", \"sandbox_linux_unittests\": \"982bef5f630b96d488bb8d52d6c3a0af9d30a657\", \"service_manager_unittests\": \"31f5b11413179f304fe3ab79200cc931d7ef2d2e\", \"services_unittests\": \"f143a11f2fc80f7b2f97e7ffb726862f461f7d2b\", \"shell_dialogs_unittests\": \"edf01b679090f6e29b9b080f887d08a44d92f24a\", \"skia_unittests\": \"ac919cf7d9c93253626aca304c42f0d8326ad7bb\", \"snapshot_unittests\": \"22d9c32a711170215542386465239ff3cf23c47e\", \"sql_unittests\": \"3e3bc20e2d831bae044cd01f0f80041320572d1e\", \"storage_unittests\": \"44a4a06df3dbfd33827c4ce74c2f10a18eba35ea\", \"sync_integration_tests\": \"8cc4a5c4bbc087ec93ed80a56077868169bd2c14\", \"telemetry_gpu_unittests\": \"a74a7906a10f8b7c1929d701fe463f012de6fd62\", \"telemetry_perf_unittests\": \"e4177096635f8b7729c6dd0dde823ac9839c2d20\", \"telemetry_unittests\": \"2af8c6988fbb5f736cc8ed53ec485441d7725d6a\", \"traffic_annotation_auditor_unittests\": \"7bac54b8d589cf726834e4c483137365f97bf2dd\", \"ui_base_unittests\": \"1e0fd03e31282aea4bb41cdc8f2e5139af071b95\", \"ui_touch_selection_unittests\": \"e1ddf72e4dd6388cea2142453afa6a84b297118b\", \"unit_tests\": \"9cfc157234bb57808c35b82e5927fc4097b8ed06\", \"url_unittests\": \"ab296c42a08b0eb54c68094786edc60c14a67b20\", \"views_perftests\": \"3a1654447094558ecfc8a9020242e0b5efbcfa37\", \"views_unittests\": \"f0470863673882f703b4765fdf4692614e993a4c\", \"viz_unittests\": \"9ad22dc79491a6a52af9e3570c2eb6f8841b3835\", \"vr_common_unittests\": \"2672e0b3f93a014e4b00d9b515d100af3a7ddbf7\", \"vr_pixeltests\": \"fa043291a1578e6773788b9f547d74d50e9e9678\", \"webdriver_wpt_tests\": \"61d42925f49379c66820d13f58fd5b19a00f7ddc\", \"weblayer_browsertests\": \"b55c008a049f86d3abc88c73463609e476f615f2\", \"wm_unittests\": \"da5b10227331662c824ac360ce460925aa059484\", \"wtf_unittests\": \"6bffdeb5bfa523f4cba826a2ca87005a57208d0f\", \"xr_browser_tests\": \"f84ce0952bafb0d8fafa78655cc5428894ef3f88\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_8116c80c2882afcd67a910417bbd6fba6f94de5911d922ccd599199b9d07f827_v2\", \"builder_8b7b2365a8f3880d050d5bb210d6d23a3c1fa90e9cf635ebce9fc15f785b82f2_v2\", \"builder_c9091f6bc58db7983401393b6dacc93b3db8fae2c2ae9b40177b9e0904c8bc80_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_d7a16d1002a90b006293eb3aaf9b6ed11d06403f3c58091e1c5077b5d2ff0b40_v2\", \"builder_ddf530b99db2c48999a16b04f27f886d0f06df616543b36733eb8d0558bd23f5_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-110-fu9v\"], \"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\": [\"4825-3d129d6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582685115051173",
"status": "COMPLETED",
"status_changed_ts": "1582688495376073",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169027",
"builder:Linux Builder (dbg)",
"buildset:commit/git/278d3bce53433a0031ea38d327a78b08b67549ed",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/278d3bce53433a0031ea38d327a78b08b67549ed",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052858477826381968",
"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/8887428410226019248/+/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:4a982f30322a6610",
"user_agent:luci-scheduler"
],
"updated_ts": "1582688495379614",
"url": "https://ci.chromium.org/b/8887428410226019248",
"utcnow_ts": "1582688497491712"
}
}
[03:41:37.501] Invocation finished in 1h1m35.656880394s with status SUCCEEDED