[04:05:04.814] New invocation is queued and will start shortly
[04:05:06.332] Starting the invocation (attempt 1)
[04:05:06.374] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:05:06.374] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:05:06.374] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028935527863035952",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c3b76ce54db647e770ae7ea71e9082b3a60c82fe\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9028935527863035952",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/c3b76ce54db647e770ae7ea71e9082b3a60c82fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c3b76ce54db647e770ae7ea71e9082b3a60c82fe",
"gitiles_ref:refs/heads/master"
]
}
[04:05:07.072] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605499506511031",
"id": "8863505465418578384",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c3b76ce54db647e770ae7ea71e9082b3a60c82fe\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605499506928819",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177702",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c3b76ce54db647e770ae7ea71e9082b3a60c82fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c3b76ce54db647e770ae7ea71e9082b3a60c82fe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028935527863035952",
"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/8863505465418578384/+/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": "1605499506928963",
"url": "https://ci.chromium.org/b/8863505465418578384",
"utcnow_ts": "1605499507060924"
}
}
[04:05:07.072] Task URL: https://ci.chromium.org/b/8863505465418578384
[04:05:07.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:2:0) after 1m0s
[04:05:12.511] Received PubSub notification, asking Buildbucket for the build status
[04:05:12.586] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:07.109] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:2:0)
[04:06:07.109] Timer tick, asking Buildbucket for the build status
[04:06:07.393] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:07.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:4:0) after 1m0s
[04:07:07.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:4:0)
[04:07:07.432] Timer tick, asking Buildbucket for the build status
[04:07:07.887] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:07.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:5:0) after 1m0s
[04:08:07.907] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:5:0)
[04:08:07.908] Timer tick, asking Buildbucket for the build status
[04:08:07.973] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:07.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:6:0) after 1m0s
[04:09:08.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:6:0)
[04:09:08.017] Timer tick, asking Buildbucket for the build status
[04:09:08.137] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:08.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:7:0) after 1m0s
[04:10:08.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:7:0)
[04:10:08.189] Timer tick, asking Buildbucket for the build status
[04:10:08.332] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:08.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:8:0) after 1m0s
[04:11:08.392] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:8:0)
[04:11:08.392] Timer tick, asking Buildbucket for the build status
[04:11:08.826] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:08.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:9:0) after 1m0s
[04:12:08.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:9:0)
[04:12:08.843] Timer tick, asking Buildbucket for the build status
[04:12:09.191] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:09.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:10:0) after 1m0s
[04:13:09.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:10:0)
[04:13:09.219] Timer tick, asking Buildbucket for the build status
[04:13:09.783] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:09.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:11:0) after 1m0s
[04:14:09.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:11:0)
[04:14:09.934] Timer tick, asking Buildbucket for the build status
[04:14:10.011] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:10.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:12:0) after 1m0s
[04:15:10.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:12:0)
[04:15:10.165] Timer tick, asking Buildbucket for the build status
[04:15:10.312] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:10.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:13:0) after 1m0s
[04:16:10.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:13:0)
[04:16:10.401] Timer tick, asking Buildbucket for the build status
[04:16:10.467] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:10.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:14:0) after 1m0s
[04:17:10.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:14:0)
[04:17:10.571] Timer tick, asking Buildbucket for the build status
[04:17:10.646] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:10.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:15:0) after 1m0s
[04:18:10.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:15:0)
[04:18:10.929] Timer tick, asking Buildbucket for the build status
[04:18:11.004] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:11.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:16:0) after 1m0s
[04:19:11.141] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:16:0)
[04:19:11.141] Timer tick, asking Buildbucket for the build status
[04:19:11.207] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:11.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:17:0) after 1m0s
[04:20:11.252] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:17:0)
[04:20:11.252] Timer tick, asking Buildbucket for the build status
[04:20:11.399] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:11.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:18:0) after 1m0s
[04:21:11.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:18:0)
[04:21:11.739] Timer tick, asking Buildbucket for the build status
[04:21:11.834] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:11.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:19:0) after 1m0s
[04:22:12.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:19:0)
[04:22:12.067] Timer tick, asking Buildbucket for the build status
[04:22:12.143] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:12.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:20:0) after 1m0s
[04:23:12.259] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:20:0)
[04:23:12.259] Timer tick, asking Buildbucket for the build status
[04:23:12.330] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:12.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:21:0) after 1m0s
[04:24:12.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:21:0)
[04:24:12.588] Timer tick, asking Buildbucket for the build status
[04:24:12.647] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:12.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:22:0) after 1m0s
[04:25:12.827] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:22:0)
[04:25:12.827] Timer tick, asking Buildbucket for the build status
[04:25:13.013] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:13.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:23:0) after 1m0s
[04:26:13.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:23:0)
[04:26:13.139] Timer tick, asking Buildbucket for the build status
[04:26:13.215] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:13.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:24:0) after 1m0s
[04:27:13.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:24:0)
[04:27:13.305] Timer tick, asking Buildbucket for the build status
[04:27:13.372] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:13.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:25:0) after 1m0s
[04:28:13.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:25:0)
[04:28:13.401] Timer tick, asking Buildbucket for the build status
[04:28:13.628] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:13.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:26:0) after 1m0s
[04:29:13.704] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:26:0)
[04:29:13.704] Timer tick, asking Buildbucket for the build status
[04:29:13.775] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:13.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:27:0) after 1m0s
[04:30:13.761] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:27:0)
[04:30:13.761] Timer tick, asking Buildbucket for the build status
[04:30:14.070] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:14.070] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:28:0) after 1m0s
[04:31:14.130] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:28:0)
[04:31:14.130] Timer tick, asking Buildbucket for the build status
[04:31:14.196] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:14.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:29:0) after 1m0s
[04:32:14.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:29:0)
[04:32:14.257] Timer tick, asking Buildbucket for the build status
[04:32:14.333] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:14.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:30:0) after 1m0s
[04:33:14.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:30:0)
[04:33:14.380] Timer tick, asking Buildbucket for the build status
[04:33:14.485] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:14.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:31:0) after 1m0s
[04:34:14.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:31:0)
[04:34:14.548] Timer tick, asking Buildbucket for the build status
[04:34:14.619] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:14.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:32:0) after 1m0s
[04:35:14.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:32:0)
[04:35:14.655] Timer tick, asking Buildbucket for the build status
[04:35:14.778] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:14.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:33:0) after 1m0s
[04:36:14.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:33:0)
[04:36:14.799] Timer tick, asking Buildbucket for the build status
[04:36:14.868] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:14.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:34:0) after 1m0s
[04:37:14.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:34:0)
[04:37:14.937] Timer tick, asking Buildbucket for the build status
[04:37:15.400] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:15.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:35:0) after 1m0s
[04:38:15.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:35:0)
[04:38:15.542] Timer tick, asking Buildbucket for the build status
[04:38:15.622] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:15.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:36:0) after 1m0s
[04:39:15.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:36:0)
[04:39:15.708] Timer tick, asking Buildbucket for the build status
[04:39:15.977] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:15.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:37:0) after 1m0s
[04:40:16.090] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:37:0)
[04:40:16.090] Timer tick, asking Buildbucket for the build status
[04:40:16.322] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:16.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:38:0) after 1m0s
[04:41:16.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:38:0)
[04:41:16.458] Timer tick, asking Buildbucket for the build status
[04:41:16.809] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:16.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:39:0) after 1m0s
[04:42:16.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:39:0)
[04:42:16.880] Timer tick, asking Buildbucket for the build status
[04:42:16.947] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:16.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:40:0) after 1m0s
[04:43:17.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:40:0)
[04:43:17.028] Timer tick, asking Buildbucket for the build status
[04:43:17.103] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:17.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:41:0) after 1m0s
[04:44:17.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:41:0)
[04:44:17.136] Timer tick, asking Buildbucket for the build status
[04:44:17.241] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:17.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:42:0) after 1m0s
[04:45:17.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:42:0)
[04:45:17.329] Timer tick, asking Buildbucket for the build status
[04:45:17.511] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:17.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:43:0) after 1m0s
[04:46:17.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:43:0)
[04:46:17.545] Timer tick, asking Buildbucket for the build status
[04:46:17.622] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:17.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:44:0) after 1m0s
[04:47:17.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:44:0)
[04:47:17.645] Timer tick, asking Buildbucket for the build status
[04:47:17.766] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:17.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:45:0) after 1m0s
[04:48:17.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:45:0)
[04:48:17.756] Timer tick, asking Buildbucket for the build status
[04:48:17.904] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:17.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:46:0) after 1m0s
[04:49:17.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:46:0)
[04:49:17.942] Timer tick, asking Buildbucket for the build status
[04:49:18.016] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:18.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:47:0) after 1m0s
[04:50:18.080] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:47:0)
[04:50:18.080] Timer tick, asking Buildbucket for the build status
[04:50:18.201] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:18.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:48:0) after 1m0s
[04:51:18.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:48:0)
[04:51:18.302] Timer tick, asking Buildbucket for the build status
[04:51:18.367] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:18.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:49:0) after 1m0s
[04:52:18.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:49:0)
[04:52:18.430] Timer tick, asking Buildbucket for the build status
[04:52:18.515] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:18.515] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:50:0) after 1m0s
[04:53:18.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:50:0)
[04:53:18.542] Timer tick, asking Buildbucket for the build status
[04:53:18.632] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:18.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:51:0) after 1m0s
[04:54:18.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:51:0)
[04:54:18.680] Timer tick, asking Buildbucket for the build status
[04:54:18.749] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:18.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:52:0) after 1m0s
[04:55:18.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:52:0)
[04:55:18.835] Timer tick, asking Buildbucket for the build status
[04:55:18.958] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:18.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:53:0) after 1m0s
[04:56:18.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:53:0)
[04:56:18.983] Timer tick, asking Buildbucket for the build status
[04:56:19.131] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:19.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:54:0) after 1m0s
[04:57:19.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:54:0)
[04:57:19.212] Timer tick, asking Buildbucket for the build status
[04:57:19.489] Build 8863505465418578384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:19.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028935527863035952:55:0) after 1m0s
[04:57:48.768] Received PubSub notification, asking Buildbucket for the build status
[04:57:48.864] Build 8863505465418578384: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:57:48.864] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605502667832198",
"created_by": "project:chromium",
"created_ts": "1605499506511031",
"id": "8863505465418578384",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c3b76ce54db647e770ae7ea71e9082b3a60c82fe\"}}",
"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\": \"c3b76ce54db647e770ae7ea71e9082b3a60c82fe\", \"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-33-4q3b\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177702, \"got_angle_revision\": \"f46e6201b40bdee3e0b79d5d97660fc302fd76f5\", \"got_dawn_revision\": \"575729e8dd25e0ac4631c9739a82118ea3545c6b\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"c3b76ce54db647e770ae7ea71e9082b3a60c82fe\", \"got_revision_cp\": \"refs/heads/master@{#827675}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e4c1a25cc6797a47043fc415c53b8edcd7b3e37e\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"99df1af2aed6a8d10bc62dc348f63d6c084c1949\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32609}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c3b76ce54db647e770ae7ea71e9082b3a60c82fe\", \"swarm_hashes_refs/heads/master(at){#827675}_without_patch\": {\"absl_hardening_tests\": \"4d3a4b0d772998cacfb4759310287ffdf8d3e867\", \"accessibility_unittests\": \"b1f5d103ba55abf7379c64b46b4abd3e091ad238\", \"angle_unittests\": \"bdcfd48b06fbf1b483ccd32fbfdc301b251757c2\", \"app_shell_unittests\": \"91e66165ab386d0dda6684ec3299d23a81ecc172\", \"aura_unittests\": \"a8dcb327fac2ddac28b1b2d3a768192ed46586ef\", \"base_unittests\": \"ee05499a974818d1ddaa69db9beb8d5e3241b4c5\", \"base_util_unittests\": \"05aae0943492caa7d063c4a3701147296b23ca43\", \"blink_common_unittests\": \"0ce5ca05330edb3a65116c06632b7da792c71d49\", \"blink_fuzzer_unittests\": \"7d598ed640c2fbf98d348bb736722e2631333570\", \"blink_heap_unittests\": \"4be07754702f8cc6fc6ce60f21ee0ecdccc1da86\", \"blink_platform_unittests\": \"ea28b8df06b4fc00ef13bbfcca387da83132c479\", \"blink_python_tests\": \"8fbe0e76aaaf858742779c2a5212848b9a424d8f\", \"blink_unittests\": \"db95ac4cf2a8e2651fed9f25c66855266253a6f7\", \"blink_web_tests\": \"98ead073203761c956f747416fbfae8824245705\", \"boringssl_crypto_tests\": \"d6081fc6f2b7d1edd78ba3a0c0843aa6b001bd64\", \"boringssl_ssl_tests\": \"cd71e580644ca1fa20fe64f429cd8607298c35d7\", \"browser_tests\": \"e250430207b5df79f978f9efae9c4b4b66494b42\", \"capture_unittests\": \"d71ac92a5173833c989aee61beead728e921eb6b\", \"cast_unittests\": \"d18688dbfc70a34b7dbdd4c3df6c7b6ca9304f45\", \"cc_unittests\": \"f47724e9e874d823e578ff487d17386575764031\", \"chrome_app_unittests\": \"6571b1a96af2965901098ba4bc1de34302bdf42c\", \"chromedriver_unittests\": \"868cfa4531cb15a197a5dd3d131263c433fc50f4\", \"components_browsertests\": \"28964a9d431630133d85ab6c6d83e6aec49e577b\", \"components_unittests\": \"400039cbc3dc27e1c45249febdea6f613597d386\", \"compositor_unittests\": \"ba98259ca1a6ec7a0fc01971b319cff898d7dfb0\", \"content_browsertests\": \"43df4d362e3b05a51af06f64ad6ac3ccc8732f67\", \"content_shell_crash_test\": \"d0a925c763abc174fc79a2757d8c9618d3151a00\", \"content_unittests\": \"1c0e0a439ddab672d1085aa405b7aedb3f3f47d4\", \"crashpad_tests\": \"8e322e6c8a5f78ea74fd71677bb43a88174bfd27\", \"cronet_tests\": \"3a8edc7785d138122f96b451ad2565c6712df88f\", \"cronet_unittests\": \"a17c3102c540f71c34c2d4d575d0ba4ba5e3b1b4\", \"crypto_unittests\": \"c9fab42cc50b508d8b218b617699694fa74858c1\", \"dbus_unittests\": \"d244860a471de23a83c839d3911de67048e4f072\", \"device_unittests\": \"6f13ea277b5c01dd4ee0b1c441a301f75dcdbf55\", \"display_unittests\": \"2a87d88487cc11952ce370aa24124fa283beb00c\", \"events_unittests\": \"1b66746ac2734d0e29b89b7b8d19805fc4483445\", \"extension_docserver_python_unittests\": \"a72e9bbdf675ff15666492e288c6f7dce1673db6\", \"extensions_browsertests\": \"cae6b9e0edd46a6f942f6e8bb64593ca8dbad3d5\", \"extensions_unittests\": \"7b6707084d2628d46eb712e47b624cdc2854b04e\", \"filesystem_service_unittests\": \"76170e91ea429562099f6361caa27e6f52bcdb24\", \"flatbuffers_unittests\": \"e44ed88e1dde0ef7f6136eb0949503718efe54b6\", \"gcm_unit_tests\": \"e914c295ad1af463659ab2e250753ecf9a15a75b\", \"gfx_unittests\": \"febfb682c5bb82eb78c95a5b748f219680da6239\", \"gin_unittests\": \"a6742c35b2e1215e5a648cfa8e86d00d2a409bc3\", \"google_apis_unittests\": \"87e0e286e73c2849749bfc06766cade81f4d7a2d\", \"gpu_unittests\": \"fe7b979297e9dfe27bab11d36f1dc889b3da90e6\", \"grit_python_unittests\": \"f4020ed5757956fbd2d0e1bd58035b529a5e6a74\", \"gwp_asan_unittests\": \"02f93cb1c148b9244b919449e15092bd42d959c2\", \"headless_browsertests\": \"015e7960ad3f3fcd7144473f5c60b7f033ff719a\", \"headless_unittests\": \"ccb32c41aa7e04b3fb1e67f78f8135cc24c10c72\", \"interactive_ui_tests\": \"5aedec0eb994f914de4a7515d432be3e1afab34c\", \"ipc_tests\": \"e3fd1c4e878a128ddd9c02daa9cf195e60028ce8\", \"jingle_unittests\": \"2198c5abdb89fe0ce76d79238d187e35e2e01bc5\", \"latency_unittests\": \"dab8ec14712625481516df1873825afb4cedf2eb\", \"libjingle_xmpp_unittests\": \"51f20050b0830f82baa4618f933287a7a758fbe9\", \"liburlpattern_unittests\": \"b74c22511241d3f0ae5528ebe98f29e8abc95f27\", \"media_blink_unittests\": \"3d2147da7e986c51f04c4d3adf98a4bc8ed1b567\", \"media_unittests\": \"3ef1166c6aabcf58b19572d877e8067ca89de850\", \"message_center_unittests\": \"7c6bbe54bbf0c103a42266bb6d80134c6ff34885\", \"metrics_python_tests\": \"8dfecde7227034ccebcc06c6fcdc412d1440f098\", \"midi_unittests\": \"291d4b335524bd2406d2e512d1fe4191567e6d5a\", \"mojo_core_unittests\": \"781f998cee790f18dcbbc3046ba10eceaa6dfcfb\", \"mojo_unittests\": \"eeef3841be11f451299b26f6fc8f4439410182d3\", \"nacl_helper_nonsfi_unittests\": \"617d46f94fd2d563126a06504e408e0d4817a91f\", \"nacl_loader_unittests\": \"cf7fe2acf06237a1680ff1b2c490942a12de3460\", \"native_theme_unittests\": \"d6f16b245c1035ed9ae85df275a2f13cf842ea29\", \"net_unittests\": \"ab60c960a1a9b213bf8bad88fbef9f644bbcaaa2\", \"openscreen_unittests\": \"3a7b8e9826d6275aa34fd81a9c8e0f0da4a8fad5\", \"pdf_unittests\": \"bbcc81e7e6aff4acbba4c64423ce5983b65971d9\", \"perfetto_unittests\": \"114973b37c5939cc2d180a3692c175c73a2beb96\", \"ppapi_unittests\": \"3752cbc6eff6cae76a3a5185350a3c624b2b75ee\", \"printing_unittests\": \"8c0d225e57b92b16f36816c0aaff54bd36c07643\", \"remoting_unittests\": \"3926c179478864b0a2bee5cb995422a9751a5d05\", \"sandbox_linux_unittests\": \"23b1efea354e5c7bbbad6544864fa76e02b1e33f\", \"service_manager_unittests\": \"22b857d3acd47e9bcc83fcf8ee334c07e1aa193a\", \"services_unittests\": \"b173543c0d14986e03b201195d4534a563a11582\", \"shell_dialogs_unittests\": \"82e4bcd1f7907118f002007093acd520471857ba\", \"skia_unittests\": \"93bd872ea97780999b14a2eabc8b7ebf2a5527a4\", \"snapshot_unittests\": \"f8ad5a54823731dc25ccb435b37e814d5c530410\", \"sql_unittests\": \"dc562c6a115365246befad1c4eea0b5869918d5b\", \"storage_unittests\": \"1f5aca0b68bc2fd031f7ef3d1b9bd61f4c23c967\", \"sync_integration_tests\": \"d39c8a9afa8c9fba4eae8a965ce47dd8efe96f3f\", \"telemetry_gpu_unittests\": \"3d20955ff7d72f60c9df809ee8f335355befe741\", \"telemetry_perf_unittests\": \"bd6b82089c7518002dd7081e37b89031dbe2dd11\", \"telemetry_unittests\": \"bc478ec535567b98b15375d2e18645b86ff1e1fb\", \"traffic_annotation_auditor_unittests\": \"8bc9d8d2c23341d9a3a32f5a6424051e3e9bd81c\", \"ui_base_unittests\": \"12a0accc39b0728987082c3ba1257c33b7c44163\", \"ui_touch_selection_unittests\": \"7c7c91426ec26bf1c2c909f8d623473362e80d0e\", \"unit_tests\": \"dfef554fd9dbef12f3cf097ec841fb5f6fc0f8f1\", \"url_unittests\": \"df4efe7970d2c49a10c7570d21324824ff36cc45\", \"views_perftests\": \"5cda002815ce08c49bc60e3e66dc9f8cefb56800\", \"views_unittests\": \"b55c3ae3f0ce56db8ef98dd573c039b1ebc3aa21\", \"viz_unittests\": \"43797469e8d05174c2a7171736133a4cb821642a\", \"vr_common_unittests\": \"169fefaff0fb4aa53b6fb0deed451017edc24a31\", \"vr_pixeltests\": \"bcea38823424272f3f69613f571a01637437455c\", \"webdriver_wpt_tests\": \"598d349f046350160c361a36a16cc07ff4f69dbb\", \"weblayer_browsertests\": \"c713a0401431d3e60c711c4696eb63e2c7bce2b3\", \"weblayer_unittests\": \"8f47aa36ea0ab16f378611a4f06b1411d22c3919\", \"wm_unittests\": \"041e6d9c8a486432b0814a9993c0a1fcd3c890dc\", \"wtf_unittests\": \"acaed942cba46273b9b437bdde14864b3d68b043\", \"x11_unittests\": \"5f1681cf4190a860f14d633a2a19af2be1550b7d\", \"xr_browser_tests\": \"e53b540d777bed8fc9cf4464f7c092b1319fa094\", \"zlib_unittests\": \"3643557a60e546fa26ae7b3bb2bfcefe4dc0a8df\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_08506e22a0e0fdc29bd318165699b599f0671cf91287ea7a96642b02d7ff24e4_v2\", \"builder_151f80801b9f29276c11c5f05dab27ce5673f9c9ba442aaf2cf20aab9215f522_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_a432d290b72bc0f3cae401fbd647c33c14340f64e89770e9c9c39d6230495526_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-33-4q3b\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5632-2e614e1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605499509524450",
"status": "COMPLETED",
"status_changed_ts": "1605502668202466",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177702",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c3b76ce54db647e770ae7ea71e9082b3a60c82fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c3b76ce54db647e770ae7ea71e9082b3a60c82fe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028935527863035952",
"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/8863505465418578384/+/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:4fe80bdb20960110",
"user_agent:luci-scheduler"
],
"updated_ts": "1605502668271603",
"url": "https://ci.chromium.org/b/8863505465418578384",
"utcnow_ts": "1605502668851956"
}
}
[04:57:48.865] Invocation finished in 52m44.067787126s with status SUCCEEDED