[02:14:07.074] New invocation is queued and will start shortly
[02:14:10.188] Starting the invocation (attempt 1)
[02:14:10.276] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:14:10.276] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:14:10.276] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9055487420165647328",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4a881e7e6ff345e0e0541bcd182c5b76e275bad8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9055487420165647328",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/4a881e7e6ff345e0e0541bcd182c5b76e275bad8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4a881e7e6ff345e0e0541bcd182c5b76e275bad8",
"gitiles_ref:refs/heads/master"
]
}
[02:14:11.201] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1580177650534442",
"id": "8890057355871770384",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4a881e7e6ff345e0e0541bcd182c5b76e275bad8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580177650945108",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167916",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4a881e7e6ff345e0e0541bcd182c5b76e275bad8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4a881e7e6ff345e0e0541bcd182c5b76e275bad8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055487420165647328",
"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/8890057355871770384/+/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": "1580177650945247",
"url": "https://ci.chromium.org/b/8890057355871770384",
"utcnow_ts": "1580177651179961"
}
}
[02:14:11.201] Task URL: https://ci.chromium.org/b/8890057355871770384
[02:14:11.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:2:0) after 1m0s
[02:15:11.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:2:0)
[02:15:11.221] Timer tick, asking Buildbucket for the build status
[02:15:11.466] Build 8890057355871770384: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:11.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:3:0) after 1m0s
[02:16:11.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:3:0)
[02:16:11.477] Timer tick, asking Buildbucket for the build status
[02:16:11.686] Build 8890057355871770384: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:11.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:4:0) after 1m0s
[02:17:11.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:4:0)
[02:17:11.743] Timer tick, asking Buildbucket for the build status
[02:17:11.960] Build 8890057355871770384: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:11.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:5:0) after 1m0s
[02:18:12.096] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:5:0)
[02:18:12.096] Timer tick, asking Buildbucket for the build status
[02:18:13.744] Build 8890057355871770384: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:13.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:6:0) after 1m0s
[02:19:06.065] Received PubSub notification, asking Buildbucket for the build status
[02:19:06.533] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:13.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:6:0)
[02:19:13.784] Timer tick, asking Buildbucket for the build status
[02:19:14.007] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:14.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:8:0) after 1m0s
[02:20:14.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:8:0)
[02:20:14.085] Timer tick, asking Buildbucket for the build status
[02:20:14.327] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:14.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:9:0) after 1m0s
[02:21:14.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:9:0)
[02:21:14.422] Timer tick, asking Buildbucket for the build status
[02:21:15.262] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:15.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:10:0) after 1m0s
[02:22:15.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:10:0)
[02:22:15.317] Timer tick, asking Buildbucket for the build status
[02:22:16.170] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:16.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:11:0) after 1m0s
[02:23:16.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:11:0)
[02:23:16.147] Timer tick, asking Buildbucket for the build status
[02:23:16.355] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:16.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:12:0) after 1m0s
[02:24:16.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:12:0)
[02:24:16.423] Timer tick, asking Buildbucket for the build status
[02:24:16.624] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:16.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:13:0) after 1m0s
[02:25:16.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:13:0)
[02:25:16.667] Timer tick, asking Buildbucket for the build status
[02:25:16.807] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:16.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:14:0) after 1m0s
[02:26:16.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:14:0)
[02:26:16.824] Timer tick, asking Buildbucket for the build status
[02:26:17.224] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:17.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:15:0) after 1m0s
[02:27:17.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:15:0)
[02:27:17.355] Timer tick, asking Buildbucket for the build status
[02:27:17.525] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:17.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:16:0) after 1m0s
[02:28:17.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:16:0)
[02:28:17.570] Timer tick, asking Buildbucket for the build status
[02:28:17.769] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:17.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:17:0) after 1m0s
[02:29:17.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:17:0)
[02:29:17.874] Timer tick, asking Buildbucket for the build status
[02:29:18.632] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:18.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:18:0) after 1m0s
[02:30:18.656] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:18:0)
[02:30:18.656] Timer tick, asking Buildbucket for the build status
[02:30:18.935] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:18.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:19:0) after 1m0s
[02:31:18.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:19:0)
[02:31:18.954] Timer tick, asking Buildbucket for the build status
[02:31:19.227] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:19.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:20:0) after 1m0s
[02:32:19.250] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:20:0)
[02:32:19.250] Timer tick, asking Buildbucket for the build status
[02:32:19.797] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:19.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:21:0) after 1m0s
[02:33:19.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:21:0)
[02:33:19.810] Timer tick, asking Buildbucket for the build status
[02:33:20.016] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:20.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:22:0) after 1m0s
[02:34:20.041] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:22:0)
[02:34:20.041] Timer tick, asking Buildbucket for the build status
[02:34:20.571] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:20.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:23:0) after 1m0s
[02:35:20.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:23:0)
[02:35:20.619] Timer tick, asking Buildbucket for the build status
[02:35:21.381] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:21.381] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:24:0) after 1m0s
[02:36:21.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:24:0)
[02:36:21.406] Timer tick, asking Buildbucket for the build status
[02:36:21.880] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:21.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:25:0) after 1m0s
[02:37:21.904] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:25:0)
[02:37:21.904] Timer tick, asking Buildbucket for the build status
[02:37:22.056] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:22.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:26:0) after 1m0s
[02:38:22.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:26:0)
[02:38:22.134] Timer tick, asking Buildbucket for the build status
[02:38:22.417] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:22.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:27:0) after 1m0s
[02:39:22.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:27:0)
[02:39:22.446] Timer tick, asking Buildbucket for the build status
[02:39:22.777] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:22.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:28:0) after 1m0s
[02:40:22.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:28:0)
[02:40:22.815] Timer tick, asking Buildbucket for the build status
[02:40:22.994] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:22.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:29:0) after 1m0s
[02:41:23.058] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:29:0)
[02:41:23.058] Timer tick, asking Buildbucket for the build status
[02:41:23.294] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:23.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:30:0) after 1m0s
[02:42:23.412] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:30:0)
[02:42:23.412] Timer tick, asking Buildbucket for the build status
[02:42:24.129] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:24.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:31:0) after 1m0s
[02:43:24.151] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:31:0)
[02:43:24.151] Timer tick, asking Buildbucket for the build status
[02:43:24.550] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:24.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:32:0) after 1m0s
[02:44:24.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:32:0)
[02:44:24.702] Timer tick, asking Buildbucket for the build status
[02:44:24.905] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:24.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:33:0) after 1m0s
[02:45:24.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:33:0)
[02:45:24.973] Timer tick, asking Buildbucket for the build status
[02:45:25.485] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:25.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:34:0) after 1m0s
[02:46:25.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:34:0)
[02:46:25.518] Timer tick, asking Buildbucket for the build status
[02:46:25.733] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:25.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:35:0) after 1m0s
[02:47:25.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:35:0)
[02:47:25.784] Timer tick, asking Buildbucket for the build status
[02:47:26.237] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:26.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:36:0) after 1m0s
[02:48:26.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:36:0)
[02:48:26.402] Timer tick, asking Buildbucket for the build status
[02:48:26.603] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:26.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:37:0) after 1m0s
[02:49:26.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:37:0)
[02:49:26.679] Timer tick, asking Buildbucket for the build status
[02:49:26.819] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:26.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:38:0) after 1m0s
[02:50:27.190] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:38:0)
[02:50:27.190] Timer tick, asking Buildbucket for the build status
[02:50:27.402] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:27.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:39:0) after 1m0s
[02:51:27.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:39:0)
[02:51:27.454] Timer tick, asking Buildbucket for the build status
[02:51:27.736] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:27.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:40:0) after 1m0s
[02:52:27.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:40:0)
[02:52:27.809] Timer tick, asking Buildbucket for the build status
[02:52:28.084] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:28.084] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:41:0) after 1m0s
[02:53:28.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:41:0)
[02:53:28.135] Timer tick, asking Buildbucket for the build status
[02:53:28.318] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:28.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:42:0) after 1m0s
[02:54:28.345] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:42:0)
[02:54:28.345] Timer tick, asking Buildbucket for the build status
[02:54:28.532] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:28.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:43:0) after 1m0s
[02:55:28.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:43:0)
[02:55:28.559] Timer tick, asking Buildbucket for the build status
[02:55:29.299] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:29.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:44:0) after 1m0s
[02:56:29.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:44:0)
[02:56:29.368] Timer tick, asking Buildbucket for the build status
[02:56:30.412] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:30.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:45:0) after 1m0s
[02:57:30.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:45:0)
[02:57:30.488] Timer tick, asking Buildbucket for the build status
[02:57:30.751] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:30.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:46:0) after 1m0s
[02:58:30.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:46:0)
[02:58:30.839] Timer tick, asking Buildbucket for the build status
[02:58:31.222] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:31.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:47:0) after 1m0s
[02:59:31.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:47:0)
[02:59:31.543] Timer tick, asking Buildbucket for the build status
[02:59:31.856] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:31.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:48:0) after 1m0s
[03:00:31.911] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:48:0)
[03:00:31.911] Timer tick, asking Buildbucket for the build status
[03:00:32.050] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:32.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:49:0) after 1m0s
[03:01:32.243] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:49:0)
[03:01:32.243] Timer tick, asking Buildbucket for the build status
[03:01:32.603] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:32.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:50:0) after 1m0s
[03:02:32.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:50:0)
[03:02:32.744] Timer tick, asking Buildbucket for the build status
[03:02:34.816] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:34.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:51:0) after 1m0s
[03:03:34.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:51:0)
[03:03:34.910] Timer tick, asking Buildbucket for the build status
[03:03:35.237] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:35.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:52:0) after 1m0s
[03:04:35.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:52:0)
[03:04:35.318] Timer tick, asking Buildbucket for the build status
[03:04:35.596] Build 8890057355871770384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:35.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055487420165647328:53:0) after 1m0s
[03:05:02.727] Received PubSub notification, asking Buildbucket for the build status
[03:05:02.849] Build 8890057355871770384: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:05:02.849] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1580180701996493",
"created_by": "project:chromium",
"created_ts": "1580177650534442",
"id": "8890057355871770384",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4a881e7e6ff345e0e0541bcd182c5b76e275bad8\"}}",
"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\"}, \"$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-45-c65i\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 167916, \"got_angle_revision\": \"2d1d9d35216b7fba0bde13ec033d1b9124ae571e\", \"got_dawn_revision\": \"f329c78b6cb0918e4aeafc9bebdf27173aa710a7\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"4a881e7e6ff345e0e0541bcd182c5b76e275bad8\", \"got_revision_cp\": \"refs/heads/master@{#735703}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"34e16df059f8c69f0409e167b4d2e7ef59bf7b55\", \"got_v8_revision\": \"5461451d0802a553ef74684bff602434668cb951\", \"got_v8_revision_cp\": \"refs/heads/8.1.290@{#1}\", \"got_webrtc_revision\": \"11b66cf1103c54781ec53f5f75e490959ae9edd1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30386}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4a881e7e6ff345e0e0541bcd182c5b76e275bad8\", \"swarm_hashes_refs/heads/master(at){#735703}_without_patch\": {\"accessibility_unittests\": \"bfc7275a6ff1bf0ff2c04dbb250313dcf16e0123\", \"angle_unittests\": \"8a520ba5b66a258db5025c470e04f3cedf3a39ef\", \"app_shell_unittests\": \"1357ab025923f70156b09deaf6b35c96bc6f94bb\", \"aura_unittests\": \"cc159ad1a3139dfdfcfce12f039b3551eaa6a939\", \"base_unittests\": \"fc867d55717df6017428dc0d80c62b434ea1cf10\", \"base_util_unittests\": \"8a148e576642a7ffdc7bd10ced6c7e4508c2448a\", \"blink_common_unittests\": \"c5bd7c30a78e3c1f606a5c9399b726c00148108a\", \"blink_fuzzer_unittests\": \"c6ae7ae56918eb15bf0afa7d6b55b267ba849554\", \"blink_heap_unittests\": \"b0f584b83b2806b2389325a4894d6675839f6ac5\", \"blink_platform_unittests\": \"c77da80a31c1f62d73e2733f4f3ea6151a2260b9\", \"blink_python_tests\": \"1337e1fb47214dc4fcaad75f341e985ada5c30b4\", \"blink_unittests\": \"5a4e85a06ed5c814603d5c86477a425a37666b36\", \"blink_web_tests\": \"f418eb854691dd0e62f72be9e72efd579cbb22e1\", \"boringssl_crypto_tests\": \"d8142a4a4cff95869707e75d28c46e3e6289c786\", \"boringssl_ssl_tests\": \"607f51d6773070c06ff42f1fae5b041e17a3d97a\", \"browser_tests\": \"227494e51d0113277bb75b0abab19fc9c0a9ac14\", \"cacheinvalidation_unittests\": \"78b2db37187597530958e7fcff24999173b56076\", \"capture_unittests\": \"739f74dc72786d722043e38284f75f6d1b22720d\", \"cast_unittests\": \"3c0facee4186391ad00769c6680015710d1eaa50\", \"cc_unittests\": \"edaf043d9e45598de1a02a213e7f71e4694f7943\", \"chrome_app_unittests\": \"9c93031ba2a24e77010a6966e8f9fdab4ca3c798\", \"chromedriver_unittests\": \"219a92cb342452706de734df005e881c11663854\", \"components_browsertests\": \"4ed966362c2894dc2b561acfb221cf5e8b854687\", \"components_unittests\": \"d6c6ae0a0c9b5075c038927ee5943d2c5c7fe9ba\", \"compositor_unittests\": \"f35492da81df24307c3b99068028f54c285d9114\", \"content_browsertests\": \"2eb4c43652bcc64ee64d93023d33bcad97a108c1\", \"content_shell_crash_test\": \"db428fbdabfef4a7a6b500ade050a5ed94115fb4\", \"content_unittests\": \"c68a62a6a28e71002ed41dc9f4d6cec9cad3e7f6\", \"crashpad_tests\": \"969fde98d808cad762f6b82d9850ece1a0fbe99f\", \"cronet_tests\": \"1e58520c98ec929a7f2cdc3707ab5084d6edc203\", \"cronet_unittests\": \"33dbc1899fd56c39ba802a1f206e42abc61d2c56\", \"crypto_unittests\": \"6df6d56a37f89bec2822642053cac9a0838b4fed\", \"dbus_unittests\": \"9793682b5c42f36c2177917a096482d1ed096921\", \"device_unittests\": \"4fc2d82accaac8983bc421fa587cd00bede4db04\", \"display_unittests\": \"a7f161691aa75b6d0b9b99f4f6a59b38a6cfa208\", \"events_unittests\": \"d7f1db424d2879ca22e630d20c24ddf05023e485\", \"extensions_browsertests\": \"de247a083207efdffa17027b7b095779a9c218d9\", \"extensions_unittests\": \"50d3e143c2839b34bcdb5487aec62bf86aa8eec4\", \"filesystem_service_unittests\": \"ae00c02e453c353418323d4542a6aea6ba90c390\", \"flatbuffers_unittests\": \"42e8acf74bc3e5f369966eb9aa16ff63f9e6640b\", \"gcm_unit_tests\": \"7a344fa04c194e8ec63b93ec11ceeab08fbedc3f\", \"gfx_unittests\": \"e0513bf532444071bbd8ec5ccfdc3752d4d730bc\", \"gin_unittests\": \"7b141899996a3355ad1826321f90687e28968495\", \"google_apis_unittests\": \"88b1f9bd2b99350aa3793908316e1ca8e560fed2\", \"gpu_unittests\": \"e10820cee5c992393152242935ea20263fe26cf1\", \"grit_python_unittests\": \"e78e7c3110422cb6e387105e898475b15c4b1be1\", \"gwp_asan_unittests\": \"5cace57cee9acc8577adf49f568cbd199730e0ce\", \"headless_browsertests\": \"31ffe47c7c9b3812088b692f6fdad43610dc32dd\", \"headless_unittests\": \"5d9852efe443ce8653775355ce9751784780387f\", \"interactive_ui_tests\": \"9da9254c2b6a765590e99cf782d185b3d23ee76b\", \"ipc_tests\": \"de0956794b8520cc1218def0954435eed5a75be8\", \"jingle_unittests\": \"93a03e5a0f1a046febabe0d5b1728aca2f0e8348\", \"latency_unittests\": \"6f3a541b99c71561904aab16eea44158beb558d4\", \"libjingle_xmpp_unittests\": \"fbf1d61fae05df810dc1820ec7bdc18bb0c9d7e4\", \"media_blink_unittests\": \"2f5fe202f803f05c587b30e31942fd08119ce953\", \"media_service_unittests\": \"1e65811262b9a155533acc203b46a2721341fb97\", \"media_unittests\": \"ee9db2bca9dc7225e641058d9ca79ea48a6e8dd2\", \"message_center_unittests\": \"2f5b2219f748198f2a204c0179d2ad5a724bda1d\", \"metrics_python_tests\": \"549f6a5c40a045c9fdfcc6a2b00614f56e0e7f07\", \"midi_unittests\": \"5155dfe0601b027d7dbdaa042de51ef3953952b4\", \"mojo_core_unittests\": \"82019630870aea8da903f5a9b039646909679a98\", \"mojo_unittests\": \"b2366be351fabaa7daa99b76535ac415b3b3ae69\", \"nacl_helper_nonsfi_unittests\": \"e5f6748aebd00fe1ec77ebcf304befb56f7d9684\", \"nacl_loader_unittests\": \"7a15e2fd3c8e515dd42a64926479fc6909801636\", \"native_theme_unittests\": \"60d514a33f5611991ca121737e99c8e0701b699a\", \"net_unittests\": \"cdd3b802f80f53a4148dc40fd01cb0e336511123\", \"pdf_unittests\": \"7390d221be0aa59ebc65f13df6248d3fd6ee7511\", \"perfetto_unittests\": \"a86473cde12eb6e5a9cc194608cb7a9b3abd7b23\", \"ppapi_unittests\": \"fee0c136aeec16b15e8ea7cb5d6c597f5eb1d5e2\", \"printing_unittests\": \"6fd4c2451d37dcbdde1bcd58aa5170f34b4d4bda\", \"remoting_unittests\": \"93d27412f085c99745cd3060c7d02d7a78b68626\", \"sandbox_linux_unittests\": \"9b1f4ec6ac6f14ccee0017f4879ed27c9134bdf9\", \"service_manager_unittests\": \"7644818898b079a3e1de7d438837648d801ba6b3\", \"services_unittests\": \"1dfe18623cbbfd754574a3726e7fa2a9bfb30df2\", \"shell_dialogs_unittests\": \"cad94f14beb905144f6d72c6ef9ccc8ad38e6f7a\", \"skia_unittests\": \"bc2f8566e778faaa551094f897df1b147b93f732\", \"snapshot_unittests\": \"8389a455cfa025443e60d68bc8dc7893ff6bc446\", \"sql_unittests\": \"e5db24c3c0fbba3afd2b651a5412c3a2ec3a7104\", \"storage_unittests\": \"191459b020f3840eab16085a5f823e3b460a10eb\", \"sync_integration_tests\": \"86d0e0bef6fe315bbb8157445e440dd5017ed1bc\", \"telemetry_gpu_unittests\": \"2d9f9dbb4b240e9e5582bab1ae01304b7ce14bcb\", \"telemetry_perf_unittests\": \"01b4c56bf2aadb192a9adb42a23f6c3b4a56f054\", \"telemetry_unittests\": \"b207b88297a7f7e4f1bee254934cc41c88a337fb\", \"traffic_annotation_auditor_unittests\": \"52532e33e90d65c1175dd7d6a4eb2f5ffbae2480\", \"ui_base_unittests\": \"a9bd5e2433893eae4a774a2579cef09fd023539b\", \"ui_touch_selection_unittests\": \"8d65790001e2e71c0a229acd75341164baa59dd3\", \"unit_tests\": \"9b8ce5e3e729e46c16093f7573ca423e0e33d7f7\", \"url_unittests\": \"fe3367393540ea22aa18ef7132a32d21f1f40c63\", \"views_perftests\": \"265e18298282939e48a98f1848b6f93c6df6b789\", \"views_unittests\": \"da58c54963dd9ef80760d9af45f0b0a883b55f49\", \"viz_unittests\": \"3671142a07d68979776ac9537a5c4738738b6222\", \"vr_common_unittests\": \"12d70f5c3ca06549c45d38c75f40a261254c3a2c\", \"vr_pixeltests\": \"53b83c84b8b4bfa5af59a73a6352fab81f478048\", \"webdriver_wpt_tests\": \"c3ed9452b6aace194b6eab5c7cd0b5b28ab7d09a\", \"weblayer_browsertests\": \"40b533e83a4ee2ad092fee2bf2617804814f755f\", \"wm_unittests\": \"f6cb17fe75a38bdcbf97e1cd4c1c72bd7f702784\", \"wtf_unittests\": \"44a8a7216fa1df014da1291714f2a7b2edf2ea97\", \"xr_browser_tests\": \"ecc8ee99b4616029d75d20805acc920663754550\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_f5174a4d80cdc4c8aa1989fa45d69979d28910f768af140dd646791c34143bfe_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-45-c65i\"], \"image\": [\"chrome-xenial-20011200-47b90f1b63b\"], \"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\": [\"4801-8ac0b59\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580177945260039",
"status": "COMPLETED",
"status_changed_ts": "1580180702337707",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167916",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4a881e7e6ff345e0e0541bcd182c5b76e275bad8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4a881e7e6ff345e0e0541bcd182c5b76e275bad8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055487420165647328",
"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/8890057355871770384/+/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:4a02befe447bb410",
"user_agent:luci-scheduler"
],
"updated_ts": "1580180702343542",
"url": "https://ci.chromium.org/b/8890057355871770384",
"utcnow_ts": "1580180702842616"
}
}
[03:05:02.849] Invocation finished in 50m55.793744066s with status SUCCEEDED