[04:29:54.302] New invocation is queued and will start shortly
[04:29:55.406] Starting the invocation (attempt 1)
[04:29:55.458] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:29:55.458] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:29:55.459] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022410984439941056",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"83bae2ae9fc3ea60cd10ad88465c09a7dfa82878\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022410984439941056",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/83bae2ae9fc3ea60cd10ad88465c09a7dfa82878",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/83bae2ae9fc3ea60cd10ad88465c09a7dfa82878",
"gitiles_ref:refs/heads/master"
]
}
[04:29:56.278] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611721795581158",
"id": "8856980922435412112",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"83bae2ae9fc3ea60cd10ad88465c09a7dfa82878\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611721796142168",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180017",
"builder:Linux Builder (dbg)",
"buildset:commit/git/83bae2ae9fc3ea60cd10ad88465c09a7dfa82878",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/83bae2ae9fc3ea60cd10ad88465c09a7dfa82878",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022410984439941056",
"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/8856980922435412112/+/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": "1611721796142279",
"url": "https://ci.chromium.org/b/8856980922435412112",
"utcnow_ts": "1611721796272440"
}
}
[04:29:56.278] Task URL: https://ci.chromium.org/b/8856980922435412112
[04:29:56.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:2:0) after 1m0s
[04:30:47.789] Received PubSub notification, asking Buildbucket for the build status
[04:30:47.865] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:56.280] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:2:0)
[04:30:56.280] Timer tick, asking Buildbucket for the build status
[04:30:56.362] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:56.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:4:0) after 1m0s
[04:31:56.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:4:0)
[04:31:56.396] Timer tick, asking Buildbucket for the build status
[04:31:56.663] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:56.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:5:0) after 1m0s
[04:32:56.687] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:5:0)
[04:32:56.687] Timer tick, asking Buildbucket for the build status
[04:33:01.967] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:01.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:6:0) after 1m0s
[04:34:02.070] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:6:0)
[04:34:02.070] Timer tick, asking Buildbucket for the build status
[04:34:02.166] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:02.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:7:0) after 1m0s
[04:35:02.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:7:0)
[04:35:02.244] Timer tick, asking Buildbucket for the build status
[04:35:02.371] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:02.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:8:0) after 1m0s
[04:36:02.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:8:0)
[04:36:02.433] Timer tick, asking Buildbucket for the build status
[04:36:02.599] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:02.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:9:0) after 1m0s
[04:37:02.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:9:0)
[04:37:02.615] Timer tick, asking Buildbucket for the build status
[04:37:02.683] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:02.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:10:0) after 1m0s
[04:38:02.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:10:0)
[04:38:02.709] Timer tick, asking Buildbucket for the build status
[04:38:02.784] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:02.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:11:0) after 1m0s
[04:39:02.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:11:0)
[04:39:02.859] Timer tick, asking Buildbucket for the build status
[04:39:02.934] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:02.934] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:12:0) after 1m0s
[04:40:03.026] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:12:0)
[04:40:03.026] Timer tick, asking Buildbucket for the build status
[04:40:03.181] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:03.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:13:0) after 1m0s
[04:41:03.249] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:13:0)
[04:41:03.249] Timer tick, asking Buildbucket for the build status
[04:41:03.308] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:03.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:14:0) after 1m0s
[04:42:03.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:14:0)
[04:42:03.350] Timer tick, asking Buildbucket for the build status
[04:42:03.429] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:03.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:15:0) after 1m0s
[04:43:03.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:15:0)
[04:43:03.472] Timer tick, asking Buildbucket for the build status
[04:43:03.767] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:03.767] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:16:0) after 1m0s
[04:44:03.777] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:16:0)
[04:44:03.777] Timer tick, asking Buildbucket for the build status
[04:44:03.872] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:03.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:17:0) after 1m0s
[04:45:03.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:17:0)
[04:45:03.933] Timer tick, asking Buildbucket for the build status
[04:45:04.246] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:04.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:18:0) after 1m0s
[04:46:04.246] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:18:0)
[04:46:04.246] Timer tick, asking Buildbucket for the build status
[04:46:04.382] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:04.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:19:0) after 1m0s
[04:47:04.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:19:0)
[04:47:04.407] Timer tick, asking Buildbucket for the build status
[04:47:04.511] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:04.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:20:0) after 1m0s
[04:48:04.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:20:0)
[04:48:04.551] Timer tick, asking Buildbucket for the build status
[04:48:04.609] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:04.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:21:0) after 1m0s
[04:49:04.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:21:0)
[04:49:04.660] Timer tick, asking Buildbucket for the build status
[04:49:04.756] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:04.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:22:0) after 1m0s
[04:50:04.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:22:0)
[04:50:04.758] Timer tick, asking Buildbucket for the build status
[04:50:05.264] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:05.264] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:23:0) after 1m0s
[04:51:05.254] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:23:0)
[04:51:05.254] Timer tick, asking Buildbucket for the build status
[04:51:05.332] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:05.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:24:0) after 1m0s
[04:52:05.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:24:0)
[04:52:05.367] Timer tick, asking Buildbucket for the build status
[04:52:05.942] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:05.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:25:0) after 1m0s
[04:53:05.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:25:0)
[04:53:05.963] Timer tick, asking Buildbucket for the build status
[04:53:06.045] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:06.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:26:0) after 1m0s
[04:54:06.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:26:0)
[04:54:06.094] Timer tick, asking Buildbucket for the build status
[04:54:06.161] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:06.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:27:0) after 1m0s
[04:55:06.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:27:0)
[04:55:06.222] Timer tick, asking Buildbucket for the build status
[04:55:06.329] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:06.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:28:0) after 1m0s
[04:56:06.370] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:28:0)
[04:56:06.370] Timer tick, asking Buildbucket for the build status
[04:56:06.474] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:06.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:29:0) after 1m0s
[04:57:06.540] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:29:0)
[04:57:06.540] Timer tick, asking Buildbucket for the build status
[04:57:06.597] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:06.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:30:0) after 1m0s
[04:58:06.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:30:0)
[04:58:06.642] Timer tick, asking Buildbucket for the build status
[04:58:06.734] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:06.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:31:0) after 1m0s
[04:59:06.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:31:0)
[04:59:06.818] Timer tick, asking Buildbucket for the build status
[04:59:06.888] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:06.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:32:0) after 1m0s
[05:00:06.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:32:0)
[05:00:06.909] Timer tick, asking Buildbucket for the build status
[05:00:07.313] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:07.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:33:0) after 1m0s
[05:01:07.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:33:0)
[05:01:07.763] Timer tick, asking Buildbucket for the build status
[05:01:07.979] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:07.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:34:0) after 1m0s
[05:02:08.026] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:34:0)
[05:02:08.026] Timer tick, asking Buildbucket for the build status
[05:02:08.090] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:08.090] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:35:0) after 1m0s
[05:03:08.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:35:0)
[05:03:08.139] Timer tick, asking Buildbucket for the build status
[05:03:08.228] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:08.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:36:0) after 1m0s
[05:04:08.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:36:0)
[05:04:08.292] Timer tick, asking Buildbucket for the build status
[05:04:08.363] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:08.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:37:0) after 1m0s
[05:05:08.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:37:0)
[05:05:08.396] Timer tick, asking Buildbucket for the build status
[05:05:08.504] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:08.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:38:0) after 1m0s
[05:06:08.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:38:0)
[05:06:08.558] Timer tick, asking Buildbucket for the build status
[05:06:08.665] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:08.665] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:39:0) after 1m0s
[05:07:08.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:39:0)
[05:07:08.700] Timer tick, asking Buildbucket for the build status
[05:07:08.826] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:08.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:40:0) after 1m0s
[05:08:08.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:40:0)
[05:08:08.893] Timer tick, asking Buildbucket for the build status
[05:08:08.975] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:08.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:41:0) after 1m0s
[05:09:09.042] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:41:0)
[05:09:09.042] Timer tick, asking Buildbucket for the build status
[05:09:09.130] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:09.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:42:0) after 1m0s
[05:10:09.160] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:42:0)
[05:10:09.160] Timer tick, asking Buildbucket for the build status
[05:10:10.961] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:10.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:43:0) after 1m0s
[05:11:11.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:43:0)
[05:11:11.157] Timer tick, asking Buildbucket for the build status
[05:11:11.215] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:11.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:44:0) after 1m0s
[05:12:11.280] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:44:0)
[05:12:11.280] Timer tick, asking Buildbucket for the build status
[05:12:11.415] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:11.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:45:0) after 1m0s
[05:13:11.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:45:0)
[05:13:11.529] Timer tick, asking Buildbucket for the build status
[05:13:11.830] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:11.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:46:0) after 1m0s
[05:14:11.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:46:0)
[05:14:11.929] Timer tick, asking Buildbucket for the build status
[05:14:12.018] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:12.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:47:0) after 1m0s
[05:15:12.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:47:0)
[05:15:12.115] Timer tick, asking Buildbucket for the build status
[05:15:12.577] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:12.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:48:0) after 1m0s
[05:16:12.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:48:0)
[05:16:12.744] Timer tick, asking Buildbucket for the build status
[05:16:12.857] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:12.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:49:0) after 1m0s
[05:17:12.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:49:0)
[05:17:12.923] Timer tick, asking Buildbucket for the build status
[05:17:13.074] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:13.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:50:0) after 1m0s
[05:18:13.592] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:50:0)
[05:18:13.592] Timer tick, asking Buildbucket for the build status
[05:18:13.674] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:13.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:51:0) after 1m0s
[05:19:14.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:51:0)
[05:19:14.686] Timer tick, asking Buildbucket for the build status
[05:19:14.824] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:14.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:52:0) after 1m0s
[05:20:15.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:52:0)
[05:20:15.876] Timer tick, asking Buildbucket for the build status
[05:20:16.032] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:16.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:53:0) after 1m0s
[05:21:16.225] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:53:0)
[05:21:16.225] Timer tick, asking Buildbucket for the build status
[05:21:16.308] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:16.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:54:0) after 1m0s
[05:22:16.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:54:0)
[05:22:16.482] Timer tick, asking Buildbucket for the build status
[05:22:16.570] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:16.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:55:0) after 1m0s
[05:23:16.996] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:55:0)
[05:23:16.996] Timer tick, asking Buildbucket for the build status
[05:23:17.058] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:17.058] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:56:0) after 1m0s
[05:24:17.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:56:0)
[05:24:17.369] Timer tick, asking Buildbucket for the build status
[05:24:17.464] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:17.464] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:57:0) after 1m0s
[05:25:17.741] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:57:0)
[05:25:17.741] Timer tick, asking Buildbucket for the build status
[05:25:17.891] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:17.891] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:58:0) after 1m0s
[05:26:18.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:58:0)
[05:26:18.014] Timer tick, asking Buildbucket for the build status
[05:26:18.096] Build 8856980922435412112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:18.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022410984439941056:59:0) after 1m0s
[05:27:07.877] Received PubSub notification, asking Buildbucket for the build status
[05:27:08.253] Build 8856980922435412112: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:27:08.253] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611725226945839",
"created_by": "project:chromium",
"created_ts": "1611721795581158",
"id": "8856980922435412112",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"83bae2ae9fc3ea60cd10ad88465c09a7dfa82878\"}}",
"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\": \"83bae2ae9fc3ea60cd10ad88465c09a7dfa82878\", \"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-72-9inl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180017, \"got_angle_revision\": \"f9afaaeedee68302e9936532de16126313a3bd02\", \"got_dawn_revision\": \"2df77f4325841e667e6b9ff9921fd626496a3b64\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"83bae2ae9fc3ea60cd10ad88465c09a7dfa82878\", \"got_revision_cp\": \"refs/heads/master@{#847494}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"aec0826aba0db51914209ec85a515d3a99311f07\", \"got_v8_revision\": \"5a6bbde4f5b86e56cbb0827de847a936161efbfe\", \"got_v8_revision_cp\": \"refs/heads/9.0.80@{#1}\", \"got_webrtc_revision\": \"fae4fb13451bea44ae1a94509befe8d7c6b11eb6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33077}\", \"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\", \"prev_got_revision\": \"adb5810cbf4c678c7ddb6f26d830c65c80153338\", \"prev_got_revision_cp\": \"refs/heads/master@{#847354}\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"83bae2ae9fc3ea60cd10ad88465c09a7dfa82878\", \"swarm_hashes_refs/heads/master(at){#847494}_without_patch\": {\"absl_hardening_tests\": \"98e0c6cff6d889c317227f117ae8fb2b4ea189d8\", \"accessibility_unittests\": \"3515d59f76f80871dadff49d8bb0ee371bf6c3a8\", \"angle_unittests\": \"d07839dd0610bc9f17f0c9cec8d25544cb54031b\", \"app_shell_unittests\": \"13c4c5aa36597f03318e463e8153086419760233\", \"aura_unittests\": \"71759a18b54564068fcebbfadb3f1f893dcd88c3\", \"base_unittests\": \"f2cfe29dc56a03c370e1adb331fb528266226024\", \"base_util_unittests\": \"3186625a00580dc13ab99c8c2fd594b27aa9c398\", \"blink_common_unittests\": \"92034796482319587eacd345ca4519cc342439cb\", \"blink_fuzzer_unittests\": \"313dd290f43b6ca37c290ccc6fd69b866e262cb3\", \"blink_heap_unittests\": \"7943bce071bc310b2ce2780fc4705eeac158f31d\", \"blink_platform_unittests\": \"b2f377e10c0c2cd40d8177c3022e2f5012bfcf7d\", \"blink_python_tests\": \"3fbfe7bc9ae0a497a4b0b727a4a7027b86586da2\", \"blink_unittests\": \"342cd0dee9b48e6b05277627de30dc60e526ae05\", \"blink_web_tests\": \"0bc1d0bd03d41fad20c1578cffc4579a532551ce\", \"boringssl_crypto_tests\": \"590cd37175cd631387ef3e5e3d8afdf117e3e219\", \"boringssl_ssl_tests\": \"5a5534a7adc0e60fdf1fab074d485ec4a48b9adf\", \"browser_tests\": \"b2885fe4986a3b74b7344a5244f460b5b3ef02cb\", \"capture_unittests\": \"75da572e60323592cfb4736c651c04b2929dbf82\", \"cast_unittests\": \"4faa5586d640976cbfb59b4dfa93be7a8d6ff537\", \"cc_unittests\": \"c210b58ff214936474a5488a78f4ebf85f06a519\", \"chrome_app_unittests\": \"32d60446ad0ba1e847b09e31722c413801bb4159\", \"chromedriver_unittests\": \"0cddc1b249ad24deb154d216cdf36f669c164c04\", \"components_browsertests\": \"940adce40e7a6517b980349f13225a066e4cf269\", \"components_unittests\": \"554a796a4d2c62010d9710f57e0056fb05ae1f0f\", \"compositor_unittests\": \"583d072ed2e99bee2525298f58c8f2c7cfa16dca\", \"content_browsertests\": \"5e333646a86a649843c3e33b66fc5c5b1932314d\", \"content_shell_crash_test\": \"1e57008ec6db8d38ec87b93debf6272c7feb1b00\", \"content_unittests\": \"6bef8ec378224f19870df2e7240a3beaf0f3d971\", \"crashpad_tests\": \"99a3c0e6641e4d8d02081c0416ac9d352cd8be53\", \"cronet_tests\": \"a869cc46f9d4157dc0ed88a5eae1910c2c7b99c0\", \"cronet_unittests\": \"9c5bae16559c6c35893750e0f94a96307e6262af\", \"crypto_unittests\": \"495e02a782f7827faae88fe00d7d9e882f76071c\", \"dbus_unittests\": \"8216e36b5b1c951d504f3a486d51e4990f837753\", \"device_unittests\": \"635c209d098ccdb827b475078aa84f6b9dcac684\", \"display_unittests\": \"3fa4aad7a100ac7bdd1e90a233f80d3f64d63508\", \"events_unittests\": \"8178a45017b507d72482243354593464ebe7504a\", \"extensions_browsertests\": \"d8b9534536bf7b91ed2f10bda36e3c62db4434b6\", \"extensions_unittests\": \"c6de40eb5d301e07283e8a46c36949b838995eeb\", \"filesystem_service_unittests\": \"2509329c1f6cc088202d9ad7d663f30b1fe761a4\", \"flatbuffers_unittests\": \"bc94b5892d7faa8d4260fa7d28e336b3c313737d\", \"gcm_unit_tests\": \"20e6e9f6fa8a21be734a39f0f7d6c4f9cb5ff471\", \"gfx_unittests\": \"f53c187bd65a87e72163a101d0e820cdff80c57c\", \"gin_unittests\": \"2162f187ea3e6a49f9f1a6c3290d4c1a1ddf6ea2\", \"google_apis_unittests\": \"a9bb443e24ff135e4256bf7aff4c77f51486b019\", \"gpu_unittests\": \"83a72185b9f98b9644597e402491ecb02c2782ef\", \"grit_python_unittests\": \"b0890b035c0d25a1641db23ae376539c3f64cf64\", \"gwp_asan_unittests\": \"fb44dced507d00445b9b860b5738131b4ef62b3c\", \"headless_browsertests\": \"7faac492333c7019b93709ecca967eb32d910a2e\", \"headless_unittests\": \"dfc0e1c952a1e9698b26ae9da0cd76533b3b0960\", \"interactive_ui_tests\": \"e23903ab90fd3469eecdb776b0bb0d887f66e297\", \"ipc_tests\": \"f9dc4b6a66cf78f01e95d645d422a5b927d5e9f8\", \"jingle_unittests\": \"a07a91eaead9a82b7aab52a7060f124d50ac5dcb\", \"latency_unittests\": \"b3fdb6a2c3c5d607ff3d8b927a4d0ac6ada019e6\", \"libjingle_xmpp_unittests\": \"4d12578679d3b4e881f65ed4a94e736675e79bf8\", \"liburlpattern_unittests\": \"dc1c37b8fdf46789c56b2a0eb2fb157a9bf7db0e\", \"media_blink_unittests\": \"8d1fdf15cae043ce33dc9f5394d09ff67c06681c\", \"media_unittests\": \"6a9368e83747799214e66a2f0699131802d6b2ff\", \"message_center_unittests\": \"d5208ed1e00090d571395f04881b24a3035da00c\", \"metrics_python_tests\": \"fecc4f2af3f48f30dbd85742c49954bf55e1e95c\", \"midi_unittests\": \"6b9213f7170225d9ab5df67e2183ae76ee965e8f\", \"mojo_core_unittests\": \"59ce2e006a07b7516e7a4028a97221c74be4a620\", \"mojo_unittests\": \"16135109ee23019b2d8f3d6fad3d11fbeeaca4c6\", \"nacl_helper_nonsfi_unittests\": \"07ae410acde63eb7f0e20281c67a4130c43348f2\", \"nacl_loader_unittests\": \"740c23567c30057fb8357c72290ab2114cbb9f7c\", \"native_theme_unittests\": \"5b9d20c6089238b777cdb171a40f7fc9ddad2329\", \"net_unittests\": \"513255bff2dd4af109b27f54a69a9575e9ee8b58\", \"openscreen_unittests\": \"e0acf3629b9d6d436629ac94d4acbecf5be1c1d9\", \"pdf_unittests\": \"ff54e2abbe2479be98457a92084f240c3d0b325f\", \"perfetto_unittests\": \"473bc3c1f37227af8ea88273c6aa70b7956b6d4c\", \"ppapi_unittests\": \"90870623dcb07e4b1cdb26c197d2ff6e19a861d0\", \"printing_unittests\": \"d8e63869251de986ca693611de55f554de7094d4\", \"remoting_unittests\": \"31ccd025f5cfcc6cab87cad3dfca08151db475b9\", \"sandbox_linux_unittests\": \"6335315d284b95101a6996b72397684dc6ee6452\", \"service_manager_unittests\": \"1f4fa15f171c993c9f97f0078198caef5d779cef\", \"services_unittests\": \"01510cf802fcbd03996c4c3d4bf5a0eadc07dab7\", \"shell_dialogs_unittests\": \"924db76650bb0489200bc4d40b98358218f1b46d\", \"skia_unittests\": \"84a3dfbd345d2d645d20da6475c647694a3b4822\", \"snapshot_unittests\": \"fcbfe3033db3ea25b442b7ecaa79c5f78191d1c7\", \"sql_unittests\": \"c9e1fe5f6b370b6310deced037c48b60f82c3c5e\", \"storage_unittests\": \"020a747ff138ff5e2ca591717ed94d972db6eb0e\", \"sync_integration_tests\": \"39fc7914a1ad5899ab4eed618735672d1c27fd3e\", \"telemetry_gpu_unittests\": \"fc215bd00dd5f3c81211f2e7b141d0732c005d14\", \"telemetry_perf_unittests\": \"4e19356382ee7953071809aa598081fd8b76652c\", \"telemetry_unittests\": \"289691c3ff5bcf9617f10b6cbd84de97c0f34311\", \"traffic_annotation_auditor_unittests\": \"b2eaea7ada6ced301aa2aa750b594c0ac185f9f1\", \"ui_base_unittests\": \"77cb0a3229ad47aeebd227183c5269eeb64463b0\", \"ui_touch_selection_unittests\": \"0c19bee43b70bc130e8d8e6c939719f3e68c3609\", \"unit_tests\": \"760d16c5d97b3eb31ec64e35bc5377f1a34ad138\", \"url_unittests\": \"dce79ada08cd593adf209f6765c3ce4b66a3487e\", \"views_perftests\": \"7b32944d7e25670f1bde99613ce9db7262eadeb2\", \"views_unittests\": \"bbc89f4ee8637f68e2fe5bc068fb9b9f9104e83b\", \"viz_unittests\": \"4f2bddb752a7774b221a9382ff4b0a4d51f64612\", \"vr_common_unittests\": \"38606288d0b740d2a50153c6815a3c2b9f2e97c6\", \"vr_pixeltests\": \"89f732fc6ccded8aabbaaaa9d4edb5baf0a300b2\", \"webdriver_wpt_tests\": \"a4c8d18d893b996aeff5aea3e07e8198447df9ec\", \"weblayer_browsertests\": \"1d37fbadf6e55de288201cd7d801e74850b9f982\", \"weblayer_unittests\": \"04358557247956edded265351ce86e20e6668f7f\", \"wm_unittests\": \"ccea05173da7260e08ea9ef0cfe360c513dfd683\", \"wtf_unittests\": \"05bf302012938d489947de6de47b3ba9524ce321\", \"x11_unittests\": \"caa5f04d4f95854e3185ee9916fbb51f418519b7\", \"xr_browser_tests\": \"5b0d7da9b49d0cc27889e42d41ed8edd95e11d3f\", \"zlib_unittests\": \"8ac93e4940dc198b2ce6aabaae908d04d476d3dc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1565bd2e801a59db86c3cb29ff80b2e229b1f19a08963dbe4c2b49186438622b_v2\", \"builder_17616f83fd632132c65ea3dd60ce01b78f71f01fa76c3e3446f88a64858a3864_v2\", \"builder_d99b56d6fc6fd15316497c0509dbc8d437110174a09b554c19aeca35e1687cdb_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-central1-b-8-72-9inl\"], \"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\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611721843737301",
"status": "COMPLETED",
"status_changed_ts": "1611725227301853",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180017",
"builder:Linux Builder (dbg)",
"buildset:commit/git/83bae2ae9fc3ea60cd10ad88465c09a7dfa82878",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/83bae2ae9fc3ea60cd10ad88465c09a7dfa82878",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022410984439941056",
"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/8856980922435412112/+/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:515aec73be296b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611725227398584",
"url": "https://ci.chromium.org/b/8856980922435412112",
"utcnow_ts": "1611725228237025"
}
}
[05:27:08.253] Invocation finished in 57m13.967681303s with status SUCCEEDED