[11:14:07.588] New invocation is queued and will start shortly
[11:14:08.796] Starting the invocation (attempt 1)
[11:14:08.829] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:14:08.829] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:14:08.830] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022476149993270544",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3eb5fc814002a218a109ec3473f36a1acb736cc4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022476149993270544",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/3eb5fc814002a218a109ec3473f36a1acb736cc4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3eb5fc814002a218a109ec3473f36a1acb736cc4",
"gitiles_ref:refs/heads/master"
]
}
[11:14:10.234] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1611659649000806",
"id": "8857046087848940352",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3eb5fc814002a218a109ec3473f36a1acb736cc4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611659649993822",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44914",
"builder:linux-chromeos-rel",
"buildset:commit/git/3eb5fc814002a218a109ec3473f36a1acb736cc4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3eb5fc814002a218a109ec3473f36a1acb736cc4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022476149993270544",
"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/8857046087848940352/+/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": "1611659649994018",
"url": "https://ci.chromium.org/b/8857046087848940352",
"utcnow_ts": "1611659650220952"
}
}
[11:14:10.234] Task URL: https://ci.chromium.org/b/8857046087848940352
[11:14:10.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:2:0) after 1m0s
[11:14:36.463] Received PubSub notification, asking Buildbucket for the build status
[11:14:36.768] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:10.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:2:0)
[11:15:10.268] Timer tick, asking Buildbucket for the build status
[11:15:10.992] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:10.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:4:0) after 1m0s
[11:16:11.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:4:0)
[11:16:11.068] Timer tick, asking Buildbucket for the build status
[11:16:11.198] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:11.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:5:0) after 1m0s
[11:17:11.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:5:0)
[11:17:11.185] Timer tick, asking Buildbucket for the build status
[11:17:11.251] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:11.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:6:0) after 1m0s
[11:18:11.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:6:0)
[11:18:11.293] Timer tick, asking Buildbucket for the build status
[11:18:11.371] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:11.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:7:0) after 1m0s
[11:19:11.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:7:0)
[11:19:11.398] Timer tick, asking Buildbucket for the build status
[11:19:11.533] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:11.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:8:0) after 1m0s
[11:20:11.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:8:0)
[11:20:11.578] Timer tick, asking Buildbucket for the build status
[11:20:11.774] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:11.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:9:0) after 1m0s
[11:21:11.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:9:0)
[11:21:11.842] Timer tick, asking Buildbucket for the build status
[11:21:12.002] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:12.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:10:0) after 1m0s
[11:22:12.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:10:0)
[11:22:12.105] Timer tick, asking Buildbucket for the build status
[11:22:12.252] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:12.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:11:0) after 1m0s
[11:23:12.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:11:0)
[11:23:12.281] Timer tick, asking Buildbucket for the build status
[11:23:12.360] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:12.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:12:0) after 1m0s
[11:24:12.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:12:0)
[11:24:12.356] Timer tick, asking Buildbucket for the build status
[11:24:13.727] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:13.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:13:0) after 1m0s
[11:25:13.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:13:0)
[11:25:13.746] Timer tick, asking Buildbucket for the build status
[11:25:13.825] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:13.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:14:0) after 1m0s
[11:26:13.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:14:0)
[11:26:13.981] Timer tick, asking Buildbucket for the build status
[11:26:14.080] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:14.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:15:0) after 1m0s
[11:27:14.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:15:0)
[11:27:14.242] Timer tick, asking Buildbucket for the build status
[11:27:14.311] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:14.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:16:0) after 1m0s
[11:28:14.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:16:0)
[11:28:14.397] Timer tick, asking Buildbucket for the build status
[11:28:14.451] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:14.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:17:0) after 1m0s
[11:29:14.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:17:0)
[11:29:14.508] Timer tick, asking Buildbucket for the build status
[11:29:14.812] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:14.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:18:0) after 1m0s
[11:30:15.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:18:0)
[11:30:15.072] Timer tick, asking Buildbucket for the build status
[11:30:15.161] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:15.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:19:0) after 1m0s
[11:31:15.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:19:0)
[11:31:15.154] Timer tick, asking Buildbucket for the build status
[11:31:15.245] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:15.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:20:0) after 1m0s
[11:32:15.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:20:0)
[11:32:15.315] Timer tick, asking Buildbucket for the build status
[11:32:15.392] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:15.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:21:0) after 1m0s
[11:33:15.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:21:0)
[11:33:15.531] Timer tick, asking Buildbucket for the build status
[11:33:15.590] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:15.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:22:0) after 1m0s
[11:34:15.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:22:0)
[11:34:15.777] Timer tick, asking Buildbucket for the build status
[11:34:15.994] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:15.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:23:0) after 1m0s
[11:35:16.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:23:0)
[11:35:16.016] Timer tick, asking Buildbucket for the build status
[11:35:16.111] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:16.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:24:0) after 1m0s
[11:36:16.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:24:0)
[11:36:16.205] Timer tick, asking Buildbucket for the build status
[11:36:16.528] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:16.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:25:0) after 1m0s
[11:37:16.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:25:0)
[11:37:16.656] Timer tick, asking Buildbucket for the build status
[11:37:17.309] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:17.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:26:0) after 1m0s
[11:38:17.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:26:0)
[11:38:17.377] Timer tick, asking Buildbucket for the build status
[11:38:17.434] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:17.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:27:0) after 1m0s
[11:39:17.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:27:0)
[11:39:17.624] Timer tick, asking Buildbucket for the build status
[11:39:17.759] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:17.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:28:0) after 1m0s
[11:40:18.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:28:0)
[11:40:18.159] Timer tick, asking Buildbucket for the build status
[11:40:18.241] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:18.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:29:0) after 1m0s
[11:41:18.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:29:0)
[11:41:18.402] Timer tick, asking Buildbucket for the build status
[11:41:18.487] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:18.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:30:0) after 1m0s
[11:42:18.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:30:0)
[11:42:18.792] Timer tick, asking Buildbucket for the build status
[11:42:18.861] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:18.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:31:0) after 1m0s
[11:43:19.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:31:0)
[11:43:19.034] Timer tick, asking Buildbucket for the build status
[11:43:19.166] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:19.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:32:0) after 1m0s
[11:44:19.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:32:0)
[11:44:19.369] Timer tick, asking Buildbucket for the build status
[11:44:19.477] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:19.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:33:0) after 1m0s
[11:45:19.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:33:0)
[11:45:19.511] Timer tick, asking Buildbucket for the build status
[11:45:19.654] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:19.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:34:0) after 1m0s
[11:46:19.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:34:0)
[11:46:19.792] Timer tick, asking Buildbucket for the build status
[11:46:20.012] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:20.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:35:0) after 1m0s
[11:47:20.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:35:0)
[11:47:20.130] Timer tick, asking Buildbucket for the build status
[11:47:20.265] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:20.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:36:0) after 1m0s
[11:48:20.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:36:0)
[11:48:20.352] Timer tick, asking Buildbucket for the build status
[11:48:20.476] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:20.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:37:0) after 1m0s
[11:49:20.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:37:0)
[11:49:20.609] Timer tick, asking Buildbucket for the build status
[11:49:20.757] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:20.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:38:0) after 1m0s
[11:50:20.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:38:0)
[11:50:20.805] Timer tick, asking Buildbucket for the build status
[11:50:21.763] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:21.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:39:0) after 1m0s
[11:51:21.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:39:0)
[11:51:21.754] Timer tick, asking Buildbucket for the build status
[11:51:22.816] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:22.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:40:0) after 1m0s
[11:52:22.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:40:0)
[11:52:22.870] Timer tick, asking Buildbucket for the build status
[11:52:23.018] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:23.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:41:0) after 1m0s
[11:53:23.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:41:0)
[11:53:23.034] Timer tick, asking Buildbucket for the build status
[11:53:23.314] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:23.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:42:0) after 1m0s
[11:54:23.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:42:0)
[11:54:23.450] Timer tick, asking Buildbucket for the build status
[11:54:23.604] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:23.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:43:0) after 1m0s
[11:55:23.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:43:0)
[11:55:23.727] Timer tick, asking Buildbucket for the build status
[11:55:23.828] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:23.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:44:0) after 1m0s
[11:56:23.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:44:0)
[11:56:23.911] Timer tick, asking Buildbucket for the build status
[11:56:25.518] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:25.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:45:0) after 1m0s
[11:57:25.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:45:0)
[11:57:25.754] Timer tick, asking Buildbucket for the build status
[11:57:25.862] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:25.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:46:0) after 1m0s
[11:58:25.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:46:0)
[11:58:25.920] Timer tick, asking Buildbucket for the build status
[11:58:26.169] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:26.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:47:0) after 1m0s
[11:59:26.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:47:0)
[11:59:26.195] Timer tick, asking Buildbucket for the build status
[11:59:26.329] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:26.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:48:0) after 1m0s
[12:00:26.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:48:0)
[12:00:26.349] Timer tick, asking Buildbucket for the build status
[12:00:27.195] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:27.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:49:0) after 1m0s
[12:01:27.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:49:0)
[12:01:27.291] Timer tick, asking Buildbucket for the build status
[12:01:27.642] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:27.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:50:0) after 1m0s
[12:02:27.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:50:0)
[12:02:27.703] Timer tick, asking Buildbucket for the build status
[12:02:27.845] Build 8857046087848940352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:27.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022476149993270544:51:0) after 1m0s
[12:03:26.634] Received PubSub notification, asking Buildbucket for the build status
[12:03:26.917] Build 8857046087848940352: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:03:26.917] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1611662605006471",
"created_by": "project:chromium",
"created_ts": "1611659649000806",
"id": "8857046087848940352",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3eb5fc814002a218a109ec3473f36a1acb736cc4\"}}",
"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\": \"3eb5fc814002a218a109ec3473f36a1acb736cc4\", \"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-23-q58c\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44914, \"got_angle_revision\": \"9bbcd86ae719866273598c988709c7ec3d462e1d\", \"got_dawn_revision\": \"b3177d418e3b3d14fe99c63badebb191c510830e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"3eb5fc814002a218a109ec3473f36a1acb736cc4\", \"got_revision_cp\": \"refs/heads/master@{#847113}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"ea1f7d10db1f22f3327f4c0bc690695bc1a73aa0\", \"got_v8_revision\": \"cb0390ea3f974ec4702166fb6ce4455c408b9bdf\", \"got_v8_revision_cp\": \"refs/heads/9.0.70@{#1}\", \"got_webrtc_revision\": \"ded6636cf43904448ee926d1f2b4352c8a957ca6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33068}\", \"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\": \"3eb5fc814002a218a109ec3473f36a1acb736cc4\", \"swarm_hashes_refs/heads/master(at){#847113}_without_patch\": {\"absl_hardening_tests\": \"be2e82ec65b3d8c9f04f45937cd66f4cafa5c3ed\", \"accessibility_unittests\": \"054d4f960cd43ee51417354a5dafdba7ff8214e3\", \"angle_unittests\": \"e70b1c18c21d036effcb19c499942a1bf14d3010\", \"app_list_unittests\": \"a3e349e4075212b345645f63cc4d3baabc58e158\", \"app_shell_unittests\": \"2a6d239d193b7e1227013bdea96a877fe2bd853f\", \"ash_unittests\": \"c394d1cfb56ff66be2624813cd96398a23c61bf7\", \"aura_unittests\": \"d08493d377dce52aa20ee3d9a49a62982875f729\", \"base_unittests\": \"da5c10c8a313b338c0dbed492be22500d950842f\", \"base_util_unittests\": \"1e7cfb41dee7dcf17e3c38f0ab24ddffdceef401\", \"blink_common_unittests\": \"35e3f999021f99962caa3ed10b8feb3f953772ed\", \"blink_fuzzer_unittests\": \"8919641e641db47d2eb4fe0093650e56503cd911\", \"blink_heap_unittests\": \"2d80b6c08ebac0c53f025a57fb845309c08f787b\", \"blink_platform_unittests\": \"3b7bb9b70348af9893704ffc5b523b592cf62c0d\", \"blink_unittests\": \"005494c339146d9d090af2c755cf8ccdf2d2994c\", \"boringssl_crypto_tests\": \"b681ccff43b7e5bb5fc7b012c1217e8cc47ca312\", \"boringssl_ssl_tests\": \"69749ddff366d19f621bd87a7cc7a6f7ef368f63\", \"browser_tests\": \"7a4829dd732962a2a73450b64af4b66e8caae97c\", \"capture_unittests\": \"14afcf9d0da16d6355d13cfccfb717539ff19ffd\", \"cast_unittests\": \"39db47c6f1317a92bfd64cd3917414fc30cc71a3\", \"cc_unittests\": \"e1b4c3276cc587dee4843f9da7aa33f5953dc6d5\", \"chrome_app_unittests\": \"ece72062660d78324a7b5869bf52892d6d1306f2\", \"chromedriver_unittests\": \"73564439a0b95810c06207dde2dee83e4eca34f2\", \"chromeos_components_unittests\": \"4f69162e1578fa778960a64dffa561a27dcd146b\", \"chromeos_unittests\": \"82c46c40590e4da47c17c419b7975b4dcb7fe596\", \"components_browsertests\": \"61c8875421a31045ae25ca830844ecd0108ec060\", \"components_unittests\": \"1427bb380e7db65504902ab445fdd9fda5a66834\", \"compositor_unittests\": \"f8d423ee7a141345b02b1b452057c2aa73564e79\", \"content_browsertests\": \"7789fa58dd31f4a6669b069baa18d5ffa296987d\", \"content_unittests\": \"2b09ae3ca6a59f713cbe04cf3b46d6d3d41292e2\", \"crashpad_tests\": \"dc74d29dc13d5d2164c2c3ba47421d0f977721ab\", \"crypto_unittests\": \"96ff67c1522a9a7411ee3757c815d471975f4cab\", \"dbus_unittests\": \"70764d5c32f2ae64f9f817d8c7d055ec73ca940d\", \"device_unittests\": \"d35bf3cbdec47d7266503a81dfc5da0858e71ca1\", \"display_unittests\": \"73eb861003e60d4a45863711c814219906adbc70\", \"events_unittests\": \"5e60d078ac2a1a7cbe7e279cf998f0698e073531\", \"exo_unittests\": \"3e5832be646e8ea266f0799d67a49dba93e5fed1\", \"extensions_browsertests\": \"e7aad40a3d4b5e2841608101b3dc16610585616e\", \"extensions_unittests\": \"299690c6b97b33d6aae5e6b586dc06862eaffdf6\", \"filesystem_service_unittests\": \"1798e6d9e5daf1c3cdf81df58b2a2a9a685c7f08\", \"gcm_unit_tests\": \"cb6f251ac0a5ae61cbf53059b34cb835341a24a6\", \"gfx_unittests\": \"fb851a8716a717301cab3187c8a50317b2375881\", \"gin_unittests\": \"b003641cc932208efe7a612b71f9afd5d2b7ddd3\", \"gl_unittests_ozone\": \"918ad2109a56828623aa658fedf7062168f4eb0d\", \"google_apis_unittests\": \"41917763972e1cf5f88378b7bfbde20667bcc907\", \"gpu_unittests\": \"3a98ef81a86d918e74e7495bb701e647befa4c1c\", \"gwp_asan_unittests\": \"4e28db97f48e17a759573ebd47a0e54c402d2077\", \"interactive_ui_tests\": \"f735ab795fa38d60cd7fbce4c7287f880f43dee5\", \"ipc_tests\": \"43305ba9cb6d4927c04b4a8e612a71136f00e0ec\", \"jingle_unittests\": \"0f773777c3811b55dced3315371d802dcb32021e\", \"keyboard_unittests\": \"4a05732a787f28495987889a2bc966ceddc4a7e9\", \"latency_unittests\": \"17da9285a95cfbe339d741bfa20ddc61cba6187a\", \"libjingle_xmpp_unittests\": \"7cc1cec297d6b5c40512ba865cf8aca981780c05\", \"liburlpattern_unittests\": \"8fce5cf570f36134a3b9aef87df500c3176a3093\", \"media_blink_unittests\": \"0b2b650e219b218471c282acb4990137ccda1dcd\", \"media_unittests\": \"ae51cac5727aa220018dbdce23590ad17c7d4677\", \"message_center_unittests\": \"56a04aef0be84263a5772757b5438bd59426c60b\", \"midi_unittests\": \"8f5605ca1341130c52f08753f1d362d7ee928e1d\", \"mojo_core_unittests\": \"031e6d8acf82715e65b4ba897e045c99528fb19a\", \"mojo_unittests\": \"b7015bdea8583d3ad4410133718f472ab87f8a26\", \"nacl_helper_nonsfi_unittests\": \"7af2965068f92d4010663ef459ea89bea2adaece\", \"nacl_loader_unittests\": \"b9be8e4e06d591aabe7447f666f97f49b83742ff\", \"native_theme_unittests\": \"c1f45f7eb23aafed857bdbce8e504def1e5fa303\", \"net_unittests\": \"fbba62417039c477cafaeaa91538fd837b426dc3\", \"ozone_gl_unittests\": \"fe8314319637a90e75f517e1d174c3056af1f95b\", \"ozone_unittests\": \"537d0d9b3b903037a6461ea8c567a2c264f11cb4\", \"ozone_x11_unittests\": \"86c65d5468347077aa34ee04ef02e1802f9f8327\", \"pdf_unittests\": \"599c7a3af9e972aab2ceb1e30e8ce500546e4f08\", \"perfetto_unittests\": \"bd370282f946a36451c18f460d745cbcc1e4ebff\", \"ppapi_unittests\": \"edd309ee0f75335c5e542706dff3fcb39d6d1f2e\", \"printing_unittests\": \"773688d368ecac2917ba32f394f741548f2662a0\", \"remoting_unittests\": \"dfdf480b9051c360231a6ff2a4944eede6c6d395\", \"sandbox_linux_unittests\": \"ef42a2ddff480578b415765836ee0f2834e58f01\", \"service_manager_unittests\": \"a11e7aab234791077feba3a00cb7038287c66c97\", \"services_unittests\": \"6dd18924f7f895546837dba726781972295ea0ab\", \"shell_dialogs_unittests\": \"7e214d02f62c0ff8d7ba5577561b8a29e3786985\", \"shell_encryption_unittests\": \"1d970bedcd4a7cacbdef8cf26178e266a204dd05\", \"skia_unittests\": \"3d094323ceb7381dd6173bb899fcdd93f28f8697\", \"snapshot_unittests\": \"4b29e41d54db3207845f93887d60f3222d8a71d1\", \"sql_unittests\": \"ddacad912f24a1437db91cb856b51fb366fe21fb\", \"storage_unittests\": \"6fa1b0574a49ebb222e761a27e7467fe3b140990\", \"sync_integration_tests\": \"f49ff9f6e662fcb264a136d251f2d40a26929085\", \"traffic_annotation_auditor_unittests\": \"a0a06945c6959dd13a29b924b762a03e0842f14b\", \"ui_base_unittests\": \"37ebae032a03527e22c728468cb6865ff3cf9116\", \"ui_chromeos_unittests\": \"0a56132e40b54ec43b5f3809c813db781045dc0f\", \"ui_touch_selection_unittests\": \"f4044e629841d66eb54865ea1fe48fec1bed37bb\", \"unit_tests\": \"13185944b2b2db603096a43b7b837d07f5be82de\", \"url_unittests\": \"a524e0024ee7addcd953038240ed87b5ff052cee\", \"usage_time_limit_unittests\": \"b9f359c15f56eda0953ba9c3680a83f53ac00a0f\", \"views_unittests\": \"6b6cdb46837acff62e5d62f44abebc487251a961\", \"viz_unittests\": \"0d2f0bda5d225a5e2f1234f3a90450fe9b5bc0a4\", \"wayland_client_perftests\": \"116bc649d3185f26d23c371f00aee87a78622fd1\", \"wm_unittests\": \"70a3caba6309cadeaf62200d40c15e30df5ea09b\", \"wtf_unittests\": \"9585741d8217bfba42953d6a0cadfd470060ac3c\", \"zlib_unittests\": \"1c8875b97b5e95bb20b9d57e1088f359250db0c7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_03684948df0f250a19c7b639204de5133dfe487bdadd877fd8990d1b9d0fd4b0_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_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-23-q58c\"], \"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\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611659675092587",
"status": "COMPLETED",
"status_changed_ts": "1611662605298113",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44914",
"builder:linux-chromeos-rel",
"buildset:commit/git/3eb5fc814002a218a109ec3473f36a1acb736cc4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3eb5fc814002a218a109ec3473f36a1acb736cc4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022476149993270544",
"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/8857046087848940352/+/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:5157382d19b52d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611662605303584",
"url": "https://ci.chromium.org/b/8857046087848940352",
"utcnow_ts": "1611662606902943"
}
}
[12:03:26.917] Invocation finished in 49m19.345340588s with status SUCCEEDED