[13:23:48.303] New invocation is queued and will start shortly
[13:23:49.353] Starting the invocation (attempt 1)
[13:23:49.390] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:23:49.390] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:23:49.390] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022196200426596064",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f29f4d81725e62dff3dd7345e0740c42cdf16925\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022196200426596064",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/f29f4d81725e62dff3dd7345e0740c42cdf16925",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f29f4d81725e62dff3dd7345e0740c42cdf16925",
"gitiles_ref:refs/heads/master"
]
}
[13:23:50.003] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611926629500585",
"id": "8856766138503487424",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f29f4d81725e62dff3dd7345e0740c42cdf16925\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611926629853331",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180098",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f29f4d81725e62dff3dd7345e0740c42cdf16925",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f29f4d81725e62dff3dd7345e0740c42cdf16925",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022196200426596064",
"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/8856766138503487424/+/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": "1611926629853442",
"url": "https://ci.chromium.org/b/8856766138503487424",
"utcnow_ts": "1611926629997183"
}
}
[13:23:50.003] Task URL: https://ci.chromium.org/b/8856766138503487424
[13:23:50.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:2:0) after 1m0s
[13:24:19.761] Received PubSub notification, asking Buildbucket for the build status
[13:24:19.868] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:50.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:2:0)
[13:24:50.114] Timer tick, asking Buildbucket for the build status
[13:24:50.741] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:50.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:4:0) after 1m0s
[13:25:50.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:4:0)
[13:25:50.844] Timer tick, asking Buildbucket for the build status
[13:25:51.371] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:51.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:5:0) after 1m0s
[13:26:51.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:5:0)
[13:26:51.406] Timer tick, asking Buildbucket for the build status
[13:26:51.512] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:51.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:6:0) after 1m0s
[13:27:51.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:6:0)
[13:27:51.631] Timer tick, asking Buildbucket for the build status
[13:27:51.954] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:51.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:7:0) after 1m0s
[13:28:51.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:7:0)
[13:28:51.979] Timer tick, asking Buildbucket for the build status
[13:28:52.494] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:52.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:8:0) after 1m0s
[13:29:52.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:8:0)
[13:29:52.607] Timer tick, asking Buildbucket for the build status
[13:29:52.739] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:52.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:9:0) after 1m0s
[13:30:52.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:9:0)
[13:30:52.864] Timer tick, asking Buildbucket for the build status
[13:30:53.031] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:53.031] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:10:0) after 1m0s
[13:31:53.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:10:0)
[13:31:53.053] Timer tick, asking Buildbucket for the build status
[13:31:53.417] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:53.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:11:0) after 1m0s
[13:32:53.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:11:0)
[13:32:53.460] Timer tick, asking Buildbucket for the build status
[13:32:53.519] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:53.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:12:0) after 1m0s
[13:33:53.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:12:0)
[13:33:53.569] Timer tick, asking Buildbucket for the build status
[13:33:53.681] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:53.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:13:0) after 1m0s
[13:34:53.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:13:0)
[13:34:53.702] Timer tick, asking Buildbucket for the build status
[13:34:54.222] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:54.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:14:0) after 1m0s
[13:35:54.279] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:14:0)
[13:35:54.279] Timer tick, asking Buildbucket for the build status
[13:35:54.354] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:54.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:15:0) after 1m0s
[13:36:54.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:15:0)
[13:36:54.429] Timer tick, asking Buildbucket for the build status
[13:36:54.658] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:54.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:16:0) after 1m0s
[13:37:54.719] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:16:0)
[13:37:54.719] Timer tick, asking Buildbucket for the build status
[13:37:54.769] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:54.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:17:0) after 1m0s
[13:38:54.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:17:0)
[13:38:54.890] Timer tick, asking Buildbucket for the build status
[13:38:54.997] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:54.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:18:0) after 1m0s
[13:39:55.090] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:18:0)
[13:39:55.090] Timer tick, asking Buildbucket for the build status
[13:39:55.160] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:55.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:19:0) after 1m0s
[13:40:55.197] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:19:0)
[13:40:55.197] Timer tick, asking Buildbucket for the build status
[13:40:55.256] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:55.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:20:0) after 1m0s
[13:41:55.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:20:0)
[13:41:55.289] Timer tick, asking Buildbucket for the build status
[13:41:55.350] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:55.350] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:21:0) after 1m0s
[13:42:55.378] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:21:0)
[13:42:55.378] Timer tick, asking Buildbucket for the build status
[13:42:55.445] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:55.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:22:0) after 1m0s
[13:43:55.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:22:0)
[13:43:55.470] Timer tick, asking Buildbucket for the build status
[13:43:55.576] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:55.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:23:0) after 1m0s
[13:44:55.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:23:0)
[13:44:55.608] Timer tick, asking Buildbucket for the build status
[13:44:55.664] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:55.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:24:0) after 1m0s
[13:45:55.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:24:0)
[13:45:55.759] Timer tick, asking Buildbucket for the build status
[13:45:55.827] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:55.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:25:0) after 1m0s
[13:46:55.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:25:0)
[13:46:55.855] Timer tick, asking Buildbucket for the build status
[13:46:55.957] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:55.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:26:0) after 1m0s
[13:47:55.964] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:26:0)
[13:47:55.964] Timer tick, asking Buildbucket for the build status
[13:47:56.042] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:56.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:27:0) after 1m0s
[13:48:56.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:27:0)
[13:48:56.067] Timer tick, asking Buildbucket for the build status
[13:48:56.208] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:56.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:28:0) after 1m0s
[13:49:56.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:28:0)
[13:49:56.223] Timer tick, asking Buildbucket for the build status
[13:49:56.281] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:56.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:29:0) after 1m0s
[13:50:56.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:29:0)
[13:50:56.300] Timer tick, asking Buildbucket for the build status
[13:50:56.430] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:56.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:30:0) after 1m0s
[13:51:56.566] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:30:0)
[13:51:56.566] Timer tick, asking Buildbucket for the build status
[13:51:56.622] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:56.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:31:0) after 1m0s
[13:52:56.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:31:0)
[13:52:56.641] Timer tick, asking Buildbucket for the build status
[13:52:56.718] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:56.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:32:0) after 1m0s
[13:53:56.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:32:0)
[13:53:56.730] Timer tick, asking Buildbucket for the build status
[13:53:56.818] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:56.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:33:0) after 1m0s
[13:54:56.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:33:0)
[13:54:56.836] Timer tick, asking Buildbucket for the build status
[13:54:56.896] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:56.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:34:0) after 1m0s
[13:55:56.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:34:0)
[13:55:56.948] Timer tick, asking Buildbucket for the build status
[13:55:57.026] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:57.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:35:0) after 1m0s
[13:56:57.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:35:0)
[13:56:57.095] Timer tick, asking Buildbucket for the build status
[13:56:57.164] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:57.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:36:0) after 1m0s
[13:57:57.263] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:36:0)
[13:57:57.263] Timer tick, asking Buildbucket for the build status
[13:57:57.317] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:57.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:37:0) after 1m0s
[13:58:58.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:37:0)
[13:58:58.467] Timer tick, asking Buildbucket for the build status
[13:58:58.598] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:58.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:38:0) after 1m0s
[13:59:58.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:38:0)
[13:59:58.810] Timer tick, asking Buildbucket for the build status
[13:59:58.869] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:58.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:39:0) after 1m0s
[14:00:58.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:39:0)
[14:00:58.997] Timer tick, asking Buildbucket for the build status
[14:00:59.798] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:59.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:40:0) after 1m0s
[14:01:59.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:40:0)
[14:01:59.977] Timer tick, asking Buildbucket for the build status
[14:02:00.337] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:00.337] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:41:0) after 1m0s
[14:03:00.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:41:0)
[14:03:00.469] Timer tick, asking Buildbucket for the build status
[14:03:00.685] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:00.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:42:0) after 1m0s
[14:04:01.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:42:0)
[14:04:01.415] Timer tick, asking Buildbucket for the build status
[14:04:01.511] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:01.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:43:0) after 1m0s
[14:05:01.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:43:0)
[14:05:01.561] Timer tick, asking Buildbucket for the build status
[14:05:01.639] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:01.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:44:0) after 1m0s
[14:06:01.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:44:0)
[14:06:01.837] Timer tick, asking Buildbucket for the build status
[14:06:01.962] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:01.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:45:0) after 1m0s
[14:07:02.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:45:0)
[14:07:02.326] Timer tick, asking Buildbucket for the build status
[14:07:02.393] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:02.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:46:0) after 1m0s
[14:08:02.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:46:0)
[14:08:02.454] Timer tick, asking Buildbucket for the build status
[14:08:02.591] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:02.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:47:0) after 1m0s
[14:09:02.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:47:0)
[14:09:02.699] Timer tick, asking Buildbucket for the build status
[14:09:02.797] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:02.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:48:0) after 1m0s
[14:10:02.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:48:0)
[14:10:02.871] Timer tick, asking Buildbucket for the build status
[14:10:03.209] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:03.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:49:0) after 1m0s
[14:11:03.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:49:0)
[14:11:03.401] Timer tick, asking Buildbucket for the build status
[14:11:03.649] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:03.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:50:0) after 1m0s
[14:12:03.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:50:0)
[14:12:03.686] Timer tick, asking Buildbucket for the build status
[14:12:03.745] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:03.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:51:0) after 1m0s
[14:13:03.891] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:51:0)
[14:13:03.891] Timer tick, asking Buildbucket for the build status
[14:13:03.968] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:03.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:52:0) after 1m0s
[14:14:04.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:52:0)
[14:14:04.044] Timer tick, asking Buildbucket for the build status
[14:14:04.503] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:04.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:53:0) after 1m0s
[14:15:04.564] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:53:0)
[14:15:04.564] Timer tick, asking Buildbucket for the build status
[14:15:04.924] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:04.924] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:54:0) after 1m0s
[14:16:05.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:54:0)
[14:16:05.136] Timer tick, asking Buildbucket for the build status
[14:16:06.013] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:06.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:55:0) after 1m0s
[14:17:06.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:55:0)
[14:17:06.072] Timer tick, asking Buildbucket for the build status
[14:17:06.209] Build 8856766138503487424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:06.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022196200426596064:56:0) after 1m0s
[14:17:51.524] Received PubSub notification, asking Buildbucket for the build status
[14:17:51.590] Build 8856766138503487424: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:17:51.590] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611929870516274",
"created_by": "project:chromium",
"created_ts": "1611926629500585",
"id": "8856766138503487424",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f29f4d81725e62dff3dd7345e0740c42cdf16925\"}}",
"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\": \"f29f4d81725e62dff3dd7345e0740c42cdf16925\", \"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-east1-d-8-99-v15v\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180098, \"got_angle_revision\": \"67a84f34080916b233598a7a6d26b9df18e7224a\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"f29f4d81725e62dff3dd7345e0740c42cdf16925\", \"got_revision_cp\": \"refs/heads/master@{#848491}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"89b433d7c3defd04809fba9deb6f8885160044a4\", \"got_v8_revision_cp\": \"refs/heads/9.0.100@{#1}\", \"got_webrtc_revision\": \"54b925cfc2cd7c2f8f83e8e484f281aa87b92dfc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33090}\", \"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\": \"f29f4d81725e62dff3dd7345e0740c42cdf16925\", \"swarm_hashes_refs/heads/master(at){#848491}_without_patch\": {\"absl_hardening_tests\": \"ccfaecddddec9d630d66376412c9fc5ff5f64732\", \"accessibility_unittests\": \"5e2f8655e36d6f5d318ae5d597b9ccccdad72270\", \"angle_unittests\": \"92eb465f3d1ad1850a2e80875aac6dea0dc4ec72\", \"app_shell_unittests\": \"9debe9b6679f559e3667e2b69706d5ab8e8c5120\", \"aura_unittests\": \"202790471ffc1ef97fb4938f6af5ddd2359934d5\", \"base_unittests\": \"2c91e20f4a1f4b7932f6f9a753295eb551c380c7\", \"base_util_unittests\": \"ddb95aa530ba78da2cdeb3c900a6cfa69ffc4807\", \"blink_common_unittests\": \"fe7e1872222b65ce611e1d90bc74e71bc6f64f60\", \"blink_fuzzer_unittests\": \"4a92daf3284ec4395d790373abae3bb5e52fe707\", \"blink_heap_unittests\": \"dea808556a047fbfc181c3edc8783fa83b520936\", \"blink_platform_unittests\": \"8ec3d6a238539c2f979ea9e9aeedf4305065a96c\", \"blink_python_tests\": \"c9741d24d700fd358d62e40e5974eab0d4d39792\", \"blink_unittests\": \"499fd485ae275540d83c1b274d74452c420a7daf\", \"blink_web_tests\": \"b5fb7673a51be4a4dd17b5c16a798fa4d8e498ee\", \"boringssl_crypto_tests\": \"04d939eabbb19483b360ec4366dd3e783c545266\", \"boringssl_ssl_tests\": \"8c1d609f8585bcf1d37a48b6349b68178d680722\", \"browser_tests\": \"54c98828fc5f5b8647e014d8b177269cb7ba6fdd\", \"capture_unittests\": \"b67323f5830a58e51bb81f67492fc1fddbf3a573\", \"cast_unittests\": \"765571fda722516dff290dcc4b774d8eaceb7867\", \"cc_unittests\": \"cd789c1a8c0146497ab19b8e366b7cf349b005f8\", \"chrome_app_unittests\": \"ba1aaae7142196c3edd3c87c0968042336695329\", \"chromedriver_unittests\": \"1f658ef780a653b5e0cf3eb4e4267e96e0999604\", \"components_browsertests\": \"e924345379ab59f53b7dc9e585c4d264b54a8833\", \"components_unittests\": \"c0f2efdcd38356db5e48242e141d77395e9c28e9\", \"compositor_unittests\": \"3f10db9168df3e9018ccc02fad4b440636f22e3a\", \"content_browsertests\": \"3d892579a3373cd131c9b9de088964a70ed4acdc\", \"content_shell_crash_test\": \"dfe5ac86ef265a13b902695febef18bdd25bafbd\", \"content_unittests\": \"743448e69213ed54a5184a452ad1783e64ae26c8\", \"crashpad_tests\": \"d3d86a368b88b05cdae37d03bb1d8bb21de101a4\", \"cronet_tests\": \"2aaf6f0839a78941e14e22a7dec32b027d6454bc\", \"cronet_unittests\": \"4eef8b0f6ed5d104a828e5534fcfedffaf758993\", \"crypto_unittests\": \"ec2ce7ad1599ae775422cbe26406c212b77e2a90\", \"dbus_unittests\": \"9b76ff3902f1e65da9e34eec025910a7e1222895\", \"device_unittests\": \"00052aba349976971390d4842d0d039be979ee2d\", \"display_unittests\": \"5d8a8791f65dd8e9ff1b008a4b78708020727d8c\", \"events_unittests\": \"43d5ba16b7d1cdba5ec3afa44f52d99f9c67175b\", \"extensions_browsertests\": \"6f6db9586124e6dc434eb872e8d47c6775816328\", \"extensions_unittests\": \"519aeae4948bbd11c4f4bb40a8b572d4ff3a5da6\", \"filesystem_service_unittests\": \"319c19c33eb83c52952f163dc776d2c0a589a188\", \"flatbuffers_unittests\": \"abe7737f42a55ed672142d98ab3b938d8384c781\", \"gcm_unit_tests\": \"ac81095cb558aa188057460e91b7e1accd51ca8e\", \"gfx_unittests\": \"fadd8f6d0bb48c107e2c3455a3a98ab474c94eca\", \"gin_unittests\": \"129f89f564464ce09956b57b60c388a4c40bbb8c\", \"google_apis_unittests\": \"c305b94b702ffad567410f74ec630560a27fd8ca\", \"gpu_unittests\": \"e4572f73ac03afdd4485ff7081d4e83f6a2c8b37\", \"grit_python_unittests\": \"b0890b035c0d25a1641db23ae376539c3f64cf64\", \"gwp_asan_unittests\": \"63bec17757a50176e59487eadb45d691ea53b4be\", \"headless_browsertests\": \"4711bafea1c8b4864e4398f31b35401692109e74\", \"headless_unittests\": \"3e4fc79cd2ead08339c18fc12f921aa5f00b3b4e\", \"interactive_ui_tests\": \"a0d90bd3b942ac3cfd27d4ad51a738b67af16c24\", \"ipc_tests\": \"857a15f4ac93e5463ea0bdfb2f1207d38450f283\", \"jingle_unittests\": \"b33331729494d4c64a09e44073490ecf92ff5c09\", \"latency_unittests\": \"44c47cb0265d753572aae8cc6800ff1f5c068185\", \"libjingle_xmpp_unittests\": \"324a3a63d501b8452659f03b186554d065289686\", \"liburlpattern_unittests\": \"49c5ecf09ac609fa4e2f840f93bbbde2034eae58\", \"media_blink_unittests\": \"65ad65b20a326dcf00e396d9587c52e0e7dfa666\", \"media_unittests\": \"29528dc34284aadc382ae1c479400ec9fff84dd6\", \"message_center_unittests\": \"952c83074286be75cd8d893341c2cad67c14be54\", \"metrics_python_tests\": \"2eb31bde1db44a13ed0cc281c05fcb8b9ab666c2\", \"midi_unittests\": \"c732bbbefbe9f0d80b1ec68bcb373c01e0409923\", \"mojo_core_unittests\": \"fabdc6a3ed4367f22975e319652d1968ea5ffc37\", \"mojo_unittests\": \"041692f771b1af74b22db109c0688f8deb2bd6f8\", \"nacl_helper_nonsfi_unittests\": \"1643394b0eda2e10e1a926572998067eeece68f5\", \"nacl_loader_unittests\": \"f0ff42e21d4689a7fc5d5e596f2ba1ffa0a40064\", \"native_theme_unittests\": \"6ff49b010b5177f905d08e350bbd490fef3d5839\", \"net_unittests\": \"17de44907d2644cf712a57721d7f1a11e23e3c2e\", \"openscreen_unittests\": \"f241dd13c909c6901d538c9b10e3ceda48ba53e4\", \"pdf_unittests\": \"ac3aa3021bb7a891583de15e6e6b56c1833494dd\", \"perfetto_unittests\": \"eba4f461a106b70b3ec4f7b34867d181d43a1bbd\", \"ppapi_unittests\": \"a3d7a1b2c359cef94bda030d9574d141c01ac7c0\", \"printing_unittests\": \"f46e6cc98ce9eacb080e165f8935b0154c0d8fb2\", \"remoting_unittests\": \"dcdfbfcd4ba3e078dc761c290d16c5bceebf3cec\", \"sandbox_linux_unittests\": \"a7fe24b07ecec2c63b82ce243c46e02275cf5f1c\", \"service_manager_unittests\": \"b6bfbcb5ff92d180fe43578385bebd551f1e1548\", \"services_unittests\": \"2952f63c339723303c9376e8709c8e29e37986c0\", \"shell_dialogs_unittests\": \"c6d1339c0e0b12d8abb6fb68dd80180191b6b173\", \"skia_unittests\": \"73e6fa6210a8694ee80e4ac63150f6d2ee3e503e\", \"snapshot_unittests\": \"8781bf3245d8e37a238751bd1b2e5ebb966e92b8\", \"sql_unittests\": \"e3036b428e158dc6eec7675e84c4a938f99fd818\", \"storage_unittests\": \"d7b5b6399eea77b382f17dcb0d298062a2429ec4\", \"sync_integration_tests\": \"d2256357cfa6651e2bfe2d58bb6818b964e3b20a\", \"telemetry_gpu_unittests\": \"c62abef1ccaadfe290e60e7328cb4219345bb6e3\", \"telemetry_perf_unittests\": \"9776eb5034570ee6d762c7af1426f0e57206d9db\", \"telemetry_unittests\": \"6eab9049ef56baf7dc63d1ccd87bd03d5a2482cf\", \"traffic_annotation_auditor_unittests\": \"57815c6c253aa39dd051c26893bd165f30282404\", \"ui_base_unittests\": \"24dfc54e2a14d405634d9e652369f05fe61f83c2\", \"ui_touch_selection_unittests\": \"677936f91712110bfe30aa16506ca28f69339912\", \"unit_tests\": \"2ce8960d9e7487d27e95c72f6830b64f16562694\", \"url_unittests\": \"e8312470d9d43e247f6a5fa9311682f3cf8ad140\", \"views_perftests\": \"fa7c9fbdbdd679d7266759c447a981e74fa1014e\", \"views_unittests\": \"b73e98750c0cbcd22e68cc6bd23629da6f175d08\", \"viz_unittests\": \"c1084ccc328e57fbe27c14ff3d8ebfca16a4a704\", \"vr_common_unittests\": \"26888840b4b386290be914e3ddca2de838dda296\", \"vr_pixeltests\": \"8024944fd8934e914356a2d7d30b44b65ee8c7c3\", \"webdriver_wpt_tests\": \"145464da1d43b1c29b0cab9c34e2877adc813e44\", \"weblayer_browsertests\": \"c0c32ba3969aa6c0d378f8cb077252d080b22db4\", \"weblayer_unittests\": \"b5492d37e103c986db88ddbb762575f669c81be3\", \"wm_unittests\": \"8eed3446d8219a89e331c519b718728e5c3310d5\", \"wtf_unittests\": \"c772b8b9896890f80f096d4d7158e533977ccfab\", \"x11_unittests\": \"8d03910559337a61ee8391d1594c6607cdd4cbcd\", \"xr_browser_tests\": \"a66fd1306c6ee80d520ffe612736691e94a39827\", \"zlib_unittests\": \"451a9354cc4691c3843c9ddc6950baff0e055d16\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2bbcd421f4eb1113f3a23522b280d70ced47ef846cc2e40eada60721dff8d17e_v2\", \"builder_3ff20984f80f48d33e2b03ffc12bed5306b6d9761e5e01dd0c6daff69f57abc3_v2\", \"builder_61faa0d0c1c079ecf670d8cfa4f78ad3b1687a5534233c7377462c3ee6819708_v2\", \"builder_a16dce727623db190129e730193443d0ae3080534f372fd612ff56e110b9028d_v2\", \"builder_abe2adbd32ad911c3e8d1f384e915329cf1f65e427edb6b91a9fbb61a55ed743_v2\", \"builder_b492a6a54599c40c9efefa6e5d1cdf990fad3125ae5ed8fb1c6f132ff9c1d569_v2\", \"builder_bbe6c22469d6b45d8f49350e3da0912e9331dc294c727d05ae5755d0a8b95710_v2\", \"builder_cc8a16e85eefa617bab544f2f33977139159d8b8c3b7333fd512c64ffd131f2c_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-east1-d-8-99-v15v\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611926659227619",
"status": "COMPLETED",
"status_changed_ts": "1611929871038736",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180098",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f29f4d81725e62dff3dd7345e0740c42cdf16925",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f29f4d81725e62dff3dd7345e0740c42cdf16925",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022196200426596064",
"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/8856766138503487424/+/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:516721f6c9a73210",
"user_agent:luci-scheduler"
],
"updated_ts": "1611929871044032",
"url": "https://ci.chromium.org/b/8856766138503487424",
"utcnow_ts": "1611929871573293"
}
}
[14:17:51.590] Invocation finished in 54m3.306988437s with status SUCCEEDED