[11:42:09.458] New invocation is queued and will start shortly
[11:42:10.638] Starting the invocation (attempt 1)
[11:42:10.696] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:42:10.696] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:42:10.696] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021749610700549968",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1eda69734ff5b5dfff128fe3ac51508249d3dfef\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021749610700549968",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/1eda69734ff5b5dfff128fe3ac51508249d3dfef",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1eda69734ff5b5dfff128fe3ac51508249d3dfef",
"gitiles_ref:refs/heads/master"
]
}
[11:42:17.663] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612352531176607",
"id": "8856319548227382080",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1eda69734ff5b5dfff128fe3ac51508249d3dfef\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612352536210595",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180233",
"builder:Linux Builder (dbg)",
"buildset:commit/git/1eda69734ff5b5dfff128fe3ac51508249d3dfef",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1eda69734ff5b5dfff128fe3ac51508249d3dfef",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021749610700549968",
"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/8856319548227382080/+/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": "1612352536210876",
"url": "https://ci.chromium.org/b/8856319548227382080",
"utcnow_ts": "1612352537600396"
}
}
[11:42:17.663] Task URL: https://ci.chromium.org/b/8856319548227382080
[11:42:17.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:2:0) after 1m0s
[11:42:29.213] Received PubSub notification, asking Buildbucket for the build status
[11:42:32.409] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:17.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:2:0)
[11:43:17.702] Timer tick, asking Buildbucket for the build status
[11:43:18.171] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:18.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:4:0) after 1m0s
[11:44:18.218] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:4:0)
[11:44:18.218] Timer tick, asking Buildbucket for the build status
[11:44:18.734] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:18.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:5:0) after 1m0s
[11:45:18.755] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:5:0)
[11:45:18.755] Timer tick, asking Buildbucket for the build status
[11:45:19.479] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:19.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:6:0) after 1m0s
[11:46:19.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:6:0)
[11:46:19.600] Timer tick, asking Buildbucket for the build status
[11:46:23.481] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:23.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:7:0) after 1m0s
[11:47:23.537] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:7:0)
[11:47:23.537] Timer tick, asking Buildbucket for the build status
[11:47:24.543] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:24.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:8:0) after 1m0s
[11:48:24.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:8:0)
[11:48:24.617] Timer tick, asking Buildbucket for the build status
[11:48:25.977] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:25.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:9:0) after 1m0s
[11:49:25.985] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:9:0)
[11:49:25.985] Timer tick, asking Buildbucket for the build status
[11:49:27.085] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:27.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:10:0) after 1m0s
[11:50:27.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:10:0)
[11:50:27.116] Timer tick, asking Buildbucket for the build status
[11:50:29.160] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:29.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:11:0) after 1m0s
[11:51:29.218] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:11:0)
[11:51:29.218] Timer tick, asking Buildbucket for the build status
[11:51:30.082] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:30.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:12:0) after 1m0s
[11:52:30.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:12:0)
[11:52:30.123] Timer tick, asking Buildbucket for the build status
[11:52:31.362] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:31.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:13:0) after 1m0s
[11:53:31.382] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:13:0)
[11:53:31.382] Timer tick, asking Buildbucket for the build status
[11:53:32.199] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:32.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:14:0) after 1m0s
[11:54:32.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:14:0)
[11:54:32.262] Timer tick, asking Buildbucket for the build status
[11:54:33.837] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:33.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:15:0) after 1m0s
[11:55:33.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:15:0)
[11:55:33.844] Timer tick, asking Buildbucket for the build status
[11:55:36.889] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:36.889] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:16:0) after 1m0s
[11:56:36.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:16:0)
[11:56:36.909] Timer tick, asking Buildbucket for the build status
[11:56:38.080] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:38.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:17:0) after 1m0s
[11:57:38.144] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:17:0)
[11:57:38.144] Timer tick, asking Buildbucket for the build status
[11:57:40.557] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:40.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:18:0) after 1m0s
[11:58:40.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:18:0)
[11:58:40.738] Timer tick, asking Buildbucket for the build status
[11:58:41.642] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:41.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:19:0) after 1m0s
[11:59:41.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:19:0)
[11:59:41.644] Timer tick, asking Buildbucket for the build status
[11:59:42.390] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:42.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:20:0) after 1m0s
[12:00:42.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:20:0)
[12:00:42.409] Timer tick, asking Buildbucket for the build status
[12:00:45.177] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:45.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:21:0) after 1m0s
[12:01:45.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:21:0)
[12:01:45.179] Timer tick, asking Buildbucket for the build status
[12:01:47.216] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:47.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:22:0) after 1m0s
[12:02:47.370] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:22:0)
[12:02:47.370] Timer tick, asking Buildbucket for the build status
[12:02:50.041] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:50.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:23:0) after 1m0s
[12:03:50.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:23:0)
[12:03:50.373] Timer tick, asking Buildbucket for the build status
[12:03:50.824] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:50.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:24:0) after 1m0s
[12:04:50.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:24:0)
[12:04:50.864] Timer tick, asking Buildbucket for the build status
[12:04:52.906] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:52.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:25:0) after 1m0s
[12:05:53.054] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:25:0)
[12:05:53.054] Timer tick, asking Buildbucket for the build status
[12:05:55.207] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:55.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:26:0) after 1m0s
[12:06:55.306] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:26:0)
[12:06:55.306] Timer tick, asking Buildbucket for the build status
[12:07:04.934] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:04.934] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:27:0) after 1m0s
[12:08:04.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:27:0)
[12:08:04.935] Timer tick, asking Buildbucket for the build status
[12:08:05.179] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:05.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:28:0) after 1m0s
[12:09:05.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:28:0)
[12:09:05.204] Timer tick, asking Buildbucket for the build status
[12:09:16.931] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:16.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:29:0) after 1m0s
[12:10:16.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:29:0)
[12:10:16.955] Timer tick, asking Buildbucket for the build status
[12:10:17.130] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:17.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:30:0) after 1m0s
[12:11:17.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:30:0)
[12:11:17.269] Timer tick, asking Buildbucket for the build status
[12:11:17.581] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:17.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:31:0) after 1m0s
[12:12:17.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:31:0)
[12:12:17.795] Timer tick, asking Buildbucket for the build status
[12:12:18.153] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:18.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:32:0) after 1m0s
[12:13:18.282] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:32:0)
[12:13:18.282] Timer tick, asking Buildbucket for the build status
[12:13:19.477] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:19.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:33:0) after 1m0s
[12:14:19.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:33:0)
[12:14:19.504] Timer tick, asking Buildbucket for the build status
[12:14:20.285] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:20.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:34:0) after 1m0s
[12:15:20.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:34:0)
[12:15:20.361] Timer tick, asking Buildbucket for the build status
[12:15:24.228] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:24.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:35:0) after 1m0s
[12:16:24.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:35:0)
[12:16:24.316] Timer tick, asking Buildbucket for the build status
[12:16:25.076] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:25.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:36:0) after 1m0s
[12:17:25.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:36:0)
[12:17:25.064] Timer tick, asking Buildbucket for the build status
[12:17:26.990] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:26.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:37:0) after 1m0s
[12:18:27.080] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:37:0)
[12:18:27.080] Timer tick, asking Buildbucket for the build status
[12:18:28.713] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:28.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:38:0) after 1m0s
[12:19:28.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:38:0)
[12:19:28.700] Timer tick, asking Buildbucket for the build status
[12:19:28.964] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:28.964] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:39:0) after 1m0s
[12:20:29.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:39:0)
[12:20:29.073] Timer tick, asking Buildbucket for the build status
[12:20:29.885] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:29.885] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:40:0) after 1m0s
[12:21:29.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:40:0)
[12:21:29.908] Timer tick, asking Buildbucket for the build status
[12:21:30.653] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:30.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:41:0) after 1m0s
[12:22:30.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:41:0)
[12:22:30.672] Timer tick, asking Buildbucket for the build status
[12:22:32.054] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:32.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:42:0) after 1m0s
[12:23:32.075] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:42:0)
[12:23:32.075] Timer tick, asking Buildbucket for the build status
[12:23:33.076] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:33.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:43:0) after 1m0s
[12:24:33.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:43:0)
[12:24:33.117] Timer tick, asking Buildbucket for the build status
[12:24:33.368] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:33.368] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:44:0) after 1m0s
[12:25:33.453] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:44:0)
[12:25:33.453] Timer tick, asking Buildbucket for the build status
[12:25:34.135] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:34.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:45:0) after 1m0s
[12:26:34.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:45:0)
[12:26:34.166] Timer tick, asking Buildbucket for the build status
[12:26:34.434] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:34.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:46:0) after 1m0s
[12:27:34.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:46:0)
[12:27:34.481] Timer tick, asking Buildbucket for the build status
[12:27:35.452] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:35.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:47:0) after 1m0s
[12:28:35.594] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:47:0)
[12:28:35.594] Timer tick, asking Buildbucket for the build status
[12:28:36.336] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:36.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:48:0) after 1m0s
[12:29:36.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:48:0)
[12:29:36.415] Timer tick, asking Buildbucket for the build status
[12:29:38.034] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:38.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:49:0) after 1m0s
[12:30:38.131] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:49:0)
[12:30:38.131] Timer tick, asking Buildbucket for the build status
[12:30:38.333] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:38.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:50:0) after 1m0s
[12:31:38.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:50:0)
[12:31:38.548] Timer tick, asking Buildbucket for the build status
[12:31:39.209] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:39.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:51:0) after 1m0s
[12:32:39.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:51:0)
[12:32:39.231] Timer tick, asking Buildbucket for the build status
[12:32:39.524] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:39.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:52:0) after 1m0s
[12:33:39.563] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:52:0)
[12:33:39.563] Timer tick, asking Buildbucket for the build status
[12:33:41.184] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:41.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:53:0) after 1m0s
[12:34:41.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:53:0)
[12:34:41.233] Timer tick, asking Buildbucket for the build status
[12:34:42.988] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:42.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:54:0) after 1m0s
[12:35:43.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:54:0)
[12:35:43.036] Timer tick, asking Buildbucket for the build status
[12:35:45.085] Build 8856319548227382080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:45.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021749610700549968:55:0) after 1m0s
[12:36:30.712] Received PubSub notification, asking Buildbucket for the build status
[12:36:32.954] Build 8856319548227382080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:36:32.954] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612355785989979",
"created_by": "project:chromium",
"created_ts": "1612352531176607",
"id": "8856319548227382080",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1eda69734ff5b5dfff128fe3ac51508249d3dfef\"}}",
"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\": \"1eda69734ff5b5dfff128fe3ac51508249d3dfef\", \"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-16-snpz\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180233, \"got_angle_revision\": \"6cc845bb0a603587ac36b900558d483e05f02f8c\", \"got_dawn_revision\": \"fd5fd05db039710c797ee8bac5e6d999173e5fc3\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"1eda69734ff5b5dfff128fe3ac51508249d3dfef\", \"got_revision_cp\": \"refs/heads/master@{#850062}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"51045556acd0fe0a1b687ef00725a57f0f19a91b\", \"got_v8_revision\": \"53720ace941d84ac17ae67a94166a363dcf0cacf\", \"got_v8_revision_cp\": \"refs/heads/9.0.123@{#1}\", \"got_webrtc_revision\": \"e7c79fd3d66e0f6c54c027f880a8b1682ebae58a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33124}\", \"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\": \"1eda69734ff5b5dfff128fe3ac51508249d3dfef\", \"swarm_hashes_refs/heads/master(at){#850062}_without_patch\": {\"absl_hardening_tests\": \"53d27b8f5869e7eba6acc9065bfa30fe13f0046f\", \"accessibility_unittests\": \"70e25f09024ee440247913578a4b87ec64d6836f\", \"angle_unittests\": \"5b81cb2d6768390585ff973b4b15d6e56155bc92\", \"app_shell_unittests\": \"09fecb24f9a59b9701c7dab5579311bc4ca65d31\", \"aura_unittests\": \"d65d71f2c311d4b77185bdd5b1d797d20ea10f7f\", \"base_unittests\": \"3dd1245bd8784dcd3196fae3fef0c346866d325b\", \"base_util_unittests\": \"dc402434983d4ea722407ae4d5766330f06ef83f\", \"blink_common_unittests\": \"2599ae9f4ef95f7ad7d81b21923e5520888a21c8\", \"blink_fuzzer_unittests\": \"c03754664ddcf782bb7d36cc07ab62b1e7016394\", \"blink_heap_unittests\": \"44448ef46fe913635a575e69ddf74c75a3727d63\", \"blink_platform_unittests\": \"f36406582faace61fce3f0bef94a287aebd4ba32\", \"blink_python_tests\": \"7aa1e1f8e8c2835334ffe95182792f547858e25f\", \"blink_unittests\": \"3bc735cbcf73916bd7bc3f9385480eb5095393d6\", \"blink_web_tests\": \"d79274cf9c61c5bc9f2df322018e2d98dcb6130a\", \"boringssl_crypto_tests\": \"83c2eb822f9a6a25c8f3ba7e99737d309a67ce67\", \"boringssl_ssl_tests\": \"0507f3f1b989466a064744b2095060bd8ae90a2e\", \"browser_tests\": \"7a323fb4e68b5a2cb0e7860b50abf0ec492f7e89\", \"capture_unittests\": \"000b67077b4c44048262d3d5408a42303610e1c7\", \"cast_unittests\": \"424fc1669adcd654a5d653876a8b149b2c6e3c92\", \"cc_unittests\": \"b5bf4fd8d7c97273e5685b152fe6d25955d0ff5f\", \"chrome_app_unittests\": \"8be9cbed01d6df7f5decece5356c8cd6e5e9a66e\", \"chromedriver_unittests\": \"e0164184069d60606551138655b13e1a9b559379\", \"components_browsertests\": \"a02aaef2b583625b960771fa988c0dd687242b52\", \"components_unittests\": \"5148e57b98550fbfcc5fe2859c4f6c59d0b29d54\", \"compositor_unittests\": \"eb1e9eb82e67b8e9bb4b40d34d05c898aa3eb8ee\", \"content_browsertests\": \"19bc5f27e12904a70afac4c7435042d05411a0f2\", \"content_shell_crash_test\": \"adca91b29fc64cfe419c8c6448555cc3d5fcff86\", \"content_unittests\": \"17d50842234a2df8a366d7d39173c648ca13085c\", \"crashpad_tests\": \"1875d11b8c508c40aa6468842896e3e055c9bce9\", \"cronet_tests\": \"39034e591330a7d16ca21431236f5b5bc68c7f9f\", \"cronet_unittests\": \"ea8b2a05befb42563fd9005614353d5675e31d9a\", \"crypto_unittests\": \"76925f57590c1652a4666f30955d5cf713ee37ba\", \"dbus_unittests\": \"0e6018d2a259415a0a83d13b6da4eb1c88233c9d\", \"device_unittests\": \"d230775764e86ff123450d6566915f2da408847e\", \"display_unittests\": \"c7526591799f3ef55f2b1d93115a8cf426031b18\", \"events_unittests\": \"e474d0c2bbb4a6ce4175a86e971bfe3b50cd5a94\", \"extensions_browsertests\": \"0484dfcbad38aff5e44c387e3b9da25c3165d134\", \"extensions_unittests\": \"e10cc682907ae6a19c057f713b78227481870bce\", \"filesystem_service_unittests\": \"42d59bf5868294cd3961aaf38d4cb14398ea25a9\", \"flatbuffers_unittests\": \"abe7737f42a55ed672142d98ab3b938d8384c781\", \"gcm_unit_tests\": \"a24c312bf064458f37d6e1c27504b0c216a8168a\", \"gfx_unittests\": \"1ab4c737654fcbd82fbb1e2cf5b9883bf8972914\", \"gin_unittests\": \"81b76f3ee9c3dc72770fa042140000ed097c897b\", \"google_apis_unittests\": \"6d7901c703231cd2204ea738ce1ac777f4fae69c\", \"gpu_unittests\": \"98d5095e1a23765e0fff7fc0a95be57a0acc841c\", \"grit_python_unittests\": \"0532571aa381198443b89c1ec536d42cf612fc22\", \"gwp_asan_unittests\": \"76c6a21ba45282b2ee154fa2ad48aecf69664e0a\", \"headless_browsertests\": \"60373e7604a9e6aa6f74b9b1c7b090b8ff2cba21\", \"headless_unittests\": \"68741473e93be27cb125d6fe07a3ee44acb93e91\", \"interactive_ui_tests\": \"0dcd43890160c1d63c06b5c80c5c095fe064ff01\", \"ipc_tests\": \"00e788a7409bc270c9de6bcdc0aca4680abfc735\", \"jingle_unittests\": \"e374d2c477e77eb25c826d2875966c1327f1fa75\", \"latency_unittests\": \"4f1ad163984c9a6980aa3453d0d5658b88c45723\", \"libjingle_xmpp_unittests\": \"fbc680b7f943183d295f87f3a061bdf9bcf91ba9\", \"liburlpattern_unittests\": \"f058bdd31897e2ef61d5ccd974076078bfc83b7a\", \"media_blink_unittests\": \"e93388da8ff15bd5d86d74b010670b46e547c235\", \"media_unittests\": \"374aa9a1ff321afbd99b4a43c842907aeb800d52\", \"message_center_unittests\": \"9990253bcac8b783cb6afdb2e7ce245a332f3a74\", \"metrics_python_tests\": \"b14fa95bc2357ed6c2e875d721cc67e3baccee8f\", \"midi_unittests\": \"73230d571f6c08a7b771a427d0accc7200736fed\", \"mojo_core_unittests\": \"ce6f51d4940dc343146fdacf7c295b78dd0d6ff6\", \"mojo_unittests\": \"ffcef76364b57a4527cff754d0964a61a21379e4\", \"nacl_helper_nonsfi_unittests\": \"8fe7b59364ae19a9388ddc299a6de9e343f4c0d5\", \"nacl_loader_unittests\": \"ff06362bb2f7ce126c53ad14cffd86fe78ede6b2\", \"native_theme_unittests\": \"ca2ee18cc2c21a6c505d44f685d899f5799d1c9f\", \"net_unittests\": \"2798c74792c8427cebd4af19a5d6d7722a737037\", \"openscreen_unittests\": \"197cd31aa7614b446d4bcd286e02a770c0f7f5d9\", \"pdf_unittests\": \"440210941dc5a27f3cc0e229fd6c1a52be95db6c\", \"perfetto_unittests\": \"d6287cd1adb41bffc162366b163b61312483e9e0\", \"ppapi_unittests\": \"bb5516a875b2e334b00e18e6f7fb7d85698c701a\", \"printing_unittests\": \"765f6a3285c9751b1a113cedf81f08e6009e0363\", \"remoting_unittests\": \"57f3ded412bec36eca065ee149c5d8efa0507b4d\", \"sandbox_linux_unittests\": \"fc57acb1628a882374df92f4df31a654471bf7df\", \"service_manager_unittests\": \"1b03f52efb7e7d8da8dff4f64f7104b213f14865\", \"services_unittests\": \"d9bce0aaa3ca56844b3291ab19fe6dc6e3785c56\", \"shell_dialogs_unittests\": \"22475bef15bcd83dccdcf8e269a0983b6e7e4c0a\", \"skia_unittests\": \"93a28d26de9110c33c661b2487be0027ea335283\", \"snapshot_unittests\": \"f6a5521fbd914fd59f87a747f834dd1add5f5ea9\", \"sql_unittests\": \"c00a380b34a5e5b5b1cd279d8ff2bb4e01df88dc\", \"storage_unittests\": \"cff9c6ef466884a8dc6d4bb52054fe66b79c42ab\", \"sync_integration_tests\": \"d0e3c43678cadaf0bf1ded2f76e7a4266a388b39\", \"telemetry_gpu_unittests\": \"14fcf0325488ccbc259ba5ee6d49001a36581fd9\", \"telemetry_perf_unittests\": \"d20e75c8be196a0dd2afe41f494795c2203aaa04\", \"telemetry_unittests\": \"b30b8bb1be6d2e623da23b3d9a17d19d4aafcd1b\", \"traffic_annotation_auditor_unittests\": \"024e966120a03e9599edb14cf7315330abc3a4ab\", \"ui_base_unittests\": \"433956da1b4b631103a29d58f6e231d70a3f34f5\", \"ui_touch_selection_unittests\": \"a259cd5c4ba69dd7bbd28008a68dfa8d5e692afc\", \"unit_tests\": \"5c9e0617c26c374b25dc897fd225c6b3cf02ab42\", \"url_unittests\": \"d06e8ec5e4402892f87edd150212439e5bfa0137\", \"views_perftests\": \"f064bf27e6bb523ad645ca1bed86169d5a87ba9d\", \"views_unittests\": \"903fbebbfbc51782b939696c4fc306489d90a527\", \"viz_unittests\": \"da6743d0776f3910546869fea6c613728a0bbe41\", \"vr_common_unittests\": \"08f5a87020b1f8a2aa94151f44582817cb2502f8\", \"vr_pixeltests\": \"b484dfa0b4b8506005b248e4c0795f379abb29fc\", \"webdriver_wpt_tests\": \"fb4ab54fda6bdaf28742d2ccb719a656cf06ca56\", \"weblayer_browsertests\": \"5e0a14fc15012e08acfe9ef4f40f2e3ec8f00ca8\", \"weblayer_unittests\": \"2bff628b736541a484bb7cd7dcbf572b08ed7f21\", \"wm_unittests\": \"61e592d89fd02bfa0bfbf2f9bde370e6a2975fe0\", \"wtf_unittests\": \"d4ba03e218b86fdd462387658fc5dddbba39eb3b\", \"x11_unittests\": \"51552cdb852b799c7c4c8d01f1c225c97f40cbfc\", \"xr_browser_tests\": \"008e6740a9ae0138d30d1949a01d694f823d58c8\", \"zlib_unittests\": \"34c3fe1c19b822d3ddc678e6723801ab2e37fe5e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_678d8b556ed6d2ea4aa43b80debb7b547a1d6d4433ddff28e80ab170912c760d_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_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-16-snpz\"], \"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": "1612352543658841",
"status": "COMPLETED",
"status_changed_ts": "1612355789847464",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180233",
"builder:Linux Builder (dbg)",
"buildset:commit/git/1eda69734ff5b5dfff128fe3ac51508249d3dfef",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1eda69734ff5b5dfff128fe3ac51508249d3dfef",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021749610700549968",
"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/8856319548227382080/+/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:518084cb9570d010",
"user_agent:luci-scheduler"
],
"updated_ts": "1612355789895041",
"url": "https://ci.chromium.org/b/8856319548227382080",
"utcnow_ts": "1612355792789919"
}
}
[12:36:32.955] Invocation finished in 54m23.520785969s with status SUCCEEDED