[12:29:27.290] New invocation is queued and will start shortly
[12:29:28.705] Starting the invocation (attempt 1)
[12:29:28.742] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:29:28.742] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:29:28.742] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022833798609315872",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"559742ff90a51253bcb104cb0c2cd6ab323fab6c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022833798609315872",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/559742ff90a51253bcb104cb0c2cd6ab323fab6c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/559742ff90a51253bcb104cb0c2cd6ab323fab6c",
"gitiles_ref:refs/heads/master"
]
}
[12:29:29.454] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611318568853087",
"id": "8857403736304247872",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"559742ff90a51253bcb104cb0c2cd6ab323fab6c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611318569254338",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179892",
"builder:Linux Builder (dbg)",
"buildset:commit/git/559742ff90a51253bcb104cb0c2cd6ab323fab6c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/559742ff90a51253bcb104cb0c2cd6ab323fab6c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022833798609315872",
"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/8857403736304247872/+/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": "1611318569254495",
"url": "https://ci.chromium.org/b/8857403736304247872",
"utcnow_ts": "1611318569442661"
}
}
[12:29:29.454] Task URL: https://ci.chromium.org/b/8857403736304247872
[12:29:29.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:2:0) after 1m0s
[12:30:18.826] Received PubSub notification, asking Buildbucket for the build status
[12:30:18.911] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:29.612] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:2:0)
[12:30:29.612] Timer tick, asking Buildbucket for the build status
[12:30:29.742] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:29.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:4:0) after 1m0s
[12:31:29.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:4:0)
[12:31:29.946] Timer tick, asking Buildbucket for the build status
[12:31:30.249] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:30.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:5:0) after 1m0s
[12:32:30.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:5:0)
[12:32:30.514] Timer tick, asking Buildbucket for the build status
[12:32:30.951] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:30.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:6:0) after 1m0s
[12:33:31.069] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:6:0)
[12:33:31.069] Timer tick, asking Buildbucket for the build status
[12:33:31.158] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:31.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:7:0) after 1m0s
[12:34:31.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:7:0)
[12:34:31.233] Timer tick, asking Buildbucket for the build status
[12:34:31.333] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:31.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:8:0) after 1m0s
[12:35:31.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:8:0)
[12:35:31.437] Timer tick, asking Buildbucket for the build status
[12:35:32.125] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:32.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:9:0) after 1m0s
[12:36:32.206] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:9:0)
[12:36:32.206] Timer tick, asking Buildbucket for the build status
[12:36:32.260] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:32.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:10:0) after 1m0s
[12:37:32.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:10:0)
[12:37:32.352] Timer tick, asking Buildbucket for the build status
[12:37:32.447] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:32.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:11:0) after 1m0s
[12:38:32.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:11:0)
[12:38:32.520] Timer tick, asking Buildbucket for the build status
[12:38:32.575] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:32.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:12:0) after 1m0s
[12:39:32.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:12:0)
[12:39:32.622] Timer tick, asking Buildbucket for the build status
[12:39:32.736] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:32.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:13:0) after 1m0s
[12:40:32.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:13:0)
[12:40:32.795] Timer tick, asking Buildbucket for the build status
[12:40:33.094] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:33.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:14:0) after 1m0s
[12:41:33.160] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:14:0)
[12:41:33.160] Timer tick, asking Buildbucket for the build status
[12:41:33.452] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:33.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:15:0) after 1m0s
[12:42:33.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:15:0)
[12:42:33.477] Timer tick, asking Buildbucket for the build status
[12:42:33.538] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:33.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:16:0) after 1m0s
[12:43:33.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:16:0)
[12:43:33.545] Timer tick, asking Buildbucket for the build status
[12:43:33.817] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:33.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:17:0) after 1m0s
[12:44:33.858] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:17:0)
[12:44:33.858] Timer tick, asking Buildbucket for the build status
[12:44:33.990] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:33.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:18:0) after 1m0s
[12:45:34.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:18:0)
[12:45:34.043] Timer tick, asking Buildbucket for the build status
[12:45:34.229] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:34.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:19:0) after 1m0s
[12:46:34.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:19:0)
[12:46:34.291] Timer tick, asking Buildbucket for the build status
[12:46:34.352] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:34.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:20:0) after 1m0s
[12:47:34.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:20:0)
[12:47:34.386] Timer tick, asking Buildbucket for the build status
[12:47:34.443] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:34.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:21:0) after 1m0s
[12:48:34.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:21:0)
[12:48:34.464] Timer tick, asking Buildbucket for the build status
[12:48:34.519] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:34.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:22:0) after 1m0s
[12:49:34.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:22:0)
[12:49:34.545] Timer tick, asking Buildbucket for the build status
[12:49:34.682] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:34.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:23:0) after 1m0s
[12:50:34.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:23:0)
[12:50:34.756] Timer tick, asking Buildbucket for the build status
[12:50:35.039] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:35.039] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:24:0) after 1m0s
[12:51:35.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:24:0)
[12:51:35.038] Timer tick, asking Buildbucket for the build status
[12:51:35.108] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:35.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:25:0) after 1m0s
[12:52:35.140] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:25:0)
[12:52:35.140] Timer tick, asking Buildbucket for the build status
[12:52:35.301] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:35.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:26:0) after 1m0s
[12:53:35.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:26:0)
[12:53:35.368] Timer tick, asking Buildbucket for the build status
[12:53:35.637] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:35.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:27:0) after 1m0s
[12:54:35.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:27:0)
[12:54:35.680] Timer tick, asking Buildbucket for the build status
[12:54:35.808] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:35.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:28:0) after 1m0s
[12:55:35.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:28:0)
[12:55:35.832] Timer tick, asking Buildbucket for the build status
[12:55:35.934] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:35.934] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:29:0) after 1m0s
[12:56:36.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:29:0)
[12:56:36.029] Timer tick, asking Buildbucket for the build status
[12:56:36.104] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:36.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:30:0) after 1m0s
[12:57:36.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:30:0)
[12:57:36.147] Timer tick, asking Buildbucket for the build status
[12:57:36.252] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:36.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:31:0) after 1m0s
[12:58:36.234] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:31:0)
[12:58:36.234] Timer tick, asking Buildbucket for the build status
[12:58:37.024] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:37.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:32:0) after 1m0s
[12:59:37.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:32:0)
[12:59:37.045] Timer tick, asking Buildbucket for the build status
[12:59:43.422] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:43.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:33:0) after 1m0s
[13:00:43.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:33:0)
[13:00:43.597] Timer tick, asking Buildbucket for the build status
[13:00:43.763] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:43.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:34:0) after 1m0s
[13:01:44.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:34:0)
[13:01:44.006] Timer tick, asking Buildbucket for the build status
[13:01:44.077] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:44.077] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:35:0) after 1m0s
[13:02:44.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:35:0)
[13:02:44.129] Timer tick, asking Buildbucket for the build status
[13:02:44.279] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:44.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:36:0) after 1m0s
[13:03:44.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:36:0)
[13:03:44.399] Timer tick, asking Buildbucket for the build status
[13:03:44.467] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:44.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:37:0) after 1m0s
[13:04:44.494] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:37:0)
[13:04:44.494] Timer tick, asking Buildbucket for the build status
[13:04:44.640] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:44.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:38:0) after 1m0s
[13:05:44.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:38:0)
[13:05:44.700] Timer tick, asking Buildbucket for the build status
[13:05:44.769] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:44.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:39:0) after 1m0s
[13:06:44.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:39:0)
[13:06:44.797] Timer tick, asking Buildbucket for the build status
[13:06:44.993] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:44.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:40:0) after 1m0s
[13:07:45.019] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:40:0)
[13:07:45.019] Timer tick, asking Buildbucket for the build status
[13:07:45.079] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:45.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:41:0) after 1m0s
[13:08:45.104] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:41:0)
[13:08:45.104] Timer tick, asking Buildbucket for the build status
[13:08:45.255] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:45.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:42:0) after 1m0s
[13:09:45.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:42:0)
[13:09:45.317] Timer tick, asking Buildbucket for the build status
[13:09:45.773] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:45.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:43:0) after 1m0s
[13:10:45.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:43:0)
[13:10:45.910] Timer tick, asking Buildbucket for the build status
[13:10:46.516] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:46.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:44:0) after 1m0s
[13:11:46.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:44:0)
[13:11:46.558] Timer tick, asking Buildbucket for the build status
[13:11:46.822] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:46.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:45:0) after 1m0s
[13:12:46.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:45:0)
[13:12:46.872] Timer tick, asking Buildbucket for the build status
[13:12:47.032] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:47.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:46:0) after 1m0s
[13:13:47.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:46:0)
[13:13:47.052] Timer tick, asking Buildbucket for the build status
[13:13:47.158] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:47.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:47:0) after 1m0s
[13:14:47.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:47:0)
[13:14:47.193] Timer tick, asking Buildbucket for the build status
[13:14:48.312] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:48.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:48:0) after 1m0s
[13:15:48.345] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:48:0)
[13:15:48.345] Timer tick, asking Buildbucket for the build status
[13:15:48.532] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:48.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:49:0) after 1m0s
[13:16:48.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:49:0)
[13:16:48.575] Timer tick, asking Buildbucket for the build status
[13:16:48.632] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:48.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:50:0) after 1m0s
[13:17:48.653] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:50:0)
[13:17:48.653] Timer tick, asking Buildbucket for the build status
[13:17:48.723] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:48.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:51:0) after 1m0s
[13:18:48.838] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:51:0)
[13:18:48.838] Timer tick, asking Buildbucket for the build status
[13:18:48.941] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:48.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:52:0) after 1m0s
[13:19:48.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:52:0)
[13:19:48.990] Timer tick, asking Buildbucket for the build status
[13:19:49.331] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:49.331] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:53:0) after 1m0s
[13:20:49.378] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:53:0)
[13:20:49.378] Timer tick, asking Buildbucket for the build status
[13:20:49.441] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:49.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:54:0) after 1m0s
[13:21:49.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:54:0)
[13:21:49.553] Timer tick, asking Buildbucket for the build status
[13:21:49.881] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:49.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:55:0) after 1m0s
[13:22:49.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:55:0)
[13:22:49.974] Timer tick, asking Buildbucket for the build status
[13:22:50.124] Build 8857403736304247872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:50.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022833798609315872:56:0) after 1m0s
[13:23:08.711] Received PubSub notification, asking Buildbucket for the build status
[13:23:08.814] Build 8857403736304247872: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:23:08.815] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611321787725833",
"created_by": "project:chromium",
"created_ts": "1611318568853087",
"id": "8857403736304247872",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"559742ff90a51253bcb104cb0c2cd6ab323fab6c\"}}",
"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\": \"559742ff90a51253bcb104cb0c2cd6ab323fab6c\", \"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-124-9yhv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179892, \"got_angle_revision\": \"c827ccbb58b8ceef91628527bad74fc90b135b61\", \"got_dawn_revision\": \"db383498c5c68ccc3c0eb10a72369c8dbe1c476a\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"559742ff90a51253bcb104cb0c2cd6ab323fab6c\", \"got_revision_cp\": \"refs/heads/master@{#846070}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1d5174b9dc3be500d63daf227b163b5e86bbc7b5\", \"got_v8_revision\": \"49fd77f34678eb5d0c7f02fc0929701f5e180928\", \"got_v8_revision_cp\": \"refs/heads/9.0.49@{#1}\", \"got_webrtc_revision\": \"e4fd1ba3198932d4c4ca0e0cc98635758555adee\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33053}\", \"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\": \"559742ff90a51253bcb104cb0c2cd6ab323fab6c\", \"swarm_hashes_refs/heads/master(at){#846070}_without_patch\": {\"absl_hardening_tests\": \"5db283a78405a38b64dda904f2ba083b9e7a908e\", \"accessibility_unittests\": \"d6f10b23b06cbe3068bd3edd3447cb37e4e23f3c\", \"angle_unittests\": \"b9d6ff342b089c6ee0b5e859c0c5f4b9a5a95112\", \"app_shell_unittests\": \"27140123e3f43fc79a1f4658f81e75992eedeea1\", \"aura_unittests\": \"3b3369be7090a240e4cc0dc3b834bff2f2367559\", \"base_unittests\": \"b26d17cacb8d3b344e9bd069be570d5b707152d6\", \"base_util_unittests\": \"df0a9b4291b02771c684c231dd8b49ecf745b44c\", \"blink_common_unittests\": \"ec184802c7d439f1d764061fb98074ef01730333\", \"blink_fuzzer_unittests\": \"1f976bbd501c38343a52d05fe17731092931d24b\", \"blink_heap_unittests\": \"15517e32ae57e5e0e9171587d8c4f685ad64ec91\", \"blink_platform_unittests\": \"64d7ea6a90c9f54e19bd2137698b71d080aee6a4\", \"blink_python_tests\": \"640b849dd198ce198e2565d27922e8286f464d63\", \"blink_unittests\": \"b33a7282746aefc90c6cd9710132dd501bdf7423\", \"blink_web_tests\": \"01b8738e9f9dcf52e8cf78d3de7605bfa9f8ccaa\", \"boringssl_crypto_tests\": \"9099528c8443a981b121af573701ecd1c4f66552\", \"boringssl_ssl_tests\": \"8fc066c14455d9f00166550b6f1a52149b733130\", \"browser_tests\": \"345556aa97815521c2eb4ffd4472b0a0806ee9d5\", \"capture_unittests\": \"f78c9338acefeff5844d16aa0af2883764bae817\", \"cast_unittests\": \"1e07ec952aa70dbe71b7cb2b4dfc0ce11fc6f53a\", \"cc_unittests\": \"3ce8b0946c6aab5b11308254fe572ada02b26742\", \"chrome_app_unittests\": \"fcf894d672bec5a6bbc2afaf0efee95e58699dda\", \"chromedriver_unittests\": \"dd7a74955ece7191e2701fbb7dbf2590f3858938\", \"components_browsertests\": \"15c55b17b729458f2196352bdfb9b779cd628742\", \"components_unittests\": \"450a97436a34a55c92f4427139e4b1ee7469ffcd\", \"compositor_unittests\": \"28928cf1c42d7d230d00dce4028a8997b017c8ee\", \"content_browsertests\": \"a6cf1b4c82eb340225c6713e4a84f6b465962f1d\", \"content_shell_crash_test\": \"a84ebf1693853f7d34307a32b442cb2eeb99a391\", \"content_unittests\": \"981d58776e4e83bdf5b7a4920430d48cd71d65b1\", \"crashpad_tests\": \"3a6eb2901bf02d4d14eeb2bbdcad9d51c682cee2\", \"cronet_tests\": \"ebce2b945195f152227a8de4af52ba031a33d3ba\", \"cronet_unittests\": \"767d06813f17fef1222560632c2095afc78291d0\", \"crypto_unittests\": \"f039e1f70f1939cea5f26cd1ff9f983f6b6ac066\", \"dbus_unittests\": \"24338792cc56e68d49ccab6b6fc7b7008d4c8c00\", \"device_unittests\": \"658a768d86ded3f1abcf12bd6cf1d3c73719c528\", \"display_unittests\": \"d331b5aa0f8a70ae9ebae6c9c30d5f1a91d43247\", \"events_unittests\": \"1415b1d0452e87e1fca51c53c236af4ab3db0e4e\", \"extensions_browsertests\": \"184c99830127377862d00f058a935b74b28f0fdc\", \"extensions_unittests\": \"069883108cabe6f75882c166f351a5023fceda47\", \"filesystem_service_unittests\": \"b69ef7f408e7777d03f3bb5e120b6ab61152a107\", \"flatbuffers_unittests\": \"bc94b5892d7faa8d4260fa7d28e336b3c313737d\", \"gcm_unit_tests\": \"aa0338d2096fb52aa248412b3580d2d3a192cc3f\", \"gfx_unittests\": \"fbb62da68e55fdfd73e6062967ac5b6ef3f4e3ae\", \"gin_unittests\": \"c75f622a271507b4f08904078c4355408ac345ef\", \"google_apis_unittests\": \"0fd919359f2e7a461db70481b5912ca6c3af4861\", \"gpu_unittests\": \"f0d648fe00ac63c3482cea7771e33ee49b80f75c\", \"grit_python_unittests\": \"0b6d4d52edfdb860d49b4e2f566968b0e84ea187\", \"gwp_asan_unittests\": \"f73d566bc72b2e3ae000674912b6717ec11ac06a\", \"headless_browsertests\": \"212b3d9a16a9521b06f96b8e2458ef8d3196e798\", \"headless_unittests\": \"0cbe01651b0205e605fbab16f63d264af19f511d\", \"interactive_ui_tests\": \"37baf92931274bab48e836ce1853e2d9232c7fe6\", \"ipc_tests\": \"a5c4ab2885a1d96329c0ce8130836d2e97818a55\", \"jingle_unittests\": \"a8bc396528ca25673694cacbfecdff94a217a089\", \"latency_unittests\": \"c51605939e27a330c8d66fef4ac5e786b0c6db80\", \"libjingle_xmpp_unittests\": \"708dc2d386008e4ebf32d593923c61d8346546e0\", \"liburlpattern_unittests\": \"dc18efcd712fac81ec2b414ed8dc8393ffb643bd\", \"media_blink_unittests\": \"b027364a8cd63ddae4e61c3b4528dd502a1ab0b6\", \"media_unittests\": \"91ab10d3f43124eb7a7f8fadaf9b0d9c1dcc2726\", \"message_center_unittests\": \"f29fca276c39bba14b6d32415ea15d8b03105c0c\", \"metrics_python_tests\": \"31c1f2340ff91efee9fbda8eb33591f40032cf86\", \"midi_unittests\": \"a449b0912daef3290005df16075477cf1f4ac6be\", \"mojo_core_unittests\": \"682a3a44449ecdd0105439b6e413eae4d55f9d04\", \"mojo_unittests\": \"4414896fbeaa1546a7b41bb54aadba337baa9301\", \"nacl_helper_nonsfi_unittests\": \"c56e5eda19cf5e9aa4ea78cbc09519bfe41bd48e\", \"nacl_loader_unittests\": \"5afa61929585ef4dbdc4fc5ee10a9b96fd021a07\", \"native_theme_unittests\": \"8b0638ca6563da2f4a894b31135bdb657966ba0e\", \"net_unittests\": \"60159e01961464286c44c752dd8837b924bb58db\", \"openscreen_unittests\": \"93c8b9509bd212e361f9af49eec1f9608b81c85f\", \"pdf_unittests\": \"bbf90910194dc6e073a00cb0b4fc811a5b782a8e\", \"perfetto_unittests\": \"4524aa9e6b9459d48174bb78a3dda9ca3d017662\", \"ppapi_unittests\": \"abd198e48488876c553feeae019d0f31606a8463\", \"printing_unittests\": \"ed624fdb619f5b29bce0973d3101a0a24039b6a4\", \"remoting_unittests\": \"32afb9e991aefe7e743ccf124c73d440ff50942c\", \"sandbox_linux_unittests\": \"32b45522fe2a5d2e6c54fdfb9e58fd9f35b4fa88\", \"service_manager_unittests\": \"9186870cbcac099b1cb905df38f13664fa4aec03\", \"services_unittests\": \"11a7568c2ddfa981639b12ecda98dd104f26ca28\", \"shell_dialogs_unittests\": \"24541f3ac3e31a5e471eb9779a8bfb363e76173c\", \"skia_unittests\": \"9a9087bb78676c835d9a70d955a80ca2cdf3dc74\", \"snapshot_unittests\": \"15d5d92722e36750e673365a940590d0fc6d2215\", \"sql_unittests\": \"13e23c8b57e41044781b73baef4af3cc25aa1262\", \"storage_unittests\": \"22596c7da5bd91129968fd917be5476701330d3c\", \"sync_integration_tests\": \"4e472027c8a701b9fcd0535ce611a4d1da540bb0\", \"telemetry_gpu_unittests\": \"52c2d338af4714b862ce73975902acaa67c09984\", \"telemetry_perf_unittests\": \"fe6eb57f6b5c9d6667c020e14173ab54bb88d665\", \"telemetry_unittests\": \"1640970ddda9d259e667ed76de1c50be72572f45\", \"traffic_annotation_auditor_unittests\": \"c2e897c1aa1f414648046d45873d306e79a5707d\", \"ui_base_unittests\": \"21040e4579ff5d565410cc4f6c4d1aa3eb3d6399\", \"ui_touch_selection_unittests\": \"a3b81215d8c787d564eaa31da598d5d204df6f42\", \"unit_tests\": \"89c3ec467225daa45e4152927154a2090372c5fa\", \"url_unittests\": \"16760361dc6fdddebd681624e6fbdc087993ca37\", \"views_perftests\": \"158879374d6202c470c7cf703d4dc8f94fb09fe2\", \"views_unittests\": \"30c3c312394a8d282c76f504d6c4de9f9680ad4b\", \"viz_unittests\": \"e7f0d3ab87ff452220067ed312af015f2d58f5c0\", \"vr_common_unittests\": \"510ca8a395bad86588bb7182cf4b171dba793ea9\", \"vr_pixeltests\": \"ec697027d2b05af95550be6d06404b80f6e9214e\", \"webdriver_wpt_tests\": \"90f981eddf5758feff7662a48dfb4af2c3ec7bcb\", \"weblayer_browsertests\": \"81fcbe2726b12b640b80066cf704ab50878426ae\", \"weblayer_unittests\": \"f743b58c06509d1daa6125a078fb99d3613fb68e\", \"wm_unittests\": \"fe076018c6b2d6a4d8ea6d97a54e6e4d194ce3db\", \"wtf_unittests\": \"10b7c454b0f8ebc55215ef2456211990bd1a1649\", \"x11_unittests\": \"70bc07e90ecac6bcba78a39ff75ebbc745fe14ef\", \"xr_browser_tests\": \"7a7eb602d6cd07dced7c2a430df964fb06ade29c\", \"zlib_unittests\": \"bfdb5e68e969c0be140b03002fa5ad1db8c28987\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_47c3ec4238d3b3d0448e41826f5b2c1435e77a4255b8c93aa27077a59a7a5a67_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_874b300c24913e8fd09d4e55502c2323a0d822e7e1e6984eec8382ff1b789e99_v2\", \"builder_d1ade7eeaf5d4bfec46cdcc4260ff7266c5ca5ac9f935f1643683e9e2b66e303_v2\", \"builder_e0d3a8c5b74a8b9e2a6656b2b613ed1c1629c2e0335e57d66a6def72c72861a0_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-124-9yhv\"], \"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\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611318617508179",
"status": "COMPLETED",
"status_changed_ts": "1611321788247805",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179892",
"builder:Linux Builder (dbg)",
"buildset:commit/git/559742ff90a51253bcb104cb0c2cd6ab323fab6c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/559742ff90a51253bcb104cb0c2cd6ab323fab6c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022833798609315872",
"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/8857403736304247872/+/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:5142e3b3abdf5010",
"user_agent:luci-scheduler"
],
"updated_ts": "1611321788353972",
"url": "https://ci.chromium.org/b/8857403736304247872",
"utcnow_ts": "1611321788804644"
}
}
[13:23:08.815] Invocation finished in 53m41.542449868s with status SUCCEEDED