[02:22:16.407] New invocation is queued and will start shortly
[02:22:17.824] Starting the invocation (attempt 1)
[02:22:17.874] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:22:17.874] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:22:17.874] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052678401114926944",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"11581e77e66698100ad20d97a9dc63f6f4ec6cf8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052678401114926944",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/11581e77e66698100ad20d97a9dc63f6f4ec6cf8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11581e77e66698100ad20d97a9dc63f6f4ec6cf8",
"gitiles_ref:refs/heads/master"
]
}
[02:22:18.557] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582856538002481",
"id": "8887248338766078160",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11581e77e66698100ad20d97a9dc63f6f4ec6cf8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582856538394039",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169108",
"builder:Linux Builder (dbg)",
"buildset:commit/git/11581e77e66698100ad20d97a9dc63f6f4ec6cf8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11581e77e66698100ad20d97a9dc63f6f4ec6cf8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052678401114926944",
"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/8887248338766078160/+/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": "1582856538394206",
"url": "https://ci.chromium.org/b/8887248338766078160",
"utcnow_ts": "1582856538536040"
}
}
[02:22:18.558] Task URL: https://ci.chromium.org/b/8887248338766078160
[02:22:18.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:2:0) after 1m0s
[02:23:18.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:2:0)
[02:23:18.691] Timer tick, asking Buildbucket for the build status
[02:23:18.940] Build 8887248338766078160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:18.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:3:0) after 1m0s
[02:24:19.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:3:0)
[02:24:19.116] Timer tick, asking Buildbucket for the build status
[02:24:19.209] Build 8887248338766078160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:19.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:4:0) after 1m0s
[02:25:19.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:4:0)
[02:25:19.339] Timer tick, asking Buildbucket for the build status
[02:25:19.431] Build 8887248338766078160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:19.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:5:0) after 1m0s
[02:26:19.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:5:0)
[02:26:19.471] Timer tick, asking Buildbucket for the build status
[02:26:19.703] Build 8887248338766078160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:19.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:6:0) after 1m0s
[02:27:11.297] Received PubSub notification, asking Buildbucket for the build status
[02:27:11.527] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:19.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:6:0)
[02:27:19.795] Timer tick, asking Buildbucket for the build status
[02:27:19.863] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:19.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:8:0) after 1m0s
[02:28:19.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:8:0)
[02:28:19.933] Timer tick, asking Buildbucket for the build status
[02:28:20.092] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:20.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:9:0) after 1m0s
[02:29:20.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:9:0)
[02:29:20.237] Timer tick, asking Buildbucket for the build status
[02:29:20.336] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:20.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:10:0) after 1m0s
[02:30:20.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:10:0)
[02:30:20.409] Timer tick, asking Buildbucket for the build status
[02:30:20.511] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:20.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:11:0) after 1m0s
[02:31:20.678] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:11:0)
[02:31:20.678] Timer tick, asking Buildbucket for the build status
[02:31:20.806] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:20.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:12:0) after 1m0s
[02:32:20.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:12:0)
[02:32:20.992] Timer tick, asking Buildbucket for the build status
[02:32:21.114] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:21.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:13:0) after 1m0s
[02:33:21.182] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:13:0)
[02:33:21.182] Timer tick, asking Buildbucket for the build status
[02:33:21.493] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:21.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:14:0) after 1m0s
[02:34:21.525] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:14:0)
[02:34:21.525] Timer tick, asking Buildbucket for the build status
[02:34:21.625] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:21.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:15:0) after 1m0s
[02:35:21.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:15:0)
[02:35:21.732] Timer tick, asking Buildbucket for the build status
[02:35:21.981] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:21.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:16:0) after 1m0s
[02:36:22.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:16:0)
[02:36:22.035] Timer tick, asking Buildbucket for the build status
[02:36:22.160] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:22.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:17:0) after 1m0s
[02:37:22.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:17:0)
[02:37:22.269] Timer tick, asking Buildbucket for the build status
[02:37:22.694] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:22.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:18:0) after 1m0s
[02:38:22.754] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:18:0)
[02:38:22.754] Timer tick, asking Buildbucket for the build status
[02:38:24.026] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:24.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:19:0) after 1m0s
[02:39:24.146] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:19:0)
[02:39:24.147] Timer tick, asking Buildbucket for the build status
[02:39:24.283] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:24.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:20:0) after 1m0s
[02:40:24.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:20:0)
[02:40:24.423] Timer tick, asking Buildbucket for the build status
[02:40:24.618] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:24.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:21:0) after 1m0s
[02:41:24.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:21:0)
[02:41:24.799] Timer tick, asking Buildbucket for the build status
[02:41:24.963] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:24.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:22:0) after 1m0s
[02:42:25.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:22:0)
[02:42:25.021] Timer tick, asking Buildbucket for the build status
[02:42:25.118] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:25.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:23:0) after 1m0s
[02:43:25.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:23:0)
[02:43:25.276] Timer tick, asking Buildbucket for the build status
[02:43:25.404] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:25.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:24:0) after 1m0s
[02:44:25.567] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:24:0)
[02:44:25.567] Timer tick, asking Buildbucket for the build status
[02:44:25.824] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:25.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:25:0) after 1m0s
[02:45:25.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:25:0)
[02:45:25.898] Timer tick, asking Buildbucket for the build status
[02:45:26.007] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:26.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:26:0) after 1m0s
[02:46:26.168] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:26:0)
[02:46:26.168] Timer tick, asking Buildbucket for the build status
[02:46:26.395] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:26.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:27:0) after 1m0s
[02:47:26.582] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:27:0)
[02:47:26.582] Timer tick, asking Buildbucket for the build status
[02:47:26.689] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:26.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:28:0) after 1m0s
[02:48:26.914] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:28:0)
[02:48:26.914] Timer tick, asking Buildbucket for the build status
[02:48:27.056] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:27.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:29:0) after 1m0s
[02:49:27.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:29:0)
[02:49:27.209] Timer tick, asking Buildbucket for the build status
[02:49:27.466] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:27.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:30:0) after 1m0s
[02:50:28.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:30:0)
[02:50:28.117] Timer tick, asking Buildbucket for the build status
[02:50:28.385] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:28.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:31:0) after 1m0s
[02:51:28.445] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:31:0)
[02:51:28.445] Timer tick, asking Buildbucket for the build status
[02:51:28.618] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:28.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:32:0) after 1m0s
[02:52:28.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:32:0)
[02:52:28.919] Timer tick, asking Buildbucket for the build status
[02:52:29.094] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:29.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:33:0) after 1m0s
[02:53:29.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:33:0)
[02:53:29.221] Timer tick, asking Buildbucket for the build status
[02:53:29.433] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:29.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:34:0) after 1m0s
[02:54:29.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:34:0)
[02:54:29.685] Timer tick, asking Buildbucket for the build status
[02:54:30.066] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:30.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:35:0) after 1m0s
[02:55:30.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:35:0)
[02:55:30.110] Timer tick, asking Buildbucket for the build status
[02:55:30.208] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:30.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:36:0) after 1m0s
[02:56:30.466] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:36:0)
[02:56:30.466] Timer tick, asking Buildbucket for the build status
[02:56:30.768] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:30.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:37:0) after 1m0s
[02:57:30.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:37:0)
[02:57:30.860] Timer tick, asking Buildbucket for the build status
[02:57:31.197] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:31.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:38:0) after 1m0s
[02:58:31.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:38:0)
[02:58:31.283] Timer tick, asking Buildbucket for the build status
[02:58:31.402] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:31.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:39:0) after 1m0s
[02:59:31.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:39:0)
[02:59:31.455] Timer tick, asking Buildbucket for the build status
[02:59:31.653] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:31.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:40:0) after 1m0s
[03:00:31.764] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:40:0)
[03:00:31.764] Timer tick, asking Buildbucket for the build status
[03:00:32.066] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:32.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:41:0) after 1m0s
[03:01:32.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:41:0)
[03:01:32.226] Timer tick, asking Buildbucket for the build status
[03:01:32.330] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:32.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:42:0) after 1m0s
[03:02:32.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:42:0)
[03:02:32.512] Timer tick, asking Buildbucket for the build status
[03:02:32.666] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:32.666] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:43:0) after 1m0s
[03:03:32.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:43:0)
[03:03:32.698] Timer tick, asking Buildbucket for the build status
[03:03:32.900] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:32.900] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:44:0) after 1m0s
[03:04:32.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:44:0)
[03:04:32.939] Timer tick, asking Buildbucket for the build status
[03:04:33.165] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:33.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:45:0) after 1m0s
[03:05:33.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:45:0)
[03:05:33.233] Timer tick, asking Buildbucket for the build status
[03:05:33.377] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:33.377] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:46:0) after 1m0s
[03:06:33.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:46:0)
[03:06:33.436] Timer tick, asking Buildbucket for the build status
[03:06:33.800] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:33.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:47:0) after 1m0s
[03:07:33.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:47:0)
[03:07:33.917] Timer tick, asking Buildbucket for the build status
[03:07:34.215] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:34.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:48:0) after 1m0s
[03:08:34.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:48:0)
[03:08:34.309] Timer tick, asking Buildbucket for the build status
[03:08:34.429] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:34.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:49:0) after 1m0s
[03:09:34.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:49:0)
[03:09:34.452] Timer tick, asking Buildbucket for the build status
[03:09:34.718] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:34.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:50:0) after 1m0s
[03:10:34.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:50:0)
[03:10:34.823] Timer tick, asking Buildbucket for the build status
[03:10:34.926] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:34.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:51:0) after 1m0s
[03:11:34.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:51:0)
[03:11:34.934] Timer tick, asking Buildbucket for the build status
[03:11:35.044] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:35.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:52:0) after 1m0s
[03:12:35.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:52:0)
[03:12:35.129] Timer tick, asking Buildbucket for the build status
[03:12:35.499] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:35.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:53:0) after 1m0s
[03:13:35.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:53:0)
[03:13:35.524] Timer tick, asking Buildbucket for the build status
[03:13:35.658] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:35.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:54:0) after 1m0s
[03:14:35.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:54:0)
[03:14:35.710] Timer tick, asking Buildbucket for the build status
[03:14:35.842] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:35.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:55:0) after 1m0s
[03:15:36.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:55:0)
[03:15:36.101] Timer tick, asking Buildbucket for the build status
[03:15:36.206] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:36.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:56:0) after 1m0s
[03:16:36.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:56:0)
[03:16:36.253] Timer tick, asking Buildbucket for the build status
[03:16:36.351] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:36.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:57:0) after 1m0s
[03:17:36.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:57:0)
[03:17:36.484] Timer tick, asking Buildbucket for the build status
[03:17:36.669] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:36.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:58:0) after 1m0s
[03:18:36.764] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:58:0)
[03:18:36.764] Timer tick, asking Buildbucket for the build status
[03:18:37.164] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:37.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:59:0) after 1m0s
[03:19:37.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:59:0)
[03:19:37.184] Timer tick, asking Buildbucket for the build status
[03:19:37.420] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:37.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:60:0) after 1m0s
[03:20:37.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:60:0)
[03:20:37.558] Timer tick, asking Buildbucket for the build status
[03:20:37.675] Build 8887248338766078160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:37.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052678401114926944:61:0) after 1m0s
[03:21:34.794] Received PubSub notification, asking Buildbucket for the build status
[03:21:34.856] Build 8887248338766078160: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:21:34.856] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582860092270506",
"created_by": "project:chromium",
"created_ts": "1582856538002481",
"id": "8887248338766078160",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11581e77e66698100ad20d97a9dc63f6f4ec6cf8\"}}",
"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-101-9s8h\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169108, \"got_angle_revision\": \"78da538aed5268be4bab9f230f101bf57b93d462\", \"got_dawn_revision\": \"e299afa9ec114c4a1b94c7c47b8e60271a807fd5\", \"got_nacl_revision\": \"21be4b46c82c14625859b4929af9ef6433fa04a5\", \"got_revision\": \"11581e77e66698100ad20d97a9dc63f6f4ec6cf8\", \"got_revision_cp\": \"refs/heads/master@{#745327}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"05f5e0b34ac8d98d093a6dd271fb0ef3535fff02\", \"got_v8_revision\": \"bfa4dadb209f32c2690fd1fedcaa2d10b0315e57\", \"got_v8_revision_cp\": \"refs/heads/8.2.205@{#1}\", \"got_webrtc_revision\": \"e3e07bf979eae09df2e161824573a457acf2212a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30637}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11581e77e66698100ad20d97a9dc63f6f4ec6cf8\", \"swarm_hashes_refs/heads/master(at){#745327}_without_patch\": {\"accessibility_unittests\": \"d6ac3a9af4532232bdeec3bf8b888f277526846c\", \"angle_unittests\": \"8da405925c689833e7f971f4af4004856a506e00\", \"app_shell_unittests\": \"467f862bfef2b7dadb25034779e9d2966b1c21af\", \"aura_unittests\": \"78ddc8899b19d5c6c74c5535d2c6959f10945d0e\", \"base_unittests\": \"ef7fed9824a04b9df31a891814a2d54243b3d192\", \"base_util_unittests\": \"c6634e3a990034acab5c97e4161a5f35f8442312\", \"blink_common_unittests\": \"540d6ea829abdfaa24ad7c80c5ac255755ab945d\", \"blink_fuzzer_unittests\": \"c4c001b12d9f1b156f7fcf112754dd119c93b366\", \"blink_heap_unittests\": \"598d41d182ed1a2ef45eab50faf05abee2b2b6fb\", \"blink_platform_unittests\": \"24e23890a8f9cebe9e9bbf30ca00e146fec86d7f\", \"blink_python_tests\": \"c044fd98a1718373765dc28a5e2fa3203a46d078\", \"blink_unittests\": \"a2380c804b86ed23cb6ccf9f2aa9d6f4fbeea344\", \"blink_web_tests\": \"63fb0e26c326f10060276be939e07bfdfd2b347e\", \"boringssl_crypto_tests\": \"9c0e8733e5e91c469854a5817f63e2196e82e7e4\", \"boringssl_ssl_tests\": \"7083e76c15d55421ca7870fc20d425d42ecafcaa\", \"browser_tests\": \"9072b5d13c064e7cdebbb17535ed914426f006d6\", \"cacheinvalidation_unittests\": \"1056de2f7b1de093be19a7e291aa386406de6c10\", \"capture_unittests\": \"04aba4ebf97159caf3afba5701d5382384902357\", \"cast_unittests\": \"d1079011d5b89a2dd5d37e480053dc1304a29d4c\", \"cc_unittests\": \"29b3cc80f84a7da9d0cce700bb9c901bb11946ff\", \"chrome_app_unittests\": \"6e85aea74cf46cd9f435e6ec69dd96e8c971ead6\", \"chromedriver_unittests\": \"a4cf4c2dbae6b2fdf1544ef566bc6c3e63ee83cd\", \"components_browsertests\": \"9f24b58422321aeb9fc3a904b214ffa967db6d93\", \"components_unittests\": \"3871a1194a8c8f7d790cd51ac7407e51a7614f57\", \"compositor_unittests\": \"28277f67eab019f495317690827b6295f2fd7b95\", \"content_browsertests\": \"a94ba8c48d3021e7b6d1c32bf5be15c077a4c83e\", \"content_shell_crash_test\": \"be2392f2366e7d2b502373a11403cd0596449e2f\", \"content_unittests\": \"0c6604e6edcc9c1307dc12ec4c789ea22e447765\", \"crashpad_tests\": \"24a76e0df6327376f14fac957971012d7051ceb9\", \"cronet_tests\": \"10db576c006117073a939263d7113621aabc57a4\", \"cronet_unittests\": \"7b606a75caefca4b878dcfc69873ee714faacaa4\", \"crypto_unittests\": \"33232b210534fd56aa153144ae19290c224c11d5\", \"dbus_unittests\": \"2164ab5b04a90a96adbdfe6b82a5d149bb1c1954\", \"device_unittests\": \"e4fec4c503f76ff2aeeb71b06e46b2b4077a903a\", \"display_unittests\": \"e46ef98878d2e06ff0e6f584a2168eba5886657f\", \"events_unittests\": \"3e4be08c457b23ea3e49eaa827e647c7d1c97692\", \"extensions_browsertests\": \"cede3f51ed78bbf7f216975649e5bc06fcbf9be8\", \"extensions_unittests\": \"c59da5256f54a4eda126405703082c1914e3f4ec\", \"filesystem_service_unittests\": \"7fa6fcd5c9f9a7276fb964dfe582c374b6b5e722\", \"flatbuffers_unittests\": \"9b972b84314b0e944fad99f4c5be3f50c351ec0c\", \"gcm_unit_tests\": \"39cf927aa368b1df7d142bdd3000ccfbf37bc7b7\", \"gfx_unittests\": \"34ddfffeeeb05a50a436faaf8989971e1d71e93b\", \"gin_unittests\": \"93bc61721425fb281d32331f9b03fd4c68870dee\", \"google_apis_unittests\": \"19855643f35ccc728c2fe7e612d67d99b17ae3b5\", \"gpu_unittests\": \"a8563b67e547c0a7ee5a85b74dd908aa232aa5b6\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"da719f5c0a0f8b0c559d4efdb235ebbd437b18cc\", \"headless_browsertests\": \"331872d02059f1226156ad73e2fc1ee14afba882\", \"headless_unittests\": \"e6f5b6ad2f5c932e74392740decdbc7c7d1017aa\", \"interactive_ui_tests\": \"6854ba9bd1c981244e4a78c8aea787f84fd3f854\", \"ipc_tests\": \"7b78815394d0aecc15a849c002083788c0442c15\", \"jingle_unittests\": \"018024102862b44c2e28637dc1ec37941657aff2\", \"latency_unittests\": \"68508b38de8441973d54d3374cc10238a56bcafd\", \"libjingle_xmpp_unittests\": \"cd5201552e67957bec936c1e7b0744e4c8c4a0fe\", \"media_blink_unittests\": \"dbbf93d789f6096e054a0c0a78b701e272e82396\", \"media_service_unittests\": \"9691e702de7696ba0bbabd7fa0d80d81c16d3527\", \"media_unittests\": \"ebaa623870f9ba83bd181d3f585cf0e67e1b535c\", \"message_center_unittests\": \"d4042f6dc2429293e056e651656680e27cca8787\", \"metrics_python_tests\": \"b37c36d8d0397ab09fe57559345871cf176d9825\", \"midi_unittests\": \"6163f0c9db8be5bd5305be8c2139ff3ecf7f8481\", \"mojo_core_unittests\": \"94155ca72ad02fddb748e9e3f7216c99a67e4bff\", \"mojo_unittests\": \"2e3588370776d6e37e3e7c15e7e3966117f2a484\", \"nacl_helper_nonsfi_unittests\": \"e93f10fe2fc57083d91c147ad127679f0666a1f5\", \"nacl_loader_unittests\": \"584485112feb390354955f23f2c8d0ea57ca89ae\", \"native_theme_unittests\": \"e6a63f4c2ac779188a1751f285b3c897bf97de81\", \"net_unittests\": \"e1988396c8617cfce0d7bd72cfd5d301e9cbb3c4\", \"pdf_unittests\": \"c7f38a177b9de23696ecba9d1e1158a296204555\", \"perfetto_unittests\": \"6db8592175fda5f319e479d6971559ed388d6a99\", \"ppapi_unittests\": \"2229eeba2545d66e1e1c724333221251942f17f7\", \"printing_unittests\": \"585c1efe9bf179823aa526b26dd56f9a292ae882\", \"remoting_unittests\": \"6de39152a0a0b52bc58df714cc6a10d8b080dfb3\", \"sandbox_linux_unittests\": \"5ab52bf4107deb9fc333256465cd26e316e9105b\", \"service_manager_unittests\": \"b5eb83e4497f8974a735ee20ce8839a321c96636\", \"services_unittests\": \"02cb058c1b350398a34af9e853ca74b88d814a26\", \"shell_dialogs_unittests\": \"f8e97474aa220c25954f7ea7f24b5187fec37c01\", \"skia_unittests\": \"abac32c162663a1fd9e9e0e7627b38fb6f4b79b2\", \"snapshot_unittests\": \"4e7daa8ee535145d662370a5e78bcb07b0436ecb\", \"sql_unittests\": \"2d17fdc5d87af82763229ef0475757c5f464be28\", \"storage_unittests\": \"d46eb693844b4929c09a036a9d6f6aa23c24488c\", \"sync_integration_tests\": \"c3bcbe2545e3e1688ae974e4eac39f045657adee\", \"telemetry_gpu_unittests\": \"b122dd7f34a233a9acc6cf96c5752fb4a9020717\", \"telemetry_perf_unittests\": \"afbab4541dd7c59381a8e7b946801e404a26c49a\", \"telemetry_unittests\": \"478f61e0567dd7b2e73d07eaa1fc29eef333dd3d\", \"traffic_annotation_auditor_unittests\": \"3ef5bd1400496ca6bd1f632a7c727a35f5120ccc\", \"ui_base_unittests\": \"124fa7be3fc3df9a8db72b04ad170ec24454a5e2\", \"ui_touch_selection_unittests\": \"85796e6cd8a50e1bc8c35a6300aa604d6b0351f5\", \"unit_tests\": \"8c78b88aea84ebe5896d2ef89081be36e7b5afc4\", \"url_unittests\": \"3b42253a5a8e52ed774dcb592cdafaa43db1b40c\", \"views_perftests\": \"7b519aa9bed59cbe6f30c1784ab4a25b4041fee4\", \"views_unittests\": \"be2c39fe07ee76b93cef33687f634a28ed2a66d8\", \"viz_unittests\": \"7051b34f2b318335a31129e78fef6a9c4000ef12\", \"vr_common_unittests\": \"cef8e2f9b26082e681c8fb4fe4ef05c3e93b7a17\", \"vr_pixeltests\": \"bf2a97494353267f5678982a824c23f3326ef1a7\", \"webdriver_wpt_tests\": \"14a45d27952eab39903c59d6bf12ee8ec187f092\", \"weblayer_browsertests\": \"6b4b7bf2408fec6486095d05b74a40ec8b9171b0\", \"wm_unittests\": \"a35440bbc71085c0971097e7e781f9e2820384c3\", \"wtf_unittests\": \"f1672f85d295e1453f8f1feab2013f29864ba858\", \"xr_browser_tests\": \"e8362ebe2b1660f4a348617e72054590737faf18\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1c97ebbcfb2b59a51287991f2ed562e10321e4784ed0e8a7a3677e8f006ec0dd_v2\", \"builder_28bbe8e6e9c00f2d4cca6bb7518e2e3abcc6dba52c0db172294f96352b49589a_v2\", \"builder_3ebf4dd509a5805e98d79f047f39cac1c13d897e075c42798b95fb1279fe5d7c_v2\", \"builder_81975214af25fe3c157931ccf4182e1c4ae2635ce20b925a941b30b87e2fcb1d_v2\", \"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_9b8e7cf0a756f5448fe63e5ba03689dec6fdccd23b3dfddd2910706476b68383_v2\", \"builder_e4464922e5c60bddfcc3d01cfc511ef7f4a711bded636fa98c66f03a573264ee_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-101-9s8h\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4838-b69615e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582856830556771",
"status": "COMPLETED",
"status_changed_ts": "1582860092697700",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169108",
"builder:Linux Builder (dbg)",
"buildset:commit/git/11581e77e66698100ad20d97a9dc63f6f4ec6cf8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11581e77e66698100ad20d97a9dc63f6f4ec6cf8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052678401114926944",
"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/8887248338766078160/+/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:4aa26b924a68fa10",
"user_agent:luci-scheduler"
],
"updated_ts": "1582860092702509",
"url": "https://ci.chromium.org/b/8887248338766078160",
"utcnow_ts": "1582860094848333"
}
}
[03:21:34.856] Invocation finished in 59m18.477504284s with status SUCCEEDED