[01:47:36.182] New invocation is queued and will start shortly
[01:47:37.265] Starting the invocation (attempt 1)
[01:47:37.297] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:47:37.297] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:47:37.298] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021605822907039088",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6a9cebb9c5e91e19958a6940e742b414fbf364f8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021605822907039088",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/6a9cebb9c5e91e19958a6940e742b414fbf364f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6a9cebb9c5e91e19958a6940e742b414fbf364f8",
"gitiles_ref:refs/heads/master"
]
}
[01:47:38.114] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612489657390263",
"id": "8856175760970955744",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6a9cebb9c5e91e19958a6940e742b414fbf364f8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612489657896602",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180288",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6a9cebb9c5e91e19958a6940e742b414fbf364f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6a9cebb9c5e91e19958a6940e742b414fbf364f8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021605822907039088",
"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/8856175760970955744/+/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": "1612489657896747",
"url": "https://ci.chromium.org/b/8856175760970955744",
"utcnow_ts": "1612489658099482"
}
}
[01:47:38.114] Task URL: https://ci.chromium.org/b/8856175760970955744
[01:47:38.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:2:0) after 1m0s
[01:47:42.532] Received PubSub notification, asking Buildbucket for the build status
[01:47:42.687] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:38.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:2:0)
[01:48:38.414] Timer tick, asking Buildbucket for the build status
[01:48:38.613] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:38.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:4:0) after 1m0s
[01:49:38.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:4:0)
[01:49:38.864] Timer tick, asking Buildbucket for the build status
[01:49:38.956] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:38.956] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:5:0) after 1m0s
[01:50:39.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:5:0)
[01:50:39.179] Timer tick, asking Buildbucket for the build status
[01:50:39.362] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:39.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:6:0) after 1m0s
[01:51:39.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:6:0)
[01:51:39.522] Timer tick, asking Buildbucket for the build status
[01:51:39.813] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:39.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:7:0) after 1m0s
[01:52:39.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:7:0)
[01:52:39.979] Timer tick, asking Buildbucket for the build status
[01:52:40.354] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:40.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:8:0) after 1m0s
[01:53:40.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:8:0)
[01:53:40.401] Timer tick, asking Buildbucket for the build status
[01:53:40.612] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:40.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:9:0) after 1m0s
[01:54:40.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:9:0)
[01:54:40.740] Timer tick, asking Buildbucket for the build status
[01:54:41.217] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:41.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:10:0) after 1m0s
[01:55:41.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:10:0)
[01:55:41.231] Timer tick, asking Buildbucket for the build status
[01:55:41.330] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:41.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:11:0) after 1m0s
[01:56:41.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:11:0)
[01:56:41.506] Timer tick, asking Buildbucket for the build status
[01:56:41.736] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:41.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:12:0) after 1m0s
[01:57:41.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:12:0)
[01:57:41.847] Timer tick, asking Buildbucket for the build status
[01:57:42.848] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:42.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:13:0) after 1m0s
[01:58:42.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:13:0)
[01:58:42.937] Timer tick, asking Buildbucket for the build status
[01:58:43.033] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:43.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:14:0) after 1m0s
[01:59:43.182] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:14:0)
[01:59:43.182] Timer tick, asking Buildbucket for the build status
[01:59:43.246] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:43.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:15:0) after 1m0s
[02:00:43.345] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:15:0)
[02:00:43.345] Timer tick, asking Buildbucket for the build status
[02:00:43.931] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:43.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:16:0) after 1m0s
[02:01:44.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:16:0)
[02:01:44.023] Timer tick, asking Buildbucket for the build status
[02:01:44.228] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:44.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:17:0) after 1m0s
[02:02:44.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:17:0)
[02:02:44.388] Timer tick, asking Buildbucket for the build status
[02:02:44.509] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:44.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:18:0) after 1m0s
[02:03:44.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:18:0)
[02:03:44.745] Timer tick, asking Buildbucket for the build status
[02:03:44.817] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:44.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:19:0) after 1m0s
[02:04:44.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:19:0)
[02:04:44.873] Timer tick, asking Buildbucket for the build status
[02:04:45.078] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:45.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:20:0) after 1m0s
[02:05:45.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:20:0)
[02:05:45.124] Timer tick, asking Buildbucket for the build status
[02:05:45.496] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:45.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:21:0) after 1m0s
[02:06:45.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:21:0)
[02:06:45.711] Timer tick, asking Buildbucket for the build status
[02:06:45.841] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:45.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:22:0) after 1m0s
[02:07:45.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:22:0)
[02:07:45.970] Timer tick, asking Buildbucket for the build status
[02:07:46.072] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:46.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:23:0) after 1m0s
[02:08:46.126] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:23:0)
[02:08:46.126] Timer tick, asking Buildbucket for the build status
[02:08:46.203] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:46.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:24:0) after 1m0s
[02:09:46.270] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:24:0)
[02:09:46.270] Timer tick, asking Buildbucket for the build status
[02:09:46.447] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:46.448] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:25:0) after 1m0s
[02:10:46.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:25:0)
[02:10:46.506] Timer tick, asking Buildbucket for the build status
[02:10:46.707] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:46.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:26:0) after 1m0s
[02:11:46.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:26:0)
[02:11:46.782] Timer tick, asking Buildbucket for the build status
[02:11:47.172] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:47.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:27:0) after 1m0s
[02:12:47.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:27:0)
[02:12:47.183] Timer tick, asking Buildbucket for the build status
[02:12:47.278] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:47.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:28:0) after 1m0s
[02:13:47.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:28:0)
[02:13:47.300] Timer tick, asking Buildbucket for the build status
[02:13:47.418] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:47.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:29:0) after 1m0s
[02:14:47.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:29:0)
[02:14:47.393] Timer tick, asking Buildbucket for the build status
[02:14:47.446] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:47.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:30:0) after 1m0s
[02:15:47.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:30:0)
[02:15:47.575] Timer tick, asking Buildbucket for the build status
[02:15:47.804] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:47.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:31:0) after 1m0s
[02:16:47.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:31:0)
[02:16:47.899] Timer tick, asking Buildbucket for the build status
[02:16:47.960] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:47.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:32:0) after 1m0s
[02:17:48.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:32:0)
[02:17:48.134] Timer tick, asking Buildbucket for the build status
[02:17:48.323] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:48.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:33:0) after 1m0s
[02:18:48.427] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:33:0)
[02:18:48.427] Timer tick, asking Buildbucket for the build status
[02:18:48.481] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:48.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:34:0) after 1m0s
[02:19:48.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:34:0)
[02:19:48.511] Timer tick, asking Buildbucket for the build status
[02:19:48.586] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:48.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:35:0) after 1m0s
[02:20:48.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:35:0)
[02:20:48.617] Timer tick, asking Buildbucket for the build status
[02:20:48.927] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:48.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:36:0) after 1m0s
[02:21:48.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:36:0)
[02:21:48.945] Timer tick, asking Buildbucket for the build status
[02:21:49.021] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:49.021] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:37:0) after 1m0s
[02:22:49.070] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:37:0)
[02:22:49.070] Timer tick, asking Buildbucket for the build status
[02:22:49.186] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:49.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:38:0) after 1m0s
[02:23:49.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:38:0)
[02:23:49.336] Timer tick, asking Buildbucket for the build status
[02:23:49.614] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:49.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:39:0) after 1m0s
[02:24:49.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:39:0)
[02:24:49.739] Timer tick, asking Buildbucket for the build status
[02:24:49.951] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:49.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:40:0) after 1m0s
[02:25:49.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:40:0)
[02:25:49.944] Timer tick, asking Buildbucket for the build status
[02:25:50.023] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:50.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:41:0) after 1m0s
[02:26:50.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:41:0)
[02:26:50.066] Timer tick, asking Buildbucket for the build status
[02:26:51.145] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:51.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:42:0) after 1m0s
[02:27:51.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:42:0)
[02:27:51.299] Timer tick, asking Buildbucket for the build status
[02:27:51.410] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:51.410] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:43:0) after 1m0s
[02:28:51.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:43:0)
[02:28:51.516] Timer tick, asking Buildbucket for the build status
[02:28:51.730] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:51.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:44:0) after 1m0s
[02:29:51.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:44:0)
[02:29:51.792] Timer tick, asking Buildbucket for the build status
[02:29:52.025] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:52.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:45:0) after 1m0s
[02:30:52.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:45:0)
[02:30:52.091] Timer tick, asking Buildbucket for the build status
[02:30:52.148] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:52.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:46:0) after 1m0s
[02:31:52.236] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:46:0)
[02:31:52.236] Timer tick, asking Buildbucket for the build status
[02:31:52.338] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:52.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:47:0) after 1m0s
[02:32:52.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:47:0)
[02:32:52.426] Timer tick, asking Buildbucket for the build status
[02:32:52.542] Build 8856175760970955744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:52.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021605822907039088:48:0) after 1m0s
[02:33:08.151] Received PubSub notification, asking Buildbucket for the build status
[02:33:08.605] Build 8856175760970955744: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:33:08.605] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612492387268450",
"created_by": "project:chromium",
"created_ts": "1612489657390263",
"id": "8856175760970955744",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6a9cebb9c5e91e19958a6940e742b414fbf364f8\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"6a9cebb9c5e91e19958a6940e742b414fbf364f8\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-128-wqyx\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180288, \"got_angle_revision\": \"ad985fcdd806a26343b9b5f8408e551b515493e5\", \"got_dawn_revision\": \"4846281d3680e1e34ffeebe556ca25c285bc1151\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"6a9cebb9c5e91e19958a6940e742b414fbf364f8\", \"got_revision_cp\": \"refs/heads/master@{#850905}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"14dcbed947ce755af1fcbfb3ba8e643b4e769860\", \"got_v8_revision\": \"a71154a1ede8ce4ce90eb23ede108aef7e94691d\", \"got_v8_revision_cp\": \"refs/heads/9.0.133@{#1}\", \"got_webrtc_revision\": \"1d71fd9c61db8f1dcf30b5d0625e514b91200926\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33155}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6a9cebb9c5e91e19958a6940e742b414fbf364f8\", \"swarm_hashes_refs/heads/master(at){#850905}_without_patch\": {\"absl_hardening_tests\": \"64a2ea6304758329ae997c4f2facf91180179de0\", \"accessibility_unittests\": \"37e32f4f4f0b6e49a9be69c790c5e66878329caa\", \"angle_unittests\": \"02f4315317aee625a7812e570c62da8ca9387914\", \"app_shell_unittests\": \"526f9e240a903029a7c6d822e485706c315a5035\", \"aura_unittests\": \"89907fee0a7b3aba289bee6a19f8ece74df08ba0\", \"base_unittests\": \"58fbd909b5b299a915adaeb681cb71cc676d6c96\", \"base_util_unittests\": \"0fc6cf4e7f89dd64792aeadb0342a83b957793a8\", \"blink_common_unittests\": \"c0ac987436b5797bafca562abad4139bda7184ed\", \"blink_fuzzer_unittests\": \"53baba2770eda75dda9abc442d8869bdeef7e085\", \"blink_heap_unittests\": \"39ca78ee87811890bddb313d5599f56099c424b1\", \"blink_platform_unittests\": \"f19db842bf23d442277baa2f8e91978b8d88038b\", \"blink_python_tests\": \"5829c47dd196139f964cd51a96565260fef783ff\", \"blink_unittests\": \"a69bac60b44d8cef4b5bbb9a14dc791871d44343\", \"blink_web_tests\": \"6f270be92e9e2aea84dc9aa54718826a7431a30e\", \"boringssl_crypto_tests\": \"77f7b7ff5aca89c7f9620c13bbfe1fcc62442ed0\", \"boringssl_ssl_tests\": \"17dfbb2eacc6c223986094679a83714917d5f65c\", \"browser_tests\": \"713ad02baab475049af2b9ac0747e15ecdf7aa5d\", \"capture_unittests\": \"4eaf1fbbbd5a760543c7340c347994f420e86c1f\", \"cast_unittests\": \"743d9cdf2026e9f0bfd8568d633c1074fc20f798\", \"cc_unittests\": \"edaba4735934c2c9f8bc8e4901b888806ce30cdc\", \"chrome_app_unittests\": \"d66d31a63170700ba2999ecd6c0b6bd3b5fda752\", \"chromedriver_unittests\": \"203305d5a849d1596e6b2e492dbb7d2796b99985\", \"components_browsertests\": \"ec67ff7ddd7accbef553217016500308cc821f47\", \"components_unittests\": \"4c2d5ebb6830166ab4f6a9da357a504b226f761a\", \"compositor_unittests\": \"4aec85f9abd0fe5ae4ab163370a36d5916bc44e4\", \"content_browsertests\": \"0c8bb1ec329598a228ee0a84e020053431242883\", \"content_shell_crash_test\": \"d2f1d93ec07d80f559f66473a08bf8ca91a587bd\", \"content_unittests\": \"77b361862d46060dec12ddd49508c9b0b262a735\", \"crashpad_tests\": \"1361ac91181a166d56ead6c6a017f71a7d2397ae\", \"cronet_tests\": \"e369f00d3146aa54e2ba56ab9ffc01707a540d42\", \"cronet_unittests\": \"b3ed8aae464e0df277c24654aa79f869f6512b03\", \"crypto_unittests\": \"8932744b2df86b87099e89b47d39b94c82c96887\", \"dbus_unittests\": \"06c1cf9e96d81f05a375c369ababfa49d223c911\", \"device_unittests\": \"59088ebb97b2b976cfda020da38a05c8eefff602\", \"display_unittests\": \"ef2144c5a2851606cd24624ce00483c6155b9f7c\", \"events_unittests\": \"fa6dfd81e2f5f5b34fd6f22c2f98979ce683fbf0\", \"extensions_browsertests\": \"dd8f6b2abdba9175ee38317aa51eab615e1bea82\", \"extensions_unittests\": \"5dbec426e7c9cb68537d2bb76fca92e86f3a0e16\", \"filesystem_service_unittests\": \"0bbbbb763803ad0912b4d41870ad0e618e0052aa\", \"flatbuffers_unittests\": \"abe7737f42a55ed672142d98ab3b938d8384c781\", \"gcm_unit_tests\": \"c39a0a5a600fbc7476c3790f5ce77315acb1e4d1\", \"gfx_unittests\": \"8f9178db230f3156388868b495657cd859dac31e\", \"gin_unittests\": \"f3815d677c54dd2335553b65cd2bb673c4dcf6c8\", \"google_apis_unittests\": \"ea6d1aa580587c8c9588529624011c26a61088de\", \"gpu_unittests\": \"569226b457836ed6e454627637bb609e2f8838ab\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"43132f6d62ca486424470ead8b0be8e13704bb5a\", \"headless_browsertests\": \"2191e380e4f88db8659d0c0ad873706bebef8041\", \"headless_unittests\": \"e28570221847b8500613f2cf8b1a96b8057ad050\", \"interactive_ui_tests\": \"d1180fb4f282b6c6923f30d6d8a6075ba22f6006\", \"ipc_tests\": \"e69996ac8c42f320c57db7578edac3b58ec68013\", \"jingle_unittests\": \"9e06500e53f206d4f563ecb0a4cf403e12610d6b\", \"latency_unittests\": \"d40ef2af2ba312ed5f80be1c93d0d88d14d63733\", \"libjingle_xmpp_unittests\": \"70aafe838601d108d12de47c36b2e2b3f38f30f3\", \"liburlpattern_unittests\": \"51c196916cf2ad1d852bb28e739b8b21f65858db\", \"media_blink_unittests\": \"fad1c63edac6ad3922c31698482a28256aca8014\", \"media_unittests\": \"e4c0bb08c3f723aa130f2fc60096952a3a53c88d\", \"message_center_unittests\": \"72fbd75298c7a40c5ed9e0a22d329acfd4233ca5\", \"metrics_python_tests\": \"2b9d68dbf7dab047ebd45efdbe2c08e67081928a\", \"midi_unittests\": \"4cf0a738c401c945b180986f2b8c3321c9125e0c\", \"mojo_core_unittests\": \"9ef2cdc56d19140adf8223bd548444fa2d89490e\", \"mojo_unittests\": \"7aeec8c9bca292a06a055cd2243ec2d8cb234f01\", \"nacl_helper_nonsfi_unittests\": \"70e14c8d4c30192ed31cc0cba0fc715b59ab09e2\", \"nacl_loader_unittests\": \"e5a1d780ce864ab984590d3e92e2ae204a854114\", \"native_theme_unittests\": \"b91e56e01f4917b6fc8b41b22df3212ec59cadc0\", \"net_unittests\": \"3bfd4d2e8c4d87e9377053532ca97ff323904e3d\", \"openscreen_unittests\": \"3751014509389a7fbba826fa1c081b5bde68e145\", \"pdf_unittests\": \"4ed557a43880cb1d3f3b8fc0300fb7d0a56efc99\", \"perfetto_unittests\": \"26e3f7d0811ec18f31f06ad33ac8937e25db5e12\", \"ppapi_unittests\": \"a002c8556afc49b2f61b07e3c88a0df097001d4b\", \"printing_unittests\": \"e60d8c645f81e00976b8c775ddf92cefc19278ad\", \"remoting_unittests\": \"3cab7834a71e620bde89a705e191d1fd1619d02c\", \"sandbox_linux_unittests\": \"99a00635e0623d72bfab1ed5e91ba2ab6f2a9971\", \"service_manager_unittests\": \"3ae50c6e50ee037aa2111ef2e9b752885ae357de\", \"services_unittests\": \"b7f785f9a7ec7604940a3f7e99b1591c49913617\", \"shell_dialogs_unittests\": \"469570e74600e4cd51c3cfea00ec731ff02eaf87\", \"skia_unittests\": \"dc519254ef34acd8d9582c3597f73b6dae899a96\", \"snapshot_unittests\": \"7bfd90dbcf12f16b3c3eb14899fb36495898cf73\", \"sql_unittests\": \"9d36fe525609e612a5a47322491c2be9fb4731b2\", \"storage_unittests\": \"90e5362a98d7457194615be8deff857380f12ea5\", \"sync_integration_tests\": \"66c4440b7e4bb1e71505dc2e25c9427494f3c93f\", \"telemetry_gpu_unittests\": \"4a4dae01cf7bc28a66cc9b13cb777c9b40077c9d\", \"telemetry_perf_unittests\": \"7d3930216b7b77f79d88b10460e1d591af0ca39e\", \"telemetry_unittests\": \"0df851173351a4fcf1e6fb43b63676b7ffe14abc\", \"traffic_annotation_auditor_unittests\": \"d2ede18428523a705d00c600d6d93f3ab4910fb5\", \"ui_base_unittests\": \"1abe2613faea3347a3fe9613f13896669b9cba26\", \"ui_touch_selection_unittests\": \"c02960fefdf730c2e1e180c977104675beb113ce\", \"unit_tests\": \"9bdbe2450e089e0ebc1bcfb670c331909defe769\", \"url_unittests\": \"90cf27c97330b628a0abb32e0cb70c2d7c6e43c5\", \"views_perftests\": \"31b10e9d2ebcc1926b209ced2f283f0398e3eb22\", \"views_unittests\": \"240b0a803c0b546d221a48a29e7df66f978c5d7d\", \"viz_unittests\": \"1d28c8479278dce03b11a90343284e77aabd3e12\", \"vr_common_unittests\": \"1152cdcd1bd94c3e658675b57995d76c8049a141\", \"vr_pixeltests\": \"f19295340fadd7ec21461fe9a4a5d29e8a09991f\", \"webdriver_wpt_tests\": \"b85347da43e037fd50e7cfbb04178522bc1b89b2\", \"weblayer_browsertests\": \"694cce7492f23bb83204515f235e391485cc477e\", \"weblayer_unittests\": \"50e770203f4991765de1533b54a0cdf55b11e71c\", \"wm_unittests\": \"b44f2c048b6ee9d7dd00731690378b668df3096f\", \"wtf_unittests\": \"0a7f23869d72dc1fc23819829b85203184adaaae\", \"x11_unittests\": \"b43ee2f073818e0b0e246a133d5c363e694056d4\", \"xr_browser_tests\": \"ce4c58eac525740660e04201fbed9b8a3374fd5c\", \"zlib_unittests\": \"fec41e3ad94269b70d7ac090728ef942e0f4d763\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_37a6efb75484d21403d66fa62f2f0e5111772231983ba4ec0093d39fca548be8_v2\", \"builder_d3ee47a27de6e242d9ac174bcd2903a12a57590a5abb70af1d9c4989bd7f5749_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-128-wqyx\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612489661863930",
"status": "COMPLETED",
"status_changed_ts": "1612492387829902",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180288",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6a9cebb9c5e91e19958a6940e742b414fbf364f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6a9cebb9c5e91e19958a6940e742b414fbf364f8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021605822907039088",
"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/8856175760970955744/+/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:5188b11801f4b910",
"user_agent:luci-scheduler"
],
"updated_ts": "1612492387834797",
"url": "https://ci.chromium.org/b/8856175760970955744",
"utcnow_ts": "1612492388575360"
}
}
[02:33:08.605] Invocation finished in 45m32.444927203s with status SUCCEEDED