[19:00:10.178] New invocation is queued and will start shortly
[19:00:11.706] Starting the invocation (attempt 1)
[19:00:11.772] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:00:11.772] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:00:11.772] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054065170394243008",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3c547e61ed9b8ef5030af698c8165f78a3a6b825\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054065170394243008",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/3c547e61ed9b8ef5030af698c8165f78a3a6b825",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3c547e61ed9b8ef5030af698c8165f78a3a6b825",
"gitiles_ref:refs/heads/master"
]
}
[19:00:12.545] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581534011895010",
"id": "8888635107901313920",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3c547e61ed9b8ef5030af698c8165f78a3a6b825\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581534012346346",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168528",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3c547e61ed9b8ef5030af698c8165f78a3a6b825",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3c547e61ed9b8ef5030af698c8165f78a3a6b825",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054065170394243008",
"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/8888635107901313920/+/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": "1581534012346509",
"url": "https://ci.chromium.org/b/8888635107901313920",
"utcnow_ts": "1581534012536823"
}
}
[19:00:12.545] Task URL: https://ci.chromium.org/b/8888635107901313920
[19:00:12.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:2:0) after 1m0s
[19:01:12.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:2:0)
[19:01:12.679] Timer tick, asking Buildbucket for the build status
[19:01:12.993] Build 8888635107901313920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:12.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:3:0) after 1m0s
[19:02:13.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:3:0)
[19:02:13.061] Timer tick, asking Buildbucket for the build status
[19:02:13.668] Build 8888635107901313920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:02:13.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:4:0) after 1m0s
[19:03:13.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:4:0)
[19:03:13.806] Timer tick, asking Buildbucket for the build status
[19:03:15.207] Build 8888635107901313920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:15.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:5:0) after 1m0s
[19:04:15.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:5:0)
[19:04:15.210] Timer tick, asking Buildbucket for the build status
[19:04:16.738] Build 8888635107901313920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:16.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:6:0) after 1m0s
[19:05:15.199] Received PubSub notification, asking Buildbucket for the build status
[19:05:15.329] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:16.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:6:0)
[19:05:16.826] Timer tick, asking Buildbucket for the build status
[19:05:16.934] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:16.934] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:8:0) after 1m0s
[19:06:16.993] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:8:0)
[19:06:16.993] Timer tick, asking Buildbucket for the build status
[19:06:17.173] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:17.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:9:0) after 1m0s
[19:07:17.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:9:0)
[19:07:17.228] Timer tick, asking Buildbucket for the build status
[19:07:19.223] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:19.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:10:0) after 1m0s
[19:08:19.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:10:0)
[19:08:19.268] Timer tick, asking Buildbucket for the build status
[19:08:19.419] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:19.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:11:0) after 1m0s
[19:09:19.469] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:11:0)
[19:09:19.469] Timer tick, asking Buildbucket for the build status
[19:09:19.604] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:19.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:12:0) after 1m0s
[19:10:20.500] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:12:0)
[19:10:20.500] Timer tick, asking Buildbucket for the build status
[19:10:20.993] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:20.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:13:0) after 1m0s
[19:11:21.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:13:0)
[19:11:21.433] Timer tick, asking Buildbucket for the build status
[19:11:21.593] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:21.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:14:0) after 1m0s
[19:12:21.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:14:0)
[19:12:21.654] Timer tick, asking Buildbucket for the build status
[19:12:21.847] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:21.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:15:0) after 1m0s
[19:13:21.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:15:0)
[19:13:21.980] Timer tick, asking Buildbucket for the build status
[19:13:22.195] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:22.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:16:0) after 1m0s
[19:14:22.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:16:0)
[19:14:22.262] Timer tick, asking Buildbucket for the build status
[19:14:22.398] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:22.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:17:0) after 1m0s
[19:15:22.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:17:0)
[19:15:22.488] Timer tick, asking Buildbucket for the build status
[19:15:22.609] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:22.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:18:0) after 1m0s
[19:16:22.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:18:0)
[19:16:22.699] Timer tick, asking Buildbucket for the build status
[19:16:22.935] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:22.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:19:0) after 1m0s
[19:17:23.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:19:0)
[19:17:23.052] Timer tick, asking Buildbucket for the build status
[19:17:23.443] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:23.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:20:0) after 1m0s
[19:18:23.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:20:0)
[19:18:23.462] Timer tick, asking Buildbucket for the build status
[19:18:24.714] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:24.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:21:0) after 1m0s
[19:19:26.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:21:0)
[19:19:26.100] Timer tick, asking Buildbucket for the build status
[19:19:26.336] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:26.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:22:0) after 1m0s
[19:20:26.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:22:0)
[19:20:26.489] Timer tick, asking Buildbucket for the build status
[19:20:26.692] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:26.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:23:0) after 1m0s
[19:21:26.877] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:23:0)
[19:21:26.877] Timer tick, asking Buildbucket for the build status
[19:21:27.057] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:27.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:24:0) after 1m0s
[19:22:27.141] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:24:0)
[19:22:27.141] Timer tick, asking Buildbucket for the build status
[19:22:27.290] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:27.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:25:0) after 1m0s
[19:23:27.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:25:0)
[19:23:27.476] Timer tick, asking Buildbucket for the build status
[19:23:28.065] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:28.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:26:0) after 1m0s
[19:24:28.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:26:0)
[19:24:28.213] Timer tick, asking Buildbucket for the build status
[19:24:28.509] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:28.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:27:0) after 1m0s
[19:25:28.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:27:0)
[19:25:28.552] Timer tick, asking Buildbucket for the build status
[19:25:28.692] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:28.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:28:0) after 1m0s
[19:26:28.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:28:0)
[19:26:28.810] Timer tick, asking Buildbucket for the build status
[19:26:28.985] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:28.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:29:0) after 1m0s
[19:27:29.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:29:0)
[19:27:29.124] Timer tick, asking Buildbucket for the build status
[19:27:29.954] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:29.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:30:0) after 1m0s
[19:28:29.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:30:0)
[19:28:29.999] Timer tick, asking Buildbucket for the build status
[19:28:30.163] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:30.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:31:0) after 1m0s
[19:29:30.284] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:31:0)
[19:29:30.284] Timer tick, asking Buildbucket for the build status
[19:29:30.528] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:30.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:32:0) after 1m0s
[19:30:30.640] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:32:0)
[19:30:30.640] Timer tick, asking Buildbucket for the build status
[19:30:31.289] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:31.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:33:0) after 1m0s
[19:31:31.325] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:33:0)
[19:31:31.325] Timer tick, asking Buildbucket for the build status
[19:31:31.796] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:31.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:34:0) after 1m0s
[19:32:31.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:34:0)
[19:32:31.921] Timer tick, asking Buildbucket for the build status
[19:32:32.087] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:32.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:35:0) after 1m0s
[19:33:32.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:35:0)
[19:33:32.129] Timer tick, asking Buildbucket for the build status
[19:33:33.042] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:33.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:36:0) after 1m0s
[19:34:33.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:36:0)
[19:34:33.098] Timer tick, asking Buildbucket for the build status
[19:34:33.888] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:33.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:37:0) after 1m0s
[19:35:33.916] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:37:0)
[19:35:33.917] Timer tick, asking Buildbucket for the build status
[19:35:34.159] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:34.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:38:0) after 1m0s
[19:36:34.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:38:0)
[19:36:34.402] Timer tick, asking Buildbucket for the build status
[19:36:34.737] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:34.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:39:0) after 1m0s
[19:37:34.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:39:0)
[19:37:34.814] Timer tick, asking Buildbucket for the build status
[19:37:35.415] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:35.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:40:0) after 1m0s
[19:38:35.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:40:0)
[19:38:35.434] Timer tick, asking Buildbucket for the build status
[19:38:35.537] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:35.537] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:41:0) after 1m0s
[19:39:35.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:41:0)
[19:39:35.562] Timer tick, asking Buildbucket for the build status
[19:39:36.324] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:36.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:42:0) after 1m0s
[19:40:36.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:42:0)
[19:40:36.433] Timer tick, asking Buildbucket for the build status
[19:40:37.324] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:37.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:43:0) after 1m0s
[19:41:37.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:43:0)
[19:41:37.367] Timer tick, asking Buildbucket for the build status
[19:41:37.616] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:37.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:44:0) after 1m0s
[19:42:37.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:44:0)
[19:42:37.714] Timer tick, asking Buildbucket for the build status
[19:42:37.927] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:37.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:45:0) after 1m0s
[19:43:38.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:45:0)
[19:43:38.073] Timer tick, asking Buildbucket for the build status
[19:43:39.072] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:39.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:46:0) after 1m0s
[19:44:39.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:46:0)
[19:44:39.149] Timer tick, asking Buildbucket for the build status
[19:44:39.626] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:39.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:47:0) after 1m0s
[19:45:39.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:47:0)
[19:45:39.650] Timer tick, asking Buildbucket for the build status
[19:45:42.205] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:42.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:48:0) after 1m0s
[19:46:42.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:48:0)
[19:46:42.203] Timer tick, asking Buildbucket for the build status
[19:46:42.366] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:42.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:49:0) after 1m0s
[19:47:42.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:49:0)
[19:47:42.642] Timer tick, asking Buildbucket for the build status
[19:47:42.910] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:42.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:50:0) after 1m0s
[19:48:43.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:50:0)
[19:48:43.045] Timer tick, asking Buildbucket for the build status
[19:48:43.233] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:43.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:51:0) after 1m0s
[19:49:43.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:51:0)
[19:49:43.506] Timer tick, asking Buildbucket for the build status
[19:49:44.521] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:44.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:52:0) after 1m0s
[19:50:44.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:52:0)
[19:50:44.606] Timer tick, asking Buildbucket for the build status
[19:50:46.082] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:46.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:53:0) after 1m0s
[19:51:46.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:53:0)
[19:51:46.125] Timer tick, asking Buildbucket for the build status
[19:51:47.258] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:47.258] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:54:0) after 1m0s
[19:52:47.331] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:54:0)
[19:52:47.331] Timer tick, asking Buildbucket for the build status
[19:52:47.870] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:47.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:55:0) after 1m0s
[19:53:47.941] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:55:0)
[19:53:47.941] Timer tick, asking Buildbucket for the build status
[19:53:49.047] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:49.047] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:56:0) after 1m0s
[19:54:49.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:56:0)
[19:54:49.073] Timer tick, asking Buildbucket for the build status
[19:54:49.323] Build 8888635107901313920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:49.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054065170394243008:57:0) after 1m0s
[19:55:24.682] Received PubSub notification, asking Buildbucket for the build status
[19:55:26.806] Build 8888635107901313920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:55:26.806] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581537288595815",
"created_by": "project:chromium",
"created_ts": "1581534011895010",
"id": "8888635107901313920",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3c547e61ed9b8ef5030af698c8165f78a3a6b825\"}}",
"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-49-pvad\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168528, \"got_angle_revision\": \"33b1e31e7efa19c303cef0c6a17989c181f8dbcd\", \"got_dawn_revision\": \"2fd618192985122aafb494ac5e9a39f572ef46fc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"3c547e61ed9b8ef5030af698c8165f78a3a6b825\", \"got_revision_cp\": \"refs/heads/master@{#740761}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"d5a2a597ceb4168edb48401c7a0ca650dd60c5aa\", \"got_v8_revision\": \"16cb8948cd1894d2ebf2ec623dc8afaa1ccbb00c\", \"got_v8_revision_cp\": \"refs/heads/8.2.60@{#1}\", \"got_webrtc_revision\": \"d4c3c3a454215b21f02d2a772a729b4c87d6b33e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30486}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3c547e61ed9b8ef5030af698c8165f78a3a6b825\", \"swarm_hashes_refs/heads/master(at){#740761}_without_patch\": {\"accessibility_unittests\": \"82f04cad1f4722079909fe5a81f5b627044a1ca3\", \"angle_unittests\": \"269405a9145e9aff9984d05e2f2b693f20679b41\", \"app_shell_unittests\": \"99982cc6b5be99a946aea69eaae4ff23bf8cca56\", \"aura_unittests\": \"254816f0f43188e0302bf89f309e0061bae6e4d7\", \"base_unittests\": \"1782385eeba70310554b67c060bd08847d235871\", \"base_util_unittests\": \"01374f7713f5d4686729c578dd83f21c25bfc041\", \"blink_common_unittests\": \"11a9abfd1690cbcb0c1ed0f4a905fdf554885ac8\", \"blink_fuzzer_unittests\": \"cbdf8af122c05aaf36d70117f6d73bbdc8a28ffb\", \"blink_heap_unittests\": \"d3508234575418bfec88b0103ca7c685d2ebee8c\", \"blink_platform_unittests\": \"db5863bcfd25889e49e9c3b60170b798fe5c7834\", \"blink_python_tests\": \"1f0b6a6b6f132bb7e6ca961850914f502d856d6b\", \"blink_unittests\": \"27c47b4da524d1b4105b82065fae07319db5f675\", \"blink_web_tests\": \"1d24a28bce939294878b43dc3fb8a8436b47b352\", \"boringssl_crypto_tests\": \"8282cc23f564e868be574cdf35eeae783f37731f\", \"boringssl_ssl_tests\": \"3725954d00bc6600292fcbc720fb5afd4f70d869\", \"browser_tests\": \"d9cbe48d51a4408f09adafb04f522b775dd90bdd\", \"cacheinvalidation_unittests\": \"b2edc9917e94434b3672892829797c8d98532ad9\", \"capture_unittests\": \"9cc17396d27f2c042a743200111103804d6111cb\", \"cast_unittests\": \"414c4423293152fc2e4bbb21cf8cc03b2552ec10\", \"cc_unittests\": \"0ad6568f8ce02b2ed6b695f99bdfcb770af764a6\", \"chrome_app_unittests\": \"61a2769fbbc7ddbc2659041c0972077989bb1915\", \"chromedriver_unittests\": \"c00d92500898da99e72900f45e5795898d8ab093\", \"components_browsertests\": \"9daf68be20190692a27392932e1d2e3b0090c1a6\", \"components_unittests\": \"9de01ddbdcc59be29a2300ff134afa964718073f\", \"compositor_unittests\": \"aeaacd54ffff7877c905454fe884ce2c1b387dd0\", \"content_browsertests\": \"bc89004afdc5c27ffbd40eb3b7b1c9d4246a18e8\", \"content_shell_crash_test\": \"3cf31594afffc21e2fe90e95d67379dd8d5473e2\", \"content_unittests\": \"f6c3c181fcef11665efd8c7988310593ceb83daa\", \"crashpad_tests\": \"7960365270f1f5f0eb725ec37914a9d6d9ea1b9f\", \"cronet_tests\": \"ff56ade5ff699afb6ded6bf2f621ac8366829621\", \"cronet_unittests\": \"679641f317e4b02e2f99af57f122360f52a9ab71\", \"crypto_unittests\": \"5aa20f5e848c0c38a9ebd0143df1234a093b0499\", \"dbus_unittests\": \"9838cf1cd9e738d169f09f13e6cf8bc21192bcce\", \"device_unittests\": \"0b4503419bd0445fcc4a010010c9cf7b40acf649\", \"display_unittests\": \"cc584e305a61a66a399a9d5ba719b7906b7a35f0\", \"events_unittests\": \"eb99722e64625ac6ead7e29d711b8131a79d14e4\", \"extensions_browsertests\": \"7c959e2a4d5ec982bab7af8737bb4b6d97baa387\", \"extensions_unittests\": \"b359c2861f344cd794c282cf172e0dfb1e5e477b\", \"filesystem_service_unittests\": \"38c523e1ad39bbd4be77d579b71d0758637b6e2a\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"61867d6e7276446927e23cff7809c15d103c6d09\", \"gfx_unittests\": \"2eb6f6c0063efdac6b281f3ab7fd5c6900d824b8\", \"gin_unittests\": \"2c84e39b92f7c4112897d354982c089f81c15c36\", \"google_apis_unittests\": \"b355f15c765ee061f5837705704c9d8435c79094\", \"gpu_unittests\": \"b25cfefb5d18bfbe8fab8ed03f24adb17f1c1f68\", \"grit_python_unittests\": \"07488c096d20bb2a4e6d9280813fca6afbee6dc0\", \"gwp_asan_unittests\": \"4f271573240e949d041b6625067433d448ac1ecf\", \"headless_browsertests\": \"958af09962ff67fbc6de45b100e63a21cc03adaf\", \"headless_unittests\": \"9ea62f033903eb6addf852a00f05d6beff5f2cb5\", \"interactive_ui_tests\": \"a07531b9f25dc9bcaa62276ca249b648ff9753ce\", \"ipc_tests\": \"83b6cf8dcc5485d3365a5f82c73b150e2fd6852d\", \"jingle_unittests\": \"b11dfa5363a2ddbdcc4dd20196208114bfa06525\", \"latency_unittests\": \"f295cd713f06bad936c96cb3ab35e87d7395b65d\", \"libjingle_xmpp_unittests\": \"49d14a15eeb3f87d3bea9a2221593fe8f140c213\", \"media_blink_unittests\": \"5ea4b17b35c4586aab89f19187e2e2ebd7428f99\", \"media_service_unittests\": \"32b629fbd51212a8160c39248adace9eaa75d816\", \"media_unittests\": \"e07dc6fdf3628f63e857b7ecef9a26e87f99a1cf\", \"message_center_unittests\": \"e857901d87ac58169240ce918c68e18f17593be3\", \"metrics_python_tests\": \"7d716ce05161a3e3b828aa1a66e1c81c9e70c7d2\", \"midi_unittests\": \"7f51bc0ccd13aed75a70206c04115074759b0d01\", \"mojo_core_unittests\": \"77de49fa9c7e53ec3b76534ab815e7410442962a\", \"mojo_unittests\": \"41c0bacb714b8ddc4e9a1056affec4c34f4a9cfa\", \"nacl_helper_nonsfi_unittests\": \"10be0a5831894e7b1d2cd7fd556fbdb6c38290d1\", \"nacl_loader_unittests\": \"f23ef3c3a9d2f3f4d181c5be089c403e7c0073eb\", \"native_theme_unittests\": \"c8aa102afbab2543b15900230890fcd4f7f4b16c\", \"net_unittests\": \"e328c2002651c20ecd6476d06376de98289191e5\", \"pdf_unittests\": \"46e772bdcc62196754c1e91d3d895a5a459c75c7\", \"perfetto_unittests\": \"a978b2d2e17b27d40b6cda68c7fa608a12e3140a\", \"ppapi_unittests\": \"26ff73c92706596ce87ff032d26cbee2edb5608a\", \"printing_unittests\": \"833cf641ec36daed89862da1ee62502241acb895\", \"remoting_unittests\": \"ef47ad1b663819e70b725c48527bc8dd2e0782b5\", \"sandbox_linux_unittests\": \"af0efeda1a68e4e1353354152de8ff3a464f6e52\", \"service_manager_unittests\": \"f3d25d8473f5eae4ea0adc874a33c308415c4d21\", \"services_unittests\": \"3297088b6faa6370b9a3cd2266c1c9bb15beeb3c\", \"shell_dialogs_unittests\": \"0701ea343d66d837a3e85900ba007a7f018463b9\", \"skia_unittests\": \"5badd277f4ceb6bba6bd4c6e1f4e7cc5b7d42640\", \"snapshot_unittests\": \"ed0a9d366862ca467a38ee1e388f661b0e094523\", \"sql_unittests\": \"df027ec3a2c71ad6ac109c1cc5230a369aadc5ea\", \"storage_unittests\": \"628f3519609a920586b7f8c75c598669e6f48c99\", \"sync_integration_tests\": \"ee8c66d57e90ed5013c3990b805731cedf69efc6\", \"telemetry_gpu_unittests\": \"3472693534ab74338ec5bf179a797897adbbaffd\", \"telemetry_perf_unittests\": \"ea29de593332c465459191c8b116ddb998c820e4\", \"telemetry_unittests\": \"8953cb9c3092c2b8cd9b302da77d14bbe9585666\", \"traffic_annotation_auditor_unittests\": \"b3a2a9756f1e62c46fe31422ff8479950c5b1942\", \"ui_base_unittests\": \"d59bc98dadc49cc351348a01b6cbb0d47c71ce0b\", \"ui_touch_selection_unittests\": \"9abc96307363409a4c850960aa66878006fc0a93\", \"unit_tests\": \"3de6f302adf7e32c4548db97ce7879cb3b9b0ed0\", \"url_unittests\": \"9e72f64aadefaa9842836201b19630736ca51f74\", \"views_perftests\": \"1569c5aa6a98c5b1d0703c950f875d86cae343c0\", \"views_unittests\": \"5c19cd9e8a3e4ecb0fc879f702682bea04c64e52\", \"viz_unittests\": \"8cb5570fb4c7ae2ca3fb88949aab5e38d8c9caee\", \"vr_common_unittests\": \"f04e1830170f2c3895c60c9cc3280875c6e28018\", \"vr_pixeltests\": \"ad3dc8eb017b61e4bcf13ed331c16251938d73aa\", \"webdriver_wpt_tests\": \"dca9fef84d08f6007a4a02f7aaabe3655ba5c280\", \"weblayer_browsertests\": \"40a618e48f3972164d21d12188399117a48cd339\", \"wm_unittests\": \"311777bcfce73c005cf47713bfe8bd9da193fb85\", \"wtf_unittests\": \"3c3a369f4dd00afe51c55caa9bea3c82221f20e1\", \"xr_browser_tests\": \"fb50c7821ceffcaffe1ab32813d5980096657082\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3f701152d865ce3ec8feb15f973214ad980aeace5cbda24477548a965269fca6_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-49-pvad\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4812-ea7e8fc\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581534307233638",
"status": "COMPLETED",
"status_changed_ts": "1581537324353213",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168528",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3c547e61ed9b8ef5030af698c8165f78a3a6b825",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3c547e61ed9b8ef5030af698c8165f78a3a6b825",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054065170394243008",
"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/8888635107901313920/+/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:4a53976e62c97410",
"user_agent:luci-scheduler"
],
"updated_ts": "1581537324357095",
"url": "https://ci.chromium.org/b/8888635107901313920",
"utcnow_ts": "1581537326794641"
}
}
[19:55:26.806] Invocation finished in 55m16.671963674s with status SUCCEEDED