[01:06:52.143] New invocation is queued and will start shortly
[01:06:53.218] Starting the invocation (attempt 1)
[01:06:53.252] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:06:53.252] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:06:53.252] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9057122396490939792",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8e1eba22b63153681863a0b34920836a442574f8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9057122396490939792",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/8e1eba22b63153681863a0b34920836a442574f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e1eba22b63153681863a0b34920836a442574f8",
"gitiles_ref:refs/heads/master"
]
}
[01:06:54.621] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1578618413628180",
"id": "8891692334269571520",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e1eba22b63153681863a0b34920836a442574f8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1578618414275091",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167199",
"builder:Linux Builder (dbg)",
"buildset:commit/git/8e1eba22b63153681863a0b34920836a442574f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e1eba22b63153681863a0b34920836a442574f8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057122396490939792",
"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/8891692334269571520/+/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": "1578618414275259",
"url": "https://ci.chromium.org/b/8891692334269571520",
"utcnow_ts": "1578618414602164"
}
}
[01:06:54.621] Task URL: https://ci.chromium.org/b/8891692334269571520
[01:06:54.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:2:0) after 1m0s
[01:07:54.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:2:0)
[01:07:54.649] Timer tick, asking Buildbucket for the build status
[01:07:55.576] Build 8891692334269571520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:55.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:3:0) after 1m0s
[01:08:55.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:3:0)
[01:08:55.577] Timer tick, asking Buildbucket for the build status
[01:08:55.893] Build 8891692334269571520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:55.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:4:0) after 1m0s
[01:09:51.613] Received PubSub notification, asking Buildbucket for the build status
[01:09:51.800] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:55.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:4:0)
[01:09:55.868] Timer tick, asking Buildbucket for the build status
[01:09:55.999] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:55.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:6:0) after 1m0s
[01:10:56.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:6:0)
[01:10:56.032] Timer tick, asking Buildbucket for the build status
[01:10:56.330] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:56.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:7:0) after 1m0s
[01:11:56.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:7:0)
[01:11:56.380] Timer tick, asking Buildbucket for the build status
[01:11:56.631] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:56.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:8:0) after 1m0s
[01:12:56.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:8:0)
[01:12:56.677] Timer tick, asking Buildbucket for the build status
[01:12:56.848] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:56.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:9:0) after 1m0s
[01:13:56.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:9:0)
[01:13:56.878] Timer tick, asking Buildbucket for the build status
[01:13:57.116] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:57.116] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:10:0) after 1m0s
[01:14:57.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:10:0)
[01:14:57.136] Timer tick, asking Buildbucket for the build status
[01:14:57.312] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:57.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:11:0) after 1m0s
[01:15:57.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:11:0)
[01:15:57.354] Timer tick, asking Buildbucket for the build status
[01:15:57.947] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:57.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:12:0) after 1m0s
[01:16:58.016] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:12:0)
[01:16:58.016] Timer tick, asking Buildbucket for the build status
[01:16:58.846] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:58.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:13:0) after 1m0s
[01:17:59.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:13:0)
[01:17:59.013] Timer tick, asking Buildbucket for the build status
[01:17:59.178] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:59.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:14:0) after 1m0s
[01:18:59.259] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:14:0)
[01:18:59.259] Timer tick, asking Buildbucket for the build status
[01:18:59.416] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:59.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:15:0) after 1m0s
[01:19:59.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:15:0)
[01:19:59.443] Timer tick, asking Buildbucket for the build status
[01:19:59.660] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:59.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:16:0) after 1m0s
[01:21:00.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:16:0)
[01:21:00.319] Timer tick, asking Buildbucket for the build status
[01:21:00.542] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:00.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:17:0) after 1m0s
[01:22:00.827] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:17:0)
[01:22:00.829] Timer tick, asking Buildbucket for the build status
[01:22:01.197] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:01.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:18:0) after 1m0s
[01:23:01.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:18:0)
[01:23:01.226] Timer tick, asking Buildbucket for the build status
[01:23:01.460] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:01.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:19:0) after 1m0s
[01:24:01.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:19:0)
[01:24:01.492] Timer tick, asking Buildbucket for the build status
[01:24:02.187] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:02.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:20:0) after 1m0s
[01:25:02.391] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:20:0)
[01:25:02.391] Timer tick, asking Buildbucket for the build status
[01:25:02.878] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:02.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:21:0) after 1m0s
[01:26:02.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:21:0)
[01:26:02.931] Timer tick, asking Buildbucket for the build status
[01:26:04.187] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:04.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:22:0) after 1m0s
[01:27:04.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:22:0)
[01:27:04.298] Timer tick, asking Buildbucket for the build status
[01:27:04.574] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:04.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:23:0) after 1m0s
[01:28:04.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:23:0)
[01:28:04.651] Timer tick, asking Buildbucket for the build status
[01:28:05.462] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:05.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:24:0) after 1m0s
[01:29:05.449] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:24:0)
[01:29:05.449] Timer tick, asking Buildbucket for the build status
[01:29:05.994] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:05.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:25:0) after 1m0s
[01:30:06.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:25:0)
[01:30:06.023] Timer tick, asking Buildbucket for the build status
[01:30:06.296] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:06.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:26:0) after 1m0s
[01:31:06.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:26:0)
[01:31:06.367] Timer tick, asking Buildbucket for the build status
[01:31:06.548] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:06.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:27:0) after 1m0s
[01:32:06.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:27:0)
[01:32:06.632] Timer tick, asking Buildbucket for the build status
[01:32:06.851] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:06.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:28:0) after 1m0s
[01:33:06.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:28:0)
[01:33:06.859] Timer tick, asking Buildbucket for the build status
[01:33:07.504] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:07.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:29:0) after 1m0s
[01:34:07.525] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:29:0)
[01:34:07.525] Timer tick, asking Buildbucket for the build status
[01:34:07.629] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:07.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:30:0) after 1m0s
[01:35:07.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:30:0)
[01:35:07.864] Timer tick, asking Buildbucket for the build status
[01:35:08.174] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:08.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:31:0) after 1m0s
[01:36:08.235] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:31:0)
[01:36:08.235] Timer tick, asking Buildbucket for the build status
[01:36:10.622] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:10.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:32:0) after 1m0s
[01:37:10.689] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:32:0)
[01:37:10.689] Timer tick, asking Buildbucket for the build status
[01:37:11.306] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:11.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:33:0) after 1m0s
[01:38:11.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:33:0)
[01:38:11.488] Timer tick, asking Buildbucket for the build status
[01:38:12.447] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:12.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:34:0) after 1m0s
[01:39:12.581] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:34:0)
[01:39:12.581] Timer tick, asking Buildbucket for the build status
[01:39:13.630] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:13.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:35:0) after 1m0s
[01:40:13.733] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:35:0)
[01:40:13.733] Timer tick, asking Buildbucket for the build status
[01:40:14.622] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:14.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:36:0) after 1m0s
[01:41:14.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:36:0)
[01:41:14.629] Timer tick, asking Buildbucket for the build status
[01:41:15.790] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:15.790] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:37:0) after 1m0s
[01:42:15.813] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:37:0)
[01:42:15.813] Timer tick, asking Buildbucket for the build status
[01:42:16.752] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:16.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:38:0) after 1m0s
[01:43:16.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:38:0)
[01:43:16.805] Timer tick, asking Buildbucket for the build status
[01:43:17.023] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:17.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:39:0) after 1m0s
[01:44:17.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:39:0)
[01:44:17.114] Timer tick, asking Buildbucket for the build status
[01:44:17.297] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:17.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:40:0) after 1m0s
[01:45:17.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:40:0)
[01:45:17.324] Timer tick, asking Buildbucket for the build status
[01:45:18.953] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:18.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:41:0) after 1m0s
[01:46:18.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:41:0)
[01:46:18.975] Timer tick, asking Buildbucket for the build status
[01:46:19.318] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:19.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:42:0) after 1m0s
[01:47:19.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:42:0)
[01:47:19.319] Timer tick, asking Buildbucket for the build status
[01:47:19.481] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:19.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:43:0) after 1m0s
[01:48:19.502] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:43:0)
[01:48:19.502] Timer tick, asking Buildbucket for the build status
[01:48:19.683] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:19.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:44:0) after 1m0s
[01:49:19.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:44:0)
[01:49:19.800] Timer tick, asking Buildbucket for the build status
[01:49:20.399] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:20.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:45:0) after 1m0s
[01:50:20.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:45:0)
[01:50:20.374] Timer tick, asking Buildbucket for the build status
[01:50:20.703] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:20.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:46:0) after 1m0s
[01:51:20.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:46:0)
[01:51:20.814] Timer tick, asking Buildbucket for the build status
[01:51:21.003] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:21.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:47:0) after 1m0s
[01:52:21.096] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:47:0)
[01:52:21.096] Timer tick, asking Buildbucket for the build status
[01:52:21.252] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:21.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:48:0) after 1m0s
[01:53:21.246] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:48:0)
[01:53:21.246] Timer tick, asking Buildbucket for the build status
[01:53:22.602] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:22.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:49:0) after 1m0s
[01:54:22.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:49:0)
[01:54:22.713] Timer tick, asking Buildbucket for the build status
[01:54:22.929] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:22.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:50:0) after 1m0s
[01:55:23.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:50:0)
[01:55:23.009] Timer tick, asking Buildbucket for the build status
[01:55:23.254] Build 8891692334269571520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:23.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057122396490939792:51:0) after 1m0s
[01:55:26.128] Received PubSub notification, asking Buildbucket for the build status
[01:55:26.275] Build 8891692334269571520: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:55:26.275] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1578621325005951",
"created_by": "project:chromium",
"created_ts": "1578618413628180",
"id": "8891692334269571520",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e1eba22b63153681863a0b34920836a442574f8\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-4-oe8a\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 167199, \"got_angle_revision\": \"697b2241a6c77113e27987c1f208512f772b8b0f\", \"got_dawn_revision\": \"1dbb5286297995f5d7ab9fb921caa4cd359934a1\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"8e1eba22b63153681863a0b34920836a442574f8\", \"got_revision_cp\": \"refs/heads/master@{#730011}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"a7e42ba7f855d8adcbca8482a803dc2b0f06fc6f\", \"got_v8_revision\": \"bd2510d9d872670cf7295ade5fbda6f617dff0ba\", \"got_v8_revision_cp\": \"refs/heads/8.1.133@{#1}\", \"got_webrtc_revision\": \"9a83dd729bf5dc604d44da2e937ae4079781eaf2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30202}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e1eba22b63153681863a0b34920836a442574f8\", \"swarm_hashes_refs/heads/master(at){#730011}_without_patch\": {\"accessibility_unittests\": \"727a1bb79fe2c9bbff86a9e3f1e8d25cbadf6d7a\", \"angle_unittests\": \"25b06fae75f4d08aa5184d8741bccb5c23a20e96\", \"app_shell_unittests\": \"a0dc03d8c06ae37e34eab76547e0a9b4d7f5cc87\", \"aura_unittests\": \"0cd4bf8f1a3b4ea08314db81f3f4b5196208a4fd\", \"base_unittests\": \"37cb01308efe05561a82b8115fcd796fd9b21c16\", \"base_util_unittests\": \"a067c6566562bd477a86b6bf8652c9a3aae099dd\", \"blink_common_unittests\": \"09f618f7b19eac6b08d2183a22ee6160885e70bd\", \"blink_fuzzer_unittests\": \"442ed0fef7c0d56c816c959a07bd12e04fbd58ee\", \"blink_heap_unittests\": \"3803c548712e15666a4d6d6bf583923d61ae6402\", \"blink_platform_unittests\": \"9aa07045730ed079f483f4ffd53bdccaa14e25cd\", \"blink_python_tests\": \"534908e52a83ad2e8699cb6d8384c10d29d97c2b\", \"blink_unittests\": \"205a65fa79fc17013556abdf141b5a588879d0c6\", \"blink_web_tests\": \"b0ac57d166b3628bedbc0b3f0bf4cf2a199db60f\", \"boringssl_crypto_tests\": \"1aa2d600a5f2b3ccd14e58ff55c484775f3bd524\", \"boringssl_ssl_tests\": \"225c43d0f834bf0faa275fe20bdd4a9b43cfcac2\", \"browser_tests\": \"31ebace25cc40711450c2d3d6938415583093d3f\", \"cacheinvalidation_unittests\": \"81d874066f68249c094661d860211a7e28eb64d8\", \"capture_unittests\": \"b6abf2d665bd65297373021b31adfacd0123ec24\", \"cast_unittests\": \"4d8de964286fec915055031fc0893e1ecf9fec93\", \"cc_unittests\": \"b87b1a6131577ebc38090ca4d6240a7ff30f6894\", \"chrome_app_unittests\": \"ab36d3b97679f544255b1995ff33b67a98e774db\", \"chromedriver_unittests\": \"bc4cd07c2f7de8ffe54f01ecaef4443427237dfb\", \"components_browsertests\": \"69bea5ad0200060b361cf4a4117f2d28d61cee94\", \"components_unittests\": \"ce099abce01b0f751fb3d325e6d9f0d38b788d0c\", \"compositor_unittests\": \"17a003bfee0608bf6be379ea594720b31aa5da3a\", \"content_browsertests\": \"95b635c5d4b7191bbaa9a534020db9216dad5c8f\", \"content_shell_crash_test\": \"997482e9b51d9e9bf353dd6b2df149b72c7cdae4\", \"content_unittests\": \"22015c5ac0a6aafe68fa4ca545b262e2a3fcd24d\", \"crashpad_tests\": \"f089c03cb423cbc398723f69877bc812f470752f\", \"cronet_tests\": \"07ab6f0e03903b2df2fd92f337fe5f5272beb65c\", \"cronet_unittests\": \"91142d235b4bf082fc5d879362ac63606427b2b1\", \"crypto_unittests\": \"b8dbec171d1a5766fe39dea158e9b2f6a130d5be\", \"dbus_unittests\": \"54c000fc1ad9bb6b67b75520ac9695b225087f48\", \"device_unittests\": \"2475912fbce55be6cd00de96f66ee8a03fc2e5df\", \"devtools_lint_check\": \"9640bf5139a46224a4c263ea03949ce02e27dc89\", \"devtools_type_check\": \"385afa768cb1ad8ed81804eeeb88ff3810fb66cd\", \"display_unittests\": \"be3a88c6b175280b6201729580d1c326b8778208\", \"events_unittests\": \"0721142c8a8c849af8226662f264b115cca684d9\", \"extensions_browsertests\": \"0601d25da40a9def937122741e0994a9527eea2d\", \"extensions_unittests\": \"d0cdf0ff0f217213b3889fb6c9639ffa71c49197\", \"filesystem_service_unittests\": \"742b73be6597c0aa09ced91efdf00f3900af8b35\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"939692ecdc2d664e012e051ca4fb00505b69cb60\", \"gfx_unittests\": \"88d8004b513abfb734ae402d2817c9587dad64ba\", \"gin_unittests\": \"fbcd8101821cc2a5b6fec8074db424d48ab326e5\", \"google_apis_unittests\": \"7a398c9a186e37351c326529774156b35ec79c05\", \"gpu_unittests\": \"174df9da2a4a7aad9c0a262dba0e160f70c027f5\", \"grit_python_unittests\": \"3190828ba2be258fad1eb0bb444ea8f00c94d9d3\", \"gwp_asan_unittests\": \"550ef1e1732783e6eda842aed669e068d03626b4\", \"headless_browsertests\": \"1e30819ed08915052cba2f1fd4eb00a4223d3ea5\", \"headless_unittests\": \"a7a99f0af325dd2e46f83d34ba0644805c7c14fa\", \"interactive_ui_tests\": \"e1cc4906e15d6215f45fa7b1143ef3bfb8bb5c1c\", \"ipc_tests\": \"2482be58780f3ba88e7a04ceab742fd1cabe85ef\", \"jingle_unittests\": \"e3cf10d6925a7dbdda6f751bced63ab55191359d\", \"latency_unittests\": \"b3ddd72e8cb04b1d7bebb7afdee6407e1fb2145b\", \"libjingle_xmpp_unittests\": \"97ad7f02c612f66ce39030091462e67e6adf0c49\", \"media_blink_unittests\": \"930bcb2ceebe014c36a119b00cdbae5fbde7a8e9\", \"media_service_unittests\": \"b93848114c48bdc46d17f990b64350d002396c18\", \"media_unittests\": \"ecbcf2957543df79e5c8bc811480312108c6df48\", \"message_center_unittests\": \"bb24609d86c791b9d16ab349b934a958cd74dfc7\", \"metrics_python_tests\": \"1e6c31f16162ad6c25f5ecde96d951f2047d28fb\", \"midi_unittests\": \"7ee901774ce437a2c2726761e2d54a93806a96ce\", \"mojo_core_unittests\": \"7560a84f73ca21d18105bd2e069142c7422b29be\", \"mojo_unittests\": \"b12372651b4d3fdea670a1493b34e36a9df87637\", \"nacl_helper_nonsfi_unittests\": \"7c5f268d144d04318932a025a11f52b2b0931b82\", \"nacl_loader_unittests\": \"397009ca02abbaf5301ee80c2f4ffdb3a7b46ea9\", \"native_theme_unittests\": \"e53cf4751a734637f826b841e1aefce541fb8bfa\", \"net_unittests\": \"4a549c479bdae21ea107fb7fb964dbb3ca67a033\", \"pdf_unittests\": \"1530cba3c2d00445a6ed3d033ca880330f961a46\", \"perfetto_unittests\": \"ec9b9a31ee4f74117af23b3995a6f2808f0c9e69\", \"ppapi_unittests\": \"cbadf2302487d8685eb5c0916e0c7fc85133c891\", \"printing_unittests\": \"23e9bb82c2727c957a4199d081cd0433a0bf9137\", \"remoting_unittests\": \"5df68ee1fa3ef5171a6c7587bb6cd93bd56f0a9b\", \"sandbox_linux_unittests\": \"2191d9c628cf5b33a06b2b8b45fbce86d2f9c217\", \"service_manager_unittests\": \"3fc19c645fd5589fd9be460580ebf7ef4b7b863d\", \"services_unittests\": \"7d60c0fecd622e7e952ea81d7fa630c153ce0349\", \"shell_dialogs_unittests\": \"4fbf6ec6157041edbd66d4e5a7df43ef9c473fb1\", \"skia_unittests\": \"cc228fdda2d166b26e87f851c86f55cccd083d89\", \"snapshot_unittests\": \"c1ce1f339740f6a74de34eda7b5be91b0193f900\", \"sql_unittests\": \"93c04abce8f406e34083abccbf4e7d9b98bb5770\", \"storage_unittests\": \"a4aacf10a798da140d719b5c845b939cd877d79b\", \"sync_integration_tests\": \"6045515ab0720a328db4c5cb00494cecc626e414\", \"telemetry_gpu_unittests\": \"ccac76cf3e27bcab3ee0754de00a358c8f9ec11a\", \"telemetry_perf_unittests\": \"141152100bfdf1606db66a5d662ea2cb640bc235\", \"telemetry_unittests\": \"e1fef528a4762cb6a42864e9bfbe895381ea18ab\", \"traffic_annotation_auditor_unittests\": \"48da49989901a4f65e426c951d8ad1f157c84146\", \"ui_base_unittests\": \"5f8878ab18a3781cde22c2b1f104d74bd2943dc9\", \"ui_touch_selection_unittests\": \"b8b73aa174df7af1c3b2ba44a1fd7ad4128de5b6\", \"unit_tests\": \"3d6da43d261309b749c2732f0e9a8461fb3a54a5\", \"url_unittests\": \"a72fedd61067e6e29306cf8a864d90ac89e1ec3a\", \"views_perftests\": \"7143eb80f361769f72a8beb6be7ecae9e74e129c\", \"views_unittests\": \"ae33b627e0d41eebc88234d82a76eb3e36f44c90\", \"viz_unittests\": \"6792fe029f430ac6f7d72a4da1abc0dd511e222b\", \"vr_common_unittests\": \"4eede56b5b8e8f41778125eebc83105f0b05584e\", \"vr_pixeltests\": \"8b3a4b86e916f5116fd94840e98a8e144b26db41\", \"webdriver_wpt_tests\": \"75f83742fd4eb603ad9694e29ba6c1008b46e70f\", \"weblayer_browsertests\": \"dc0810e41486a128ff240026060cbf25ab298ded\", \"wm_unittests\": \"6a0886c1c44f320f2f037d6af8fa9ed6fae90408\", \"wtf_unittests\": \"16b208837f43a13c794b127b67ca2b099f3af94b\", \"xr_browser_tests\": \"c866a46fc46d0c905b0ed2ef51b85d0d7d2ff9ee\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_21b7b67cc5140fc86b3165a24b457b619be37de8070af45371e28279dc829f76_v2\", \"builder_9ccb21220795a1d1972030c6b5d9b4569472a28790e1458f6676edb8e4495e8f_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-4-oe8a\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4752-73c7603\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1578618590964148",
"status": "COMPLETED",
"status_changed_ts": "1578621325549112",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167199",
"builder:Linux Builder (dbg)",
"buildset:commit/git/8e1eba22b63153681863a0b34920836a442574f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e1eba22b63153681863a0b34920836a442574f8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057122396490939792",
"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/8891692334269571520/+/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:49a5cf04dee1d110",
"user_agent:luci-scheduler"
],
"updated_ts": "1578621325577134",
"url": "https://ci.chromium.org/b/8891692334269571520",
"utcnow_ts": "1578621326259983"
}
}
[01:55:26.275] Invocation finished in 48m34.14889888s with status SUCCEEDED