[03:04:52.483] New invocation is queued and will start shortly
[03:04:53.643] Starting the invocation (attempt 1)
[03:04:53.711] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:04:53.711] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:04:53.711] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9055393629856746688",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6fd7160064963c5eca9c3444554c15cc3f662610\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9055393629856746688",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/6fd7160064963c5eca9c3444554c15cc3f662610",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6fd7160064963c5eca9c3444554c15cc3f662610",
"gitiles_ref:refs/heads/master"
]
}
[03:04:54.279] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1580267093849816",
"id": "8889963567758320400",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6fd7160064963c5eca9c3444554c15cc3f662610\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580267094168592",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167965",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6fd7160064963c5eca9c3444554c15cc3f662610",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6fd7160064963c5eca9c3444554c15cc3f662610",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055393629856746688",
"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/8889963567758320400/+/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": "1580267094168777",
"url": "https://ci.chromium.org/b/8889963567758320400",
"utcnow_ts": "1580267094265983"
}
}
[03:04:54.279] Task URL: https://ci.chromium.org/b/8889963567758320400
[03:04:54.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:2:0) after 1m0s
[03:05:54.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:2:0)
[03:05:54.428] Timer tick, asking Buildbucket for the build status
[03:05:55.480] Build 8889963567758320400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:05:55.480] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:3:0) after 1m0s
[03:06:55.494] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:3:0)
[03:06:55.494] Timer tick, asking Buildbucket for the build status
[03:06:55.638] Build 8889963567758320400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:06:55.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:4:0) after 1m0s
[03:07:55.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:4:0)
[03:07:55.734] Timer tick, asking Buildbucket for the build status
[03:07:56.278] Build 8889963567758320400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:07:56.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:5:0) after 1m0s
[03:08:56.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:5:0)
[03:08:56.337] Timer tick, asking Buildbucket for the build status
[03:08:57.385] Build 8889963567758320400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:08:57.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:6:0) after 1m0s
[03:09:17.925] Received PubSub notification, asking Buildbucket for the build status
[03:09:18.812] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:57.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:6:0)
[03:09:57.651] Timer tick, asking Buildbucket for the build status
[03:09:58.532] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:58.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:8:0) after 1m0s
[03:10:58.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:8:0)
[03:10:58.728] Timer tick, asking Buildbucket for the build status
[03:10:58.881] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:58.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:9:0) after 1m0s
[03:11:58.920] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:9:0)
[03:11:58.920] Timer tick, asking Buildbucket for the build status
[03:11:59.087] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:59.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:10:0) after 1m0s
[03:12:59.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:10:0)
[03:12:59.196] Timer tick, asking Buildbucket for the build status
[03:12:59.677] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:59.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:11:0) after 1m0s
[03:13:59.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:11:0)
[03:13:59.884] Timer tick, asking Buildbucket for the build status
[03:14:00.074] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:00.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:12:0) after 1m0s
[03:15:00.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:12:0)
[03:15:00.128] Timer tick, asking Buildbucket for the build status
[03:15:00.319] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:00.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:13:0) after 1m0s
[03:16:00.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:13:0)
[03:16:00.350] Timer tick, asking Buildbucket for the build status
[03:16:00.530] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:00.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:14:0) after 1m0s
[03:17:00.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:14:0)
[03:17:00.638] Timer tick, asking Buildbucket for the build status
[03:17:00.876] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:00.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:15:0) after 1m0s
[03:18:00.894] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:15:0)
[03:18:00.894] Timer tick, asking Buildbucket for the build status
[03:18:01.247] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:01.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:16:0) after 1m0s
[03:19:01.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:16:0)
[03:19:01.266] Timer tick, asking Buildbucket for the build status
[03:19:02.113] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:02.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:17:0) after 1m0s
[03:20:02.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:17:0)
[03:20:02.154] Timer tick, asking Buildbucket for the build status
[03:20:02.311] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:02.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:18:0) after 1m0s
[03:21:02.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:18:0)
[03:21:02.351] Timer tick, asking Buildbucket for the build status
[03:21:02.499] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:02.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:19:0) after 1m0s
[03:22:02.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:19:0)
[03:22:02.535] Timer tick, asking Buildbucket for the build status
[03:22:02.710] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:02.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:20:0) after 1m0s
[03:23:02.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:20:0)
[03:23:02.774] Timer tick, asking Buildbucket for the build status
[03:23:03.262] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:03.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:21:0) after 1m0s
[03:24:03.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:21:0)
[03:24:03.373] Timer tick, asking Buildbucket for the build status
[03:24:03.693] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:03.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:22:0) after 1m0s
[03:25:03.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:22:0)
[03:25:03.670] Timer tick, asking Buildbucket for the build status
[03:25:03.858] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:03.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:23:0) after 1m0s
[03:26:03.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:23:0)
[03:26:03.959] Timer tick, asking Buildbucket for the build status
[03:26:04.129] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:04.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:24:0) after 1m0s
[03:27:04.206] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:24:0)
[03:27:04.206] Timer tick, asking Buildbucket for the build status
[03:27:04.440] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:04.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:25:0) after 1m0s
[03:28:04.475] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:25:0)
[03:28:04.475] Timer tick, asking Buildbucket for the build status
[03:28:04.648] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:04.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:26:0) after 1m0s
[03:29:04.746] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:26:0)
[03:29:04.746] Timer tick, asking Buildbucket for the build status
[03:29:04.866] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:04.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:27:0) after 1m0s
[03:30:04.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:27:0)
[03:30:04.991] Timer tick, asking Buildbucket for the build status
[03:30:05.171] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:05.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:28:0) after 1m0s
[03:31:05.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:28:0)
[03:31:05.433] Timer tick, asking Buildbucket for the build status
[03:31:05.638] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:05.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:29:0) after 1m0s
[03:32:06.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:29:0)
[03:32:06.098] Timer tick, asking Buildbucket for the build status
[03:32:06.245] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:06.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:30:0) after 1m0s
[03:33:06.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:30:0)
[03:33:06.371] Timer tick, asking Buildbucket for the build status
[03:33:06.527] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:06.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:31:0) after 1m0s
[03:34:06.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:31:0)
[03:34:06.782] Timer tick, asking Buildbucket for the build status
[03:34:07.174] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:07.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:32:0) after 1m0s
[03:35:07.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:32:0)
[03:35:07.227] Timer tick, asking Buildbucket for the build status
[03:35:08.478] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:08.478] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:33:0) after 1m0s
[03:36:08.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:33:0)
[03:36:08.649] Timer tick, asking Buildbucket for the build status
[03:36:08.917] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:08.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:34:0) after 1m0s
[03:37:09.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:34:0)
[03:37:09.138] Timer tick, asking Buildbucket for the build status
[03:37:09.495] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:09.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:35:0) after 1m0s
[03:38:09.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:35:0)
[03:38:09.606] Timer tick, asking Buildbucket for the build status
[03:38:10.605] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:10.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:36:0) after 1m0s
[03:39:10.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:36:0)
[03:39:10.730] Timer tick, asking Buildbucket for the build status
[03:39:10.978] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:10.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:37:0) after 1m0s
[03:40:11.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:37:0)
[03:40:11.166] Timer tick, asking Buildbucket for the build status
[03:40:11.406] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:11.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:38:0) after 1m0s
[03:41:11.594] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:38:0)
[03:41:11.594] Timer tick, asking Buildbucket for the build status
[03:41:11.860] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:11.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:39:0) after 1m0s
[03:42:12.144] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:39:0)
[03:42:12.144] Timer tick, asking Buildbucket for the build status
[03:42:12.899] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:12.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:40:0) after 1m0s
[03:43:12.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:40:0)
[03:43:12.983] Timer tick, asking Buildbucket for the build status
[03:43:13.244] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:13.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:41:0) after 1m0s
[03:44:13.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:41:0)
[03:44:13.334] Timer tick, asking Buildbucket for the build status
[03:44:13.465] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:13.465] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:42:0) after 1m0s
[03:45:13.612] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:42:0)
[03:45:13.612] Timer tick, asking Buildbucket for the build status
[03:45:13.971] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:13.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:43:0) after 1m0s
[03:46:13.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:43:0)
[03:46:13.994] Timer tick, asking Buildbucket for the build status
[03:46:14.756] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:14.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:44:0) after 1m0s
[03:47:14.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:44:0)
[03:47:14.815] Timer tick, asking Buildbucket for the build status
[03:47:15.046] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:15.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:45:0) after 1m0s
[03:48:15.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:45:0)
[03:48:15.138] Timer tick, asking Buildbucket for the build status
[03:48:15.308] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:15.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:46:0) after 1m0s
[03:49:15.363] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:46:0)
[03:49:15.363] Timer tick, asking Buildbucket for the build status
[03:49:16.623] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:16.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:47:0) after 1m0s
[03:50:16.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:47:0)
[03:50:16.875] Timer tick, asking Buildbucket for the build status
[03:50:17.007] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:17.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:48:0) after 1m0s
[03:51:17.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:48:0)
[03:51:17.123] Timer tick, asking Buildbucket for the build status
[03:51:17.294] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:17.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:49:0) after 1m0s
[03:52:17.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:49:0)
[03:52:17.380] Timer tick, asking Buildbucket for the build status
[03:52:18.272] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:18.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:50:0) after 1m0s
[03:53:18.272] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:50:0)
[03:53:18.272] Timer tick, asking Buildbucket for the build status
[03:53:18.809] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:18.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:51:0) after 1m0s
[03:54:19.131] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:51:0)
[03:54:19.131] Timer tick, asking Buildbucket for the build status
[03:54:19.389] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:19.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:52:0) after 1m0s
[03:55:19.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:52:0)
[03:55:19.520] Timer tick, asking Buildbucket for the build status
[03:55:19.671] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:19.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:53:0) after 1m0s
[03:56:19.746] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:53:0)
[03:56:19.746] Timer tick, asking Buildbucket for the build status
[03:56:19.917] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:19.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:54:0) after 1m0s
[03:57:20.031] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:54:0)
[03:57:20.031] Timer tick, asking Buildbucket for the build status
[03:57:20.257] Build 8889963567758320400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:20.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055393629856746688:55:0) after 1m0s
[03:57:53.209] Received PubSub notification, asking Buildbucket for the build status
[03:57:53.360] Build 8889963567758320400: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:57:53.360] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1580270272266791",
"created_by": "project:chromium",
"created_ts": "1580267093849816",
"id": "8889963567758320400",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6fd7160064963c5eca9c3444554c15cc3f662610\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-58-zr1q\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 167965, \"got_angle_revision\": \"4a8fa19f05741435f56d582f69c9194e56513839\", \"got_dawn_revision\": \"74f5054ec925faf5100fa265325c460df2795120\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"6fd7160064963c5eca9c3444554c15cc3f662610\", \"got_revision_cp\": \"refs/heads/master@{#736182}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"6c3dc3581eaf4345c0507d5ac7bb013d55351547\", \"got_v8_revision\": \"390a4513a584df618c36884766c69b46da421c94\", \"got_v8_revision_cp\": \"refs/heads/8.1.297@{#1}\", \"got_webrtc_revision\": \"b6bf0b2546f3f5eeec88112431c8a58e86a2e19a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30396}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6fd7160064963c5eca9c3444554c15cc3f662610\", \"swarm_hashes_refs/heads/master(at){#736182}_without_patch\": {\"accessibility_unittests\": \"cb3f253dd0901ec80d45c5d2688eaba6f2648e39\", \"angle_unittests\": \"a22c0eaa63d7f9b160ac70a8d88aa45d6da4402e\", \"app_shell_unittests\": \"aedc253dde717c3d627e293da1dad3ebc8bc2385\", \"aura_unittests\": \"895174a0794a502576f70932d7fec89e8d373dd6\", \"base_unittests\": \"e484132b3cd5555cb6b9e3123169badd896f2db2\", \"base_util_unittests\": \"bbe49e4f8cacc028f92fdf8b8cfd47be58d1a04d\", \"blink_common_unittests\": \"0325c3e802a19dbefd823f47dad97f90b1b0dbf5\", \"blink_fuzzer_unittests\": \"b6ce866825c329ce14761e20f287cfd66114b1ce\", \"blink_heap_unittests\": \"636329c4f0c2044f18aaa5b36350774ae3e686bb\", \"blink_platform_unittests\": \"3633204e985f18f0b378e29517daea5299675cfc\", \"blink_python_tests\": \"573905a3d0b43d3450fabb91c051007bdeab6d20\", \"blink_unittests\": \"5601d8017e209e955a6a67d2d44f0c53183c084a\", \"blink_web_tests\": \"7aba22d1ae2084ac8e4aca182b5472dcdf9f919e\", \"boringssl_crypto_tests\": \"ac6e81ffe8fef5b1c853f6a23de6d37f3a014976\", \"boringssl_ssl_tests\": \"7e43212a1c533b6af8fbb00c59ad3e98901bd656\", \"browser_tests\": \"a2c9b5702ea830a87ec264c6ce427c3e2878580e\", \"cacheinvalidation_unittests\": \"6c5d509a89058edad360b29f5c68ac39b8988c60\", \"capture_unittests\": \"4c4d78b53bc74d5390921f1ec5268588af453230\", \"cast_unittests\": \"bb4640fc68583c8a7edada442799dd882fc83e8f\", \"cc_unittests\": \"aff6353f37b13ff681f640fec83fcbb860968967\", \"chrome_app_unittests\": \"38203bf7c10577adc77bfe6e78ec414c70fcc755\", \"chromedriver_unittests\": \"34585749f5e47bc708139ddf10e9c6307129c8bd\", \"components_browsertests\": \"add2b63689a16f7377260863b66e50e9728b9c7b\", \"components_unittests\": \"d07704d0c7775794ef55c07d8bb386dbdfee22b2\", \"compositor_unittests\": \"e7a2e071a56199a1f8cb6d34cf0b370660891094\", \"content_browsertests\": \"30386970d9d70d718ef15a1dba52b04ee6615ec5\", \"content_shell_crash_test\": \"0a1ca75fe11d485c5d4593331ba704fcb8ef7289\", \"content_unittests\": \"d4b5f75ca502d6f1a01c8f96758363a0cd66851c\", \"crashpad_tests\": \"1fad081c5212bd6f8e7b9c2621e36171c27b0f83\", \"cronet_tests\": \"fd18f042ad1efcdcb51a9f3014f481cd541bd4b7\", \"cronet_unittests\": \"16bfa3811bd028a6ac238887e93cbb1bd1709d8a\", \"crypto_unittests\": \"70f4c6ae330dc17cbaa3293f96f89a24a2829c30\", \"dbus_unittests\": \"8d00c5b4293be0d0e0a72182209a101dbec4d061\", \"device_unittests\": \"0e6a3687a60a1ddccf6d17c58ff2380e7989a5cd\", \"display_unittests\": \"71e8e176789b04b805d10f258f79da10f7b842fe\", \"events_unittests\": \"4a64d3f77b3bc0740dd96f7344fb38c745ea0ba2\", \"extensions_browsertests\": \"10ff0fc3af414db022acf89b50597cd7a85204c8\", \"extensions_unittests\": \"b3b8c5908eac83aabb95ff65b2d37ea7d65a215b\", \"filesystem_service_unittests\": \"9bb1ca4a6d1e38d03443b5832e1cf68b128d52c2\", \"flatbuffers_unittests\": \"92c174f535dbe8e15f58589d59dc88efc29a10d4\", \"gcm_unit_tests\": \"f5d5badfcf561c2572744f9626bb82f38698ed9d\", \"gfx_unittests\": \"aa4a7a099841074ebd9811c547b44ee674047273\", \"gin_unittests\": \"c09301a8b815686bcbc09da1ec7121977dab8c75\", \"google_apis_unittests\": \"7bf42250964b2dba828da24456d4be15923fac7d\", \"gpu_unittests\": \"c2c04b01d5ec9e0d5656d3c2df7cf7e31943bf92\", \"grit_python_unittests\": \"896da2265579af982b0c06ff8662522b696fea99\", \"gwp_asan_unittests\": \"d8604673e19e0d18353dcbf5300185e78b40d0c9\", \"headless_browsertests\": \"afec81e2c60cbe02564c79b2d69b4133e0090e48\", \"headless_unittests\": \"83873bb1b750d23a773332e540d56c9e1f82bed3\", \"interactive_ui_tests\": \"77c56a88467c4eabd356e341bec36331aa10c28f\", \"ipc_tests\": \"c724110fd4e18212ecb50a4ea3ba90de561a2a3a\", \"jingle_unittests\": \"a216e1251f7b5b163d611d55d489596e9ea32ac3\", \"latency_unittests\": \"13d0699f60c84456196bbcb1d2cf45c00eecf08d\", \"libjingle_xmpp_unittests\": \"a2f0f4dccf6f3a79264f2b6a3e557f0865845044\", \"media_blink_unittests\": \"ef02b3c003163288d1bd240c9a3e70e97c255030\", \"media_service_unittests\": \"c974efb7c30a1f13f38a1e945bd2acd1ad2236dc\", \"media_unittests\": \"b0703117d6032cb2568a7f386e955dc64ff0d633\", \"message_center_unittests\": \"ec5590713b1b03784b5ed44159b14bc970d650b5\", \"metrics_python_tests\": \"0ccfc8d10c390fce8e11ddc7277d34ea7e677484\", \"midi_unittests\": \"b504af9a058f3d336bd526e6185542341c4bd88a\", \"mojo_core_unittests\": \"16a9134aa42ad060c17ac60f56ed8b8b730fa3f8\", \"mojo_unittests\": \"dfada091c80b8625300bf6acbe233e8c0589a889\", \"nacl_helper_nonsfi_unittests\": \"63c9166f7d293f83fed335b45054de0643144f61\", \"nacl_loader_unittests\": \"18ccdabfc38c6cbdb4830f9f8c234fd9f7fc9a48\", \"native_theme_unittests\": \"4bbe5235b9aa497140e374636924cd509c678f4b\", \"net_unittests\": \"35a3d87d89ddd1dfd43dbb4d6f7aed8947961cc6\", \"pdf_unittests\": \"a39fc2b3095a9c76b58a2ea9142f3c19afc8a9f8\", \"perfetto_unittests\": \"d847a218c49b9a5440bc2c20eb783c0ea92d5484\", \"ppapi_unittests\": \"6d68b725f7d2c61c4d8d3551e56f6740c15d72e3\", \"printing_unittests\": \"cc2f208ba4cbe74c156ccf6d26bcd6a561483b2b\", \"remoting_unittests\": \"54c732197234d62e46795b19223cf8cab4407ebd\", \"sandbox_linux_unittests\": \"47eaeb1c3b410cfe232c2b28190c7df8417f88a2\", \"service_manager_unittests\": \"97222d09366bc2221c28fe781526c1e35c41a13c\", \"services_unittests\": \"25ade15b345a0397b8b7c1a6b6fef806dbd45274\", \"shell_dialogs_unittests\": \"c29a873dd7e8fabce03704ef2b8a008f6e6f51a4\", \"skia_unittests\": \"7d1a99aa1104afbef612df5bec604f376460a608\", \"snapshot_unittests\": \"bab3e76fc389fe8c1412bb2a08e3050cf8e93f97\", \"sql_unittests\": \"5e4d0a9d12152d0983c19dec049839281956c515\", \"storage_unittests\": \"884c3f992ab583ee05792b37ba05a7ca207ed7df\", \"sync_integration_tests\": \"f56ca702f4ea4e1abcd5aad8c3dfd80e9944db0c\", \"telemetry_gpu_unittests\": \"5a27c23a8a8b9d5b0f9dc1be515afaf670e2969c\", \"telemetry_perf_unittests\": \"c45e9cdf4814ab95938de4b18b75b92b2317fdcf\", \"telemetry_unittests\": \"3fd94f6dd843319066e9b23ebee5005d5bb1debd\", \"traffic_annotation_auditor_unittests\": \"07c253e83a787518a2f277c4fb02d13ae27df7cb\", \"ui_base_unittests\": \"108b51eb214fa30c2a8e766d0e5f31a192ef54e7\", \"ui_touch_selection_unittests\": \"6f99557033dd3e9574a15f819a3d8835c63cae73\", \"unit_tests\": \"450824d0023080d712c63e3055b3ab52470d3eaa\", \"url_unittests\": \"6f548374b8576eaa6b5c3b7011656722ed7071c5\", \"views_perftests\": \"ab75f3f5a9df766f46c2335eebc1ce7545f7c30d\", \"views_unittests\": \"f369adec7d43031734c22e1b70bb7be42eea2ca5\", \"viz_unittests\": \"503822e4facc1dd32937f10bc2c86c65d9371899\", \"vr_common_unittests\": \"6d6457dcd96bb5370013f9c04c85438652a77cbc\", \"vr_pixeltests\": \"9fde4977c9c3bfc9668af4f4673a9d1b0af5f7d7\", \"webdriver_wpt_tests\": \"90417dbf2a1ce82210898e76692a814ea2258708\", \"weblayer_browsertests\": \"55c2cd89286afe22de90822d3c3996c91c7cf323\", \"wm_unittests\": \"a213ace0d5371d5bd2ef62c65db762a2e7f9da37\", \"wtf_unittests\": \"f0141aae154dbd16700118f345ac32b7b9945b99\", \"xr_browser_tests\": \"b52afae360b90f4f9c3490c066dbee7475c1e00d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-58-zr1q\"], \"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\": [\"4801-8ac0b59\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580267352132319",
"status": "COMPLETED",
"status_changed_ts": "1580270272580656",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167965",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6fd7160064963c5eca9c3444554c15cc3f662610",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6fd7160064963c5eca9c3444554c15cc3f662610",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055393629856746688",
"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/8889963567758320400/+/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:4a0813ca3f047010",
"user_agent:luci-scheduler"
],
"updated_ts": "1580270272590175",
"url": "https://ci.chromium.org/b/8889963567758320400",
"utcnow_ts": "1580270273350201"
}
}
[03:57:53.361] Invocation finished in 53m0.896936096s with status SUCCEEDED