[01:29:55.951] New invocation is queued and will start shortly
[01:29:57.284] Starting the invocation (attempt 1)
[01:29:57.319] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:29:57.319] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:29:57.319] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018979622607238416",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"70cdf0709583860b9ed8da84e0c3344c4dbab9f1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9018979622607238416",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/70cdf0709583860b9ed8da84e0c3344c4dbab9f1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/70cdf0709583860b9ed8da84e0c3344c4dbab9f1",
"gitiles_ref:refs/heads/master"
]
}
[01:29:57.926] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614994197405379",
"id": "8853549560420100944",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"70cdf0709583860b9ed8da84e0c3344c4dbab9f1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614994197775191",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181157",
"builder:Linux Builder (dbg)",
"buildset:commit/git/70cdf0709583860b9ed8da84e0c3344c4dbab9f1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/70cdf0709583860b9ed8da84e0c3344c4dbab9f1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018979622607238416",
"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/8853549560420100944/+/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": "1614994197775334",
"url": "https://ci.chromium.org/b/8853549560420100944",
"utcnow_ts": "1614994197916148"
}
}
[01:29:57.926] Task URL: https://ci.chromium.org/b/8853549560420100944
[01:29:57.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:2:0) after 1m0s
[01:30:01.217] Received PubSub notification, asking Buildbucket for the build status
[01:30:01.315] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:57.957] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:2:0)
[01:30:57.957] Timer tick, asking Buildbucket for the build status
[01:30:59.235] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:59.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:4:0) after 1m0s
[01:31:59.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:4:0)
[01:31:59.261] Timer tick, asking Buildbucket for the build status
[01:31:59.391] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:59.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:5:0) after 1m0s
[01:32:59.449] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:5:0)
[01:32:59.449] Timer tick, asking Buildbucket for the build status
[01:32:59.532] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:59.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:6:0) after 1m0s
[01:33:59.601] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:6:0)
[01:33:59.601] Timer tick, asking Buildbucket for the build status
[01:33:59.756] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:59.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:7:0) after 1m0s
[01:34:59.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:7:0)
[01:34:59.763] Timer tick, asking Buildbucket for the build status
[01:34:59.854] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:59.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:8:0) after 1m0s
[01:35:59.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:8:0)
[01:35:59.917] Timer tick, asking Buildbucket for the build status
[01:35:59.996] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:59.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:9:0) after 1m0s
[01:37:00.089] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:9:0)
[01:37:00.089] Timer tick, asking Buildbucket for the build status
[01:37:00.241] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:00.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:10:0) after 1m0s
[01:38:00.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:10:0)
[01:38:00.516] Timer tick, asking Buildbucket for the build status
[01:38:01.106] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:01.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:11:0) after 1m0s
[01:39:01.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:11:0)
[01:39:01.357] Timer tick, asking Buildbucket for the build status
[01:39:01.438] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:01.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:12:0) after 1m0s
[01:40:01.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:12:0)
[01:40:01.622] Timer tick, asking Buildbucket for the build status
[01:40:01.893] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:01.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:13:0) after 1m0s
[01:41:01.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:13:0)
[01:41:01.917] Timer tick, asking Buildbucket for the build status
[01:41:01.983] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:01.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:14:0) after 1m0s
[01:42:02.026] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:14:0)
[01:42:02.026] Timer tick, asking Buildbucket for the build status
[01:42:02.084] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:02.084] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:15:0) after 1m0s
[01:43:02.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:15:0)
[01:43:02.103] Timer tick, asking Buildbucket for the build status
[01:43:02.229] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:02.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:16:0) after 1m0s
[01:44:02.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:16:0)
[01:44:02.269] Timer tick, asking Buildbucket for the build status
[01:44:02.354] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:02.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:17:0) after 1m0s
[01:45:02.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:17:0)
[01:45:02.369] Timer tick, asking Buildbucket for the build status
[01:45:02.720] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:02.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:18:0) after 1m0s
[01:46:03.922] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:18:0)
[01:46:03.922] Timer tick, asking Buildbucket for the build status
[01:46:04.207] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:04.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:19:0) after 1m0s
[01:47:04.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:19:0)
[01:47:04.686] Timer tick, asking Buildbucket for the build status
[01:47:04.779] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:04.779] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:20:0) after 1m0s
[01:48:04.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:20:0)
[01:48:04.815] Timer tick, asking Buildbucket for the build status
[01:48:04.885] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:04.885] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:21:0) after 1m0s
[01:49:05.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:21:0)
[01:49:05.737] Timer tick, asking Buildbucket for the build status
[01:49:05.789] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:05.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:22:0) after 1m0s
[01:50:06.020] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:22:0)
[01:50:06.021] Timer tick, asking Buildbucket for the build status
[01:50:06.184] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:06.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:23:0) after 1m0s
[01:51:06.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:23:0)
[01:51:06.924] Timer tick, asking Buildbucket for the build status
[01:51:06.992] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:06.992] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:24:0) after 1m0s
[01:52:07.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:24:0)
[01:52:07.260] Timer tick, asking Buildbucket for the build status
[01:52:07.766] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:07.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:25:0) after 1m0s
[01:53:07.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:25:0)
[01:53:07.854] Timer tick, asking Buildbucket for the build status
[01:53:07.924] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:07.924] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:26:0) after 1m0s
[01:54:08.026] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:26:0)
[01:54:08.026] Timer tick, asking Buildbucket for the build status
[01:54:08.090] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:08.090] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:27:0) after 1m0s
[01:55:08.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:27:0)
[01:55:08.110] Timer tick, asking Buildbucket for the build status
[01:55:08.182] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:08.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:28:0) after 1m0s
[01:56:08.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:28:0)
[01:56:08.228] Timer tick, asking Buildbucket for the build status
[01:56:08.345] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:08.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:29:0) after 1m0s
[01:57:08.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:29:0)
[01:57:08.411] Timer tick, asking Buildbucket for the build status
[01:57:08.587] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:08.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:30:0) after 1m0s
[01:58:08.610] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:30:0)
[01:58:08.610] Timer tick, asking Buildbucket for the build status
[01:58:08.690] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:08.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:31:0) after 1m0s
[01:59:08.905] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:31:0)
[01:59:08.905] Timer tick, asking Buildbucket for the build status
[01:59:09.167] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:09.167] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:32:0) after 1m0s
[02:00:09.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:32:0)
[02:00:09.533] Timer tick, asking Buildbucket for the build status
[02:00:09.691] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:09.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:33:0) after 1m0s
[02:01:10.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:33:0)
[02:01:10.164] Timer tick, asking Buildbucket for the build status
[02:01:10.296] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:10.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:34:0) after 1m0s
[02:02:10.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:34:0)
[02:02:10.524] Timer tick, asking Buildbucket for the build status
[02:02:10.839] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:10.839] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:35:0) after 1m0s
[02:03:10.819] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:35:0)
[02:03:10.819] Timer tick, asking Buildbucket for the build status
[02:03:10.928] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:10.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:36:0) after 1m0s
[02:04:11.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:36:0)
[02:04:11.074] Timer tick, asking Buildbucket for the build status
[02:04:11.159] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:11.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:37:0) after 1m0s
[02:05:11.141] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:37:0)
[02:05:11.141] Timer tick, asking Buildbucket for the build status
[02:05:13.089] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:13.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:38:0) after 1m0s
[02:06:13.285] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:38:0)
[02:06:13.285] Timer tick, asking Buildbucket for the build status
[02:06:13.365] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:13.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:39:0) after 1m0s
[02:07:13.439] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:39:0)
[02:07:13.439] Timer tick, asking Buildbucket for the build status
[02:07:13.542] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:13.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:40:0) after 1m0s
[02:08:13.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:40:0)
[02:08:13.615] Timer tick, asking Buildbucket for the build status
[02:08:13.682] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:13.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:41:0) after 1m0s
[02:09:14.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:41:0)
[02:09:14.205] Timer tick, asking Buildbucket for the build status
[02:09:14.310] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:14.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:42:0) after 1m0s
[02:10:14.798] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:42:0)
[02:10:14.798] Timer tick, asking Buildbucket for the build status
[02:10:15.103] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:15.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:43:0) after 1m0s
[02:11:15.156] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:43:0)
[02:11:15.156] Timer tick, asking Buildbucket for the build status
[02:11:17.708] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:17.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:44:0) after 1m0s
[02:12:17.812] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:44:0)
[02:12:17.812] Timer tick, asking Buildbucket for the build status
[02:12:17.893] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:17.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:45:0) after 1m0s
[02:13:17.891] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:45:0)
[02:13:17.891] Timer tick, asking Buildbucket for the build status
[02:13:18.237] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:18.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:46:0) after 1m0s
[02:14:18.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:46:0)
[02:14:18.288] Timer tick, asking Buildbucket for the build status
[02:14:18.368] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:18.368] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:47:0) after 1m0s
[02:15:18.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:47:0)
[02:15:18.366] Timer tick, asking Buildbucket for the build status
[02:15:18.439] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:18.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:48:0) after 1m0s
[02:16:18.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:48:0)
[02:16:18.497] Timer tick, asking Buildbucket for the build status
[02:16:18.575] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:18.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:49:0) after 1m0s
[02:17:18.603] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:49:0)
[02:17:18.603] Timer tick, asking Buildbucket for the build status
[02:17:18.684] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:18.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:50:0) after 1m0s
[02:18:18.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:50:0)
[02:18:18.705] Timer tick, asking Buildbucket for the build status
[02:18:18.798] Build 8853549560420100944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:18.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018979622607238416:51:0) after 1m0s
[02:19:02.755] Received PubSub notification, asking Buildbucket for the build status
[02:19:02.880] Build 8853549560420100944: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:19:02.880] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614997141972372",
"created_by": "project:chromium",
"created_ts": "1614994197405379",
"id": "8853549560420100944",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"70cdf0709583860b9ed8da84e0c3344c4dbab9f1\"}}",
"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\": \"70cdf0709583860b9ed8da84e0c3344c4dbab9f1\", \"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-93-b9r7\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181157, \"got_angle_revision\": \"d96b9ffa5c19f4b92ee0fff918ae5341c7b787d2\", \"got_dawn_revision\": \"010fd1a8d7c7dd4e8fabe73546be78c45b6419c2\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"70cdf0709583860b9ed8da84e0c3344c4dbab9f1\", \"got_revision_cp\": \"refs/heads/master@{#860465}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"de7d5775ab25234a2c14d061e0cda342248a0e6d\", \"got_v8_revision\": \"f6cfc21cf2633296a4f20f14107469c8e00eaec7\", \"got_v8_revision_cp\": \"refs/heads/9.1.54@{#1}\", \"got_webrtc_revision\": \"1413e2db4c9b186176a54e70c52f5b673c2cb939\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33387}\", \"is_cached\": true, \"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\": \"70cdf0709583860b9ed8da84e0c3344c4dbab9f1\", \"swarm_hashes_refs/heads/master(at){#860465}_without_patch\": {\"absl_hardening_tests\": \"9e597060ad327bb3040988dc957ce5cdd9a5ee46\", \"accessibility_unittests\": \"42de1654942c13d05989c436b5d58feba073205e\", \"angle_unittests\": \"fd66ceca7f06f9501375f49200570e151e2dda05\", \"app_shell_unittests\": \"9184561ea3faf021d884c29b8c09262b328fd7b5\", \"aura_unittests\": \"e39db39d5d7ade50331620ecd7f3b7b997a606b4\", \"base_unittests\": \"c830c088999c69afc2d2d56102f189680375825a\", \"base_util_unittests\": \"f2c699739a545ed981fdd7a249f54e622a27af1a\", \"blink_common_unittests\": \"87c7ea1a9c33e58af39a69d8f8be7fac13a7177e\", \"blink_fuzzer_unittests\": \"1aab2930ddaf5b01d6a22a2caa193345699b515e\", \"blink_heap_unittests\": \"df713135895d334f3c147bc35e5007e964924578\", \"blink_platform_unittests\": \"52a48ec0af4fc61ea4106b4e702541a592c9716a\", \"blink_python_tests\": \"fdcd6df0733b922f8a86823a0818f1d4fba736cd\", \"blink_unittests\": \"f88bb81d3f4c1ade1b4943e03d84357206570e09\", \"blink_web_tests\": \"23799f5d18ba166219032cf71298cf3cb81f844f\", \"boringssl_crypto_tests\": \"91a283737c6521d16833f5fb1c194fd7a476869d\", \"boringssl_ssl_tests\": \"2abf8c25af975c50b192b4d637c5ab9175b31663\", \"browser_tests\": \"1f8914b9387d1c512f78164f723eb50eb255b16e\", \"capture_unittests\": \"f40b5bee387673a9b83cae9ee57df7b8d60824ef\", \"cast_unittests\": \"1e6c469fdd112334aee01833c65378b0158bc710\", \"cc_unittests\": \"b09c4eac0e2196aa245051916dc7de6e6824096c\", \"chrome_app_unittests\": \"d07feab054be7267ced71e2eb49e15dc95702cd1\", \"chromedriver_unittests\": \"e815fa1235673b3e91ac22deaed95fe57e3bb269\", \"color_unittests\": \"972d5509b7ad31b4947894aa8a8d062e1227f0b1\", \"components_browsertests\": \"64313f0cdb96d7a8e61d9df86a5b0052db67ba17\", \"components_unittests\": \"870ce1098029134b33d155b55913b65268006d43\", \"compositor_unittests\": \"af092e629f9e5e53e3d68875e5fabdf70fae555f\", \"content_browsertests\": \"0c21b9546519b32e7edc6c6617e385204d61cf26\", \"content_shell_crash_test\": \"a7ff84c658c3262cc1c5301c14628e8b40f08244\", \"content_unittests\": \"61d8d2461a9cf8d0f4840eaf08172298ba18261c\", \"crashpad_tests\": \"17088418c96a1ca058473bacba841c4d0c104038\", \"cronet_tests\": \"12ca1fdfd9cdd2719565f6b1554b2a8da0e23b87\", \"cronet_unittests\": \"801f03f9c50c7ace6e0c7379628d0d10d5acfb4a\", \"crypto_unittests\": \"df153c34fd121d3e687a32bfcd1a98d9e9549cd1\", \"dbus_unittests\": \"8e287483776c305ff260e426d7ff855193237ad5\", \"device_unittests\": \"87af9c3c8bd4bfa2d805a28e901a0a3559a2570c\", \"display_unittests\": \"64be03b1cf0797400b8e4ac6a063d817ddc66c0a\", \"events_unittests\": \"a616a7ced437d36840ce6202eb41238a50419260\", \"extensions_browsertests\": \"66e6ee4d38dc7dfcb663b227faa93e69a0567a20\", \"extensions_unittests\": \"3ac4917c0994951d3488294c798a518b3b0123f4\", \"filesystem_service_unittests\": \"b01730f548953d45e86ca4004293774c8bd1b99c\", \"flatbuffers_unittests\": \"c250ce450f13000694dfe6ba468b9387e0777b33\", \"gcm_unit_tests\": \"44e0e360bc2b1e84621fc4a51c1e99c9096afc7a\", \"gfx_unittests\": \"9e448ed3563f500e3ca425e86eb8d11d45a1d914\", \"gin_unittests\": \"e62d37811ab1988dc5ab162f5782c4e490d69f4c\", \"google_apis_unittests\": \"f7836443868604ed666e5dda3ae687baf311d789\", \"gpu_unittests\": \"26dd1491345efae80a33c02c0ae7618de5f6b240\", \"grit_python_unittests\": \"3c64b70c7cdd81b5f218a9b86ebdd85ad0bd7f76\", \"gwp_asan_unittests\": \"45592d54bec5eef4ae869cd40aa214a044ef68a5\", \"headless_browsertests\": \"0f8c5b0e7418d420f3229a1f3fe8a4570ea57653\", \"headless_unittests\": \"56312d3ef2b38757afbe4d77197fad5b5a227977\", \"interactive_ui_tests\": \"eef10f32e9e36c8c35f1c2c64568ce7aa0a372eb\", \"ipc_tests\": \"5ad4f56bb5aef820e9e97e5f09707f8336c710ad\", \"jingle_unittests\": \"3df1a41b502ed78f14f6c62ebe0fc1557d34d6b3\", \"latency_unittests\": \"0ec5f4a108da610a0e96a80a6a718dc7e8ec39ef\", \"libjingle_xmpp_unittests\": \"1272fbf659c276b4390524e58ae5ead76bc80824\", \"liburlpattern_unittests\": \"d09eadd559a999b9f9c8a47b690d76a1d586e996\", \"media_blink_unittests\": \"50f2dcad1fb375e012012aa03d3501548f77c690\", \"media_unittests\": \"b39398b230ae1e0a858727dda977c48ef515d5fc\", \"message_center_unittests\": \"101f17458fe7e046c5d9444b0a8f9c2183bf4495\", \"metrics_python_tests\": \"04006d1a156e08819531240266a91ad227891753\", \"midi_unittests\": \"89c38a29cd9c0b701b64390ab54ae74b3b59a157\", \"mojo_core_unittests\": \"78174f0fb8f554177c80a8849930589f92852968\", \"mojo_unittests\": \"c7b5bad2606a7defa57352b8d2768a94c2b34efe\", \"nacl_helper_nonsfi_unittests\": \"84aa1f5aef06201aa4d5ebc538bc9c3fb8cfcbe9\", \"nacl_loader_unittests\": \"5f456be4cb42bf1e6a591673f3c654712bd0302b\", \"native_theme_unittests\": \"925a5e190e4071110976bcea5fe3a514599f59c3\", \"net_unittests\": \"867be09895aee9cb2284f4d4267dae6dc139af73\", \"openscreen_unittests\": \"d746a4acf0e92476c4d8164137248e2e61817243\", \"pdf_unittests\": \"95391013a00cf298dab1039c13e2065baab97c17\", \"perfetto_unittests\": \"ea964373e7fe109fcd447b1047d04cb268b068ac\", \"ppapi_unittests\": \"025b34f5ec6ada2047e089e1bd5bdcf6c6168ce5\", \"printing_unittests\": \"3e9477b9a93b876c95c6beb7c307a1cac9447a2c\", \"remoting_unittests\": \"0fb4459c6ae3d77bc0e799087e460e937c510003\", \"sandbox_linux_unittests\": \"ae606b6b52459fe18d9febbfdcb76171429c6a68\", \"service_manager_unittests\": \"35d4eaa2aaa4730fb46250e0dae34361f68716a4\", \"services_unittests\": \"aaddc5ecf2ace97787876015664d5d464076ccf2\", \"shell_dialogs_unittests\": \"d10726a5729495af720fcabf30d74cda26cde925\", \"skia_unittests\": \"87a4f26f7f9f1a7eb790a96ca09496644a5f2897\", \"snapshot_unittests\": \"18ed39220a2719e7518b7ccd4fb15c9d41ab85e5\", \"sql_unittests\": \"3d091fb1724a16dfdcd6b8c594f4e82b95fce97d\", \"storage_unittests\": \"923e9a822dee2376118806eb3ff1237641d467f6\", \"sync_integration_tests\": \"b6598c0d2ebc9159259456dbe6f7dda8c649fa6a\", \"telemetry_gpu_unittests\": \"185e2685e14799d7426cbaa4061ad6efa8c23fd0\", \"telemetry_perf_unittests\": \"fe25c94ddaa429585b2b90242e234f3c09a77c44\", \"telemetry_unittests\": \"d8daba5039dab4485ea3f438dc1a5e98efc6c8cd\", \"traffic_annotation_auditor_unittests\": \"5805bdecccd9b3cc89ddbd0672f04bc74e56aa30\", \"ui_base_unittests\": \"92c97fa6641bba04e3a6efc73dbde03b8cc53fc4\", \"ui_touch_selection_unittests\": \"f5396e99d6e16aeffbb14a5b2c2c068865fc361c\", \"unit_tests\": \"3ed0b95b9e59334b3596e15dd73038e57d4167d6\", \"url_unittests\": \"a873c2497d6a773f5a530d072d5d3d1f7244df05\", \"views_perftests\": \"7866e093c145db011eb9f62f2cdf65b433764689\", \"views_unittests\": \"bb4c060a85667018754c25a8b89eeaf144fb3bc9\", \"viz_unittests\": \"a89840c213efba8f2251dc67a748739afe356e89\", \"vr_common_unittests\": \"fff1b8cf6e5ae681f4c2e2c821fccc30c5adc5f6\", \"vr_pixeltests\": \"0675d26c434d8951f42db4e1acbd1d0b503ed6bf\", \"webdriver_wpt_tests\": \"8931fd020ef64a4c9c8c9c961369a1934cfee971\", \"weblayer_browsertests\": \"9846cc00902e623a23824a7c570bc6a401e2b396\", \"weblayer_unittests\": \"24d838327414173bdcdc20a225146cfb59c0c0ed\", \"wm_unittests\": \"774821f927a0c6b22515d65ecea3fcc408ac9b27\", \"wtf_unittests\": \"230be32bee7c09b6cd095d1260a7bc903af96ad1\", \"x11_unittests\": \"8f2740d2800d331ef80d934b35cbe543812a9024\", \"xr_browser_tests\": \"e49071e1f0006878885317d43c0547e9242b0f26\", \"zlib_unittests\": \"bac58d0a66135a70ba02f345c59ed1c30effa0a0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_9d256cb2f85be378659e55cf5f0ce01fc0940a9249a2a1ce7ed4704193366f14_v2\", \"builder_bf327355f14a5f9d508737b4360c68279752310c332341be5eb6c5a154f6df89_v2\", \"builder_d1ade7eeaf5d4bfec46cdcc4260ff7266c5ca5ac9f935f1643683e9e2b66e303_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_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-93-b9r7\"], \"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\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614994199424458",
"status": "COMPLETED",
"status_changed_ts": "1614997142383005",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181157",
"builder:Linux Builder (dbg)",
"buildset:commit/git/70cdf0709583860b9ed8da84e0c3344c4dbab9f1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/70cdf0709583860b9ed8da84e0c3344c4dbab9f1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018979622607238416",
"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/8853549560420100944/+/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:521df957ea04ea10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614997142388243",
"url": "https://ci.chromium.org/b/8853549560420100944",
"utcnow_ts": "1614997142871864"
}
}
[02:19:02.880] Invocation finished in 49m6.944209186s with status SUCCEEDED