[21:02:12.813] New invocation is queued and will start shortly
[21:02:14.024] Starting the invocation (attempt 1)
[21:02:14.065] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:02:14.066] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:02:14.066] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022982732552910016",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3f12512d26b54f6ea5c855e70a8fd93cff189be5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022982732552910016",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/3f12512d26b54f6ea5c855e70a8fd93cff189be5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3f12512d26b54f6ea5c855e70a8fd93cff189be5",
"gitiles_ref:refs/heads/master"
]
}
[21:02:14.907] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611176534198400",
"id": "8857552670434607632",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3f12512d26b54f6ea5c855e70a8fd93cff189be5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611176534732240",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44774",
"builder:linux-chromeos-rel",
"buildset:commit/git/3f12512d26b54f6ea5c855e70a8fd93cff189be5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3f12512d26b54f6ea5c855e70a8fd93cff189be5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022982732552910016",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857552670434607632/+/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": "1611176534732360",
"url": "https://ci.chromium.org/b/8857552670434607632",
"utcnow_ts": "1611176534898349"
}
}
[21:02:14.907] Task URL: https://ci.chromium.org/b/8857552670434607632
[21:02:14.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:2:0) after 1m0s
[21:03:14.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:2:0)
[21:03:14.952] Timer tick, asking Buildbucket for the build status
[21:03:15.073] Build 8857552670434607632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:15.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:3:0) after 1m0s
[21:04:15.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:3:0)
[21:04:15.159] Timer tick, asking Buildbucket for the build status
[21:04:15.301] Build 8857552670434607632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:15.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:4:0) after 1m0s
[21:05:15.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:4:0)
[21:05:15.375] Timer tick, asking Buildbucket for the build status
[21:05:15.457] Build 8857552670434607632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:15.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:5:0) after 1m0s
[21:05:30.492] Received PubSub notification, asking Buildbucket for the build status
[21:05:30.701] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:15.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:5:0)
[21:06:15.877] Timer tick, asking Buildbucket for the build status
[21:06:15.994] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:15.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:7:0) after 1m0s
[21:07:16.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:7:0)
[21:07:16.170] Timer tick, asking Buildbucket for the build status
[21:07:16.462] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:16.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:8:0) after 1m0s
[21:08:16.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:8:0)
[21:08:16.764] Timer tick, asking Buildbucket for the build status
[21:08:16.881] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:16.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:9:0) after 1m0s
[21:09:17.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:9:0)
[21:09:17.268] Timer tick, asking Buildbucket for the build status
[21:09:17.338] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:17.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:10:0) after 1m0s
[21:10:17.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:10:0)
[21:10:17.611] Timer tick, asking Buildbucket for the build status
[21:10:17.729] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:17.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:11:0) after 1m0s
[21:11:17.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:11:0)
[21:11:17.808] Timer tick, asking Buildbucket for the build status
[21:11:17.918] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:17.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:12:0) after 1m0s
[21:12:18.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:12:0)
[21:12:18.039] Timer tick, asking Buildbucket for the build status
[21:12:18.192] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:18.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:13:0) after 1m0s
[21:13:18.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:13:0)
[21:13:18.381] Timer tick, asking Buildbucket for the build status
[21:13:18.533] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:18.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:14:0) after 1m0s
[21:14:18.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:14:0)
[21:14:18.671] Timer tick, asking Buildbucket for the build status
[21:14:18.767] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:18.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:15:0) after 1m0s
[21:15:19.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:15:0)
[21:15:19.108] Timer tick, asking Buildbucket for the build status
[21:15:19.186] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:19.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:16:0) after 1m0s
[21:16:19.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:16:0)
[21:16:19.325] Timer tick, asking Buildbucket for the build status
[21:16:19.388] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:19.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:17:0) after 1m0s
[21:17:19.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:17:0)
[21:17:19.514] Timer tick, asking Buildbucket for the build status
[21:17:19.641] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:19.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:18:0) after 1m0s
[21:18:19.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:18:0)
[21:18:19.739] Timer tick, asking Buildbucket for the build status
[21:18:19.852] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:19.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:19:0) after 1m0s
[21:19:19.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:19:0)
[21:19:19.946] Timer tick, asking Buildbucket for the build status
[21:19:20.211] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:20.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:20:0) after 1m0s
[21:20:20.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:20:0)
[21:20:20.288] Timer tick, asking Buildbucket for the build status
[21:20:20.340] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:20.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:21:0) after 1m0s
[21:21:20.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:21:0)
[21:21:20.434] Timer tick, asking Buildbucket for the build status
[21:21:20.502] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:20.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:22:0) after 1m0s
[21:22:20.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:22:0)
[21:22:20.631] Timer tick, asking Buildbucket for the build status
[21:22:20.739] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:20.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:23:0) after 1m0s
[21:23:20.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:23:0)
[21:23:20.798] Timer tick, asking Buildbucket for the build status
[21:23:20.855] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:20.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:24:0) after 1m0s
[21:24:20.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:24:0)
[21:24:20.965] Timer tick, asking Buildbucket for the build status
[21:24:21.032] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:21.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:25:0) after 1m0s
[21:25:21.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:25:0)
[21:25:21.420] Timer tick, asking Buildbucket for the build status
[21:25:21.478] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:21.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:26:0) after 1m0s
[21:26:21.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:26:0)
[21:26:21.534] Timer tick, asking Buildbucket for the build status
[21:26:21.749] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:21.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:27:0) after 1m0s
[21:27:21.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:27:0)
[21:27:21.784] Timer tick, asking Buildbucket for the build status
[21:27:22.146] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:22.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:28:0) after 1m0s
[21:28:22.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:28:0)
[21:28:22.281] Timer tick, asking Buildbucket for the build status
[21:28:22.337] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:22.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:29:0) after 1m0s
[21:29:22.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:29:0)
[21:29:22.351] Timer tick, asking Buildbucket for the build status
[21:29:22.630] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:22.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:30:0) after 1m0s
[21:30:22.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:30:0)
[21:30:22.639] Timer tick, asking Buildbucket for the build status
[21:30:22.704] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:22.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:31:0) after 1m0s
[21:31:22.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:31:0)
[21:31:22.738] Timer tick, asking Buildbucket for the build status
[21:31:22.879] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:22.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:32:0) after 1m0s
[21:32:22.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:32:0)
[21:32:22.896] Timer tick, asking Buildbucket for the build status
[21:32:23.297] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:23.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:33:0) after 1m0s
[21:33:23.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:33:0)
[21:33:23.323] Timer tick, asking Buildbucket for the build status
[21:33:23.540] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:23.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:34:0) after 1m0s
[21:34:23.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:34:0)
[21:34:23.579] Timer tick, asking Buildbucket for the build status
[21:34:23.688] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:23.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:35:0) after 1m0s
[21:35:23.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:35:0)
[21:35:23.736] Timer tick, asking Buildbucket for the build status
[21:35:23.805] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:23.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:36:0) after 1m0s
[21:36:23.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:36:0)
[21:36:23.879] Timer tick, asking Buildbucket for the build status
[21:36:23.996] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:23.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:37:0) after 1m0s
[21:37:24.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:37:0)
[21:37:24.145] Timer tick, asking Buildbucket for the build status
[21:37:24.251] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:24.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:38:0) after 1m0s
[21:38:24.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:38:0)
[21:38:24.331] Timer tick, asking Buildbucket for the build status
[21:38:24.766] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:24.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:39:0) after 1m0s
[21:39:24.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:39:0)
[21:39:24.852] Timer tick, asking Buildbucket for the build status
[21:39:24.946] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:24.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:40:0) after 1m0s
[21:40:25.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:40:0)
[21:40:25.064] Timer tick, asking Buildbucket for the build status
[21:40:25.299] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:25.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:41:0) after 1m0s
[21:41:25.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:41:0)
[21:41:25.368] Timer tick, asking Buildbucket for the build status
[21:41:25.502] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:25.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:42:0) after 1m0s
[21:42:25.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:42:0)
[21:42:25.735] Timer tick, asking Buildbucket for the build status
[21:42:25.876] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:25.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:43:0) after 1m0s
[21:43:25.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:43:0)
[21:43:25.979] Timer tick, asking Buildbucket for the build status
[21:43:26.133] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:26.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:44:0) after 1m0s
[21:44:26.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:44:0)
[21:44:26.250] Timer tick, asking Buildbucket for the build status
[21:44:26.378] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:26.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:45:0) after 1m0s
[21:45:26.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:45:0)
[21:45:26.534] Timer tick, asking Buildbucket for the build status
[21:45:26.879] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:26.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:46:0) after 1m0s
[21:46:26.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:46:0)
[21:46:26.944] Timer tick, asking Buildbucket for the build status
[21:46:27.093] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:27.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:47:0) after 1m0s
[21:47:27.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:47:0)
[21:47:27.096] Timer tick, asking Buildbucket for the build status
[21:47:27.215] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:27.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:48:0) after 1m0s
[21:48:27.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:48:0)
[21:48:27.259] Timer tick, asking Buildbucket for the build status
[21:48:27.440] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:27.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:49:0) after 1m0s
[21:49:27.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:49:0)
[21:49:27.493] Timer tick, asking Buildbucket for the build status
[21:49:27.638] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:27.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:50:0) after 1m0s
[21:50:27.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:50:0)
[21:50:27.661] Timer tick, asking Buildbucket for the build status
[21:50:27.931] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:27.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:51:0) after 1m0s
[21:51:27.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:51:0)
[21:51:27.997] Timer tick, asking Buildbucket for the build status
[21:51:28.153] Build 8857552670434607632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:28.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022982732552910016:52:0) after 1m0s
[21:52:23.638] Received PubSub notification, asking Buildbucket for the build status
[21:52:23.719] Build 8857552670434607632: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:52:23.719] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611179542404169",
"created_by": "project:chromium",
"created_ts": "1611176534198400",
"id": "8857552670434607632",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3f12512d26b54f6ea5c855e70a8fd93cff189be5\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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\": \"3f12512d26b54f6ea5c855e70a8fd93cff189be5\", \"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-47-zair\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44774, \"got_angle_revision\": \"2900a0f4cb8219be40997f72c25bdc71cef66038\", \"got_dawn_revision\": \"064f33e4416ed498c91137f518fedb56c325b99b\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"3f12512d26b54f6ea5c855e70a8fd93cff189be5\", \"got_revision_cp\": \"refs/heads/master@{#845319}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"e27e7488e4ad0ef2099149c66e8b57742e9d5a1c\", \"got_v8_revision\": \"1d681a1a9f5b66ce7c18d756f80e1c3afab911d5\", \"got_v8_revision_cp\": \"refs/heads/9.0.28@{#1}\", \"got_webrtc_revision\": \"6dcbcead3da45604b84aef9d9496689fef5ff8f5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33041}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3f12512d26b54f6ea5c855e70a8fd93cff189be5\", \"swarm_hashes_refs/heads/master(at){#845319}_without_patch\": {\"absl_hardening_tests\": \"39a9ad978d1ee8583c55041a581691ed9e6b7a48\", \"accessibility_unittests\": \"f4986762b99e7f302c1908be9c3238e1a9e385a8\", \"angle_unittests\": \"2a62e7aff34c77e20e60611f3f05c92976fe9005\", \"app_list_unittests\": \"75f9ffc6e41c8ce05c805ae5d929ef8777097af3\", \"app_shell_unittests\": \"917f8c9f9c1235707a588ccc21e803c1a51db903\", \"ash_unittests\": \"2586ff80a5962e44582a4a4c94c5340f10f41abf\", \"aura_unittests\": \"b532f69a373b68de92985e5ace0b414e6c95d9bb\", \"base_unittests\": \"93fac250dfd843f10562f0a982303c171b6c32e5\", \"base_util_unittests\": \"244330cf4f0460d70ebd4a5c17139987b8018a1d\", \"blink_common_unittests\": \"306322d70d0995c414924dca24bc7f3aa5a1def8\", \"blink_fuzzer_unittests\": \"f7ed7b58e559b575d170aaa13720c82fba6b56c7\", \"blink_heap_unittests\": \"1f88585ce639f1542e7742375812d6e2cd875ce9\", \"blink_platform_unittests\": \"50c99bc64530b4de379e385bb4e8513508681deb\", \"blink_unittests\": \"c94956f19c2362790bafba374ea7f0c44e461b01\", \"boringssl_crypto_tests\": \"23e71fe9df9b8501f2752a0243736db6fb60deb9\", \"boringssl_ssl_tests\": \"051e74b38d79dbb5b2f659552773ee24864f0dd5\", \"browser_tests\": \"f74059494abe08287d8f4a081dee29de34f3a6c0\", \"capture_unittests\": \"b54c993096f9f90a09f4471fb0fa303b09f945c4\", \"cast_unittests\": \"8f22ee3022622faf9722d1c979072bae328c7161\", \"cc_unittests\": \"622b04aa008cc7072a2fbe9a155f8b7087613c6b\", \"chrome_app_unittests\": \"8e84bd52e524ff0fc96df730d921ae9b5aca799c\", \"chromedriver_unittests\": \"e0ed64b91f2570a10f58374fdd98dfd95f86a432\", \"chromeos_components_unittests\": \"aae5050288cea962299b2a3072bf7fdfb7ae6da5\", \"chromeos_unittests\": \"d1cb3f294ab232209fbe035f472b9cf33f0a92f9\", \"components_browsertests\": \"95b58a97075f22f9672b1f79b1fb68497808feb4\", \"components_unittests\": \"53448db334f2a18b26792644dceb9f3e0417e8ef\", \"compositor_unittests\": \"3b1e44dbaaf79b91167063b30456fcfc5e334354\", \"content_browsertests\": \"5140a745ec9e47c9f0e064e177719f37b7d8bcd9\", \"content_unittests\": \"08e519ab9162b505479c268ea53540c6d218c560\", \"crashpad_tests\": \"f243ea2e851509b852e45c81695dd8ba7da53b56\", \"crypto_unittests\": \"728a70a8e91f911cdda7361f067b8e3aa4678986\", \"dbus_unittests\": \"d9235e0c1bb5bd6e96a6668fc886c69f5530674e\", \"device_unittests\": \"1648d7281e0e69313253e2c9d99958a31b87166e\", \"display_unittests\": \"c03aa7cc9977394e7cdd6204834fe0f926d5b24a\", \"events_unittests\": \"5553c7566d8529e1bf969b4b1cfab07b861ea68f\", \"exo_unittests\": \"3dd622d86967fe0fd351a2caf01511a089833991\", \"extensions_browsertests\": \"9ce566f135e9cb0bc102b434f79fb0603f81c69f\", \"extensions_unittests\": \"c678d552614600ebb48a1db65da8d38b0d186349\", \"filesystem_service_unittests\": \"98b7ac2be6606684f98cb829094c5f1c7a434768\", \"gcm_unit_tests\": \"8e6b898f9a54bc1beaa3a2c7aba0ac0fd897fd12\", \"gfx_unittests\": \"1f15cada13e783def1b448bccca803b7961b07da\", \"gin_unittests\": \"555ada4edba78533d0da242e6101cdd26dfd8f93\", \"gl_unittests_ozone\": \"e4b935fd923c6419dbd6a8d44f28d6b7f68c3e37\", \"google_apis_unittests\": \"1dbd734224a873f1cc3447e609d77a3e4b2f465a\", \"gpu_unittests\": \"b0c2aa898eb0f5bedc0d10d6d8968b59f6ba88ff\", \"gwp_asan_unittests\": \"822cc5a7d1e79601c087333ac76bcdf37029a2b0\", \"interactive_ui_tests\": \"3a92ee97c2111d30f3d0193f16f517c5356fe5bd\", \"ipc_tests\": \"0bcf942c383a4d41d2040159c95b329426a582bd\", \"jingle_unittests\": \"b960e3ede9d264b17c755bf544d3c38228116265\", \"keyboard_unittests\": \"c5ead004e1753c723d6d26357c5320d629473e68\", \"latency_unittests\": \"d9eb48b4ce01414c789313da9aff211725656655\", \"libjingle_xmpp_unittests\": \"1ce110ed923a0b9f064317b60950dee215509f09\", \"liburlpattern_unittests\": \"8c58b74104dc019917bde000cd40310954a87629\", \"media_blink_unittests\": \"9fbe45a8943bad041a1a8e1b1ace938cbde92ce8\", \"media_unittests\": \"08e7785ba770dbc032c7fe622ebce78ffa0f7933\", \"message_center_unittests\": \"5a36fb1797cf0c139bf0b3f530459e380296fa1c\", \"midi_unittests\": \"044586b2e0549e56e0fbdcf791d099db578a9aec\", \"mojo_core_unittests\": \"5699b902e3eaaa310a0cfcabecc35f545de76c9f\", \"mojo_unittests\": \"954de0a3d5e37d4b334bee6c1f6a049bd7f5918c\", \"nacl_helper_nonsfi_unittests\": \"193e237b4987101df9864480ff82fb6daf77dd28\", \"nacl_loader_unittests\": \"385061b9c8f93ca1d178db8c023a0bb494a1c438\", \"native_theme_unittests\": \"26a197083b851edddd3a71ce6c88a66a5b96305f\", \"net_unittests\": \"9e7ce1a89bd214afe63e4fb1148dd53bfb9a412b\", \"ozone_gl_unittests\": \"3c75eb1a391033c943821f6eab494f710f3f8070\", \"ozone_unittests\": \"4e6f86941e473e665c0628d7cddbde998ed0f8ce\", \"ozone_x11_unittests\": \"ca44dbebadd8283b80f53b38049ee4136fd27c13\", \"pdf_unittests\": \"18edf86dc452a4b2bbfd4e0eb1cbe49afb5842fa\", \"perfetto_unittests\": \"a775cf6e89377a58e304b2ff6b4b8c3f0e3db803\", \"ppapi_unittests\": \"2d95d726eaa6f1c62cfb4b272537e4ff79779210\", \"printing_unittests\": \"67b74265817741cf9519cff8f427dd859026ac6c\", \"remoting_unittests\": \"59620a63579f034895c13bd187711e1654409988\", \"sandbox_linux_unittests\": \"f01291b519d1f5788356ecbc160e702bb84a8e37\", \"service_manager_unittests\": \"914be5f61a2bf4de1077a0a8fb6cd1329744d67f\", \"services_unittests\": \"2779dd219c32141a2c3a6abbbcc783726342f887\", \"shell_dialogs_unittests\": \"c95179bbe3e9f6ff5c8fafad5546fcd1a1177b47\", \"shell_encryption_unittests\": \"98692c9ce9dc40aa8fb40b6a1ee65dd6650b6043\", \"skia_unittests\": \"303c5a73f77243b8bcf9e9699e4a2be34f4792c2\", \"snapshot_unittests\": \"53f4e29dc72c0241dffe3a5c40a2705f09781063\", \"sql_unittests\": \"324ab32efdd7a7e5a0d1a8c78ea5e2acb6d953b9\", \"storage_unittests\": \"6f26481282c0850fe2adeabcd51a41440c9b16a1\", \"sync_integration_tests\": \"d51559277f1696d6eeb9e42a908a03a9e28921a5\", \"traffic_annotation_auditor_unittests\": \"ffeb8528d6e97007399bc89b2d1de0e623b60233\", \"ui_base_unittests\": \"29b92feaa80d5e108978ec569ea409876b683775\", \"ui_chromeos_unittests\": \"a4f18ac013072b870de66c48d8de7acb9ceb04b1\", \"ui_touch_selection_unittests\": \"247d85f40451116eb2369c6e6042a742a9e74cae\", \"unit_tests\": \"a5f9664c3e4846080db86eb441b7c06695270ed0\", \"url_unittests\": \"16290403628a89894149515ff8b0c2067bb81cdd\", \"usage_time_limit_unittests\": \"e1bbeea932b58839ef9eb7c7a60088bd42c92678\", \"views_unittests\": \"9141689c62fb1ccd4db60e9a97be0b416d8c4590\", \"viz_unittests\": \"9a5dec1af3a117ce0987ba1f5cf2ca620c823289\", \"wayland_client_perftests\": \"cc4f1228e20fd61fb9307b5cb342d9bb5d799fa6\", \"wm_unittests\": \"d146c79bb80cfc160296d92d2617aa0c625aa6c9\", \"wtf_unittests\": \"feebfe9abed9fed70325cad7ff0d02e88c183c31\", \"zlib_unittests\": \"544d6db82a6d267d44744c6e8780ea8cf3f760d6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_5f9879dd307b3e3de87d4273aaf77dfc3adf50a63c1d75c3b245bfdff463a933_v2\", \"builder_8c23a72064650b4b1d9380637a287eed4ae2e2a2092116afea022d28ee09b5dd_v2\", \"builder_8e35dc9d0a811a7a5937b2845f7d6ff611dfc73c6ea10d73e1df62dc95746f2a_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a10052c67097968898fa29710cdaa0ada58a120001760a536a006ca29eefe964_v2\", \"builder_e9d7d0a19fc068adf341a224b6eb4c464e3f53ed9d47979ef0c80d8aa2ba711c_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-47-zair\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611176729927331",
"status": "COMPLETED",
"status_changed_ts": "1611179542833119",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44774",
"builder:linux-chromeos-rel",
"buildset:commit/git/3f12512d26b54f6ea5c855e70a8fd93cff189be5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3f12512d26b54f6ea5c855e70a8fd93cff189be5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022982732552910016",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857552670434607632/+/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:513a6c745552d910",
"user_agent:luci-scheduler"
],
"updated_ts": "1611179542837737",
"url": "https://ci.chromium.org/b/8857552670434607632",
"utcnow_ts": "1611179543710186"
}
}
[21:52:23.719] Invocation finished in 50m10.923952939s with status SUCCEEDED