[00:31:14.162] New invocation is queued and will start shortly
[00:31:15.496] Starting the invocation (attempt 1)
[00:31:15.534] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:31:15.534] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:31:15.534] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021791821429032528",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"98caa68c71baa8226984b5354051683adc474550\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9021791821429032528",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/98caa68c71baa8226984b5354051683adc474550",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/98caa68c71baa8226984b5354051683adc474550",
"gitiles_ref:refs/heads/master"
]
}
[00:31:17.124] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612312275706969",
"id": "8856361759147064080",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"98caa68c71baa8226984b5354051683adc474550\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612312276871984",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45095",
"builder:linux-chromeos-rel",
"buildset:commit/git/98caa68c71baa8226984b5354051683adc474550",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/98caa68c71baa8226984b5354051683adc474550",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021791821429032528",
"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/8856361759147064080/+/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": "1612312276872140",
"url": "https://ci.chromium.org/b/8856361759147064080",
"utcnow_ts": "1612312277106847"
}
}
[00:31:17.124] Task URL: https://ci.chromium.org/b/8856361759147064080
[00:31:17.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:2:0) after 1m0s
[00:32:17.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:2:0)
[00:32:17.257] Timer tick, asking Buildbucket for the build status
[00:32:17.405] Build 8856361759147064080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:17.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:3:0) after 1m0s
[00:32:56.757] Received PubSub notification, asking Buildbucket for the build status
[00:32:56.942] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:17.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:3:0)
[00:33:17.440] Timer tick, asking Buildbucket for the build status
[00:33:17.565] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:17.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:5:0) after 1m0s
[00:34:17.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:5:0)
[00:34:17.622] Timer tick, asking Buildbucket for the build status
[00:34:17.723] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:17.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:6:0) after 1m0s
[00:35:17.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:6:0)
[00:35:17.843] Timer tick, asking Buildbucket for the build status
[00:35:17.905] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:17.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:7:0) after 1m0s
[00:36:18.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:7:0)
[00:36:18.009] Timer tick, asking Buildbucket for the build status
[00:36:18.075] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:18.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:8:0) after 1m0s
[00:37:18.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:8:0)
[00:37:18.063] Timer tick, asking Buildbucket for the build status
[00:37:18.182] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:18.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:9:0) after 1m0s
[00:38:18.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:9:0)
[00:38:18.227] Timer tick, asking Buildbucket for the build status
[00:38:18.368] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:18.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:10:0) after 1m0s
[00:39:18.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:10:0)
[00:39:18.436] Timer tick, asking Buildbucket for the build status
[00:39:18.567] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:18.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:11:0) after 1m0s
[00:40:18.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:11:0)
[00:40:18.724] Timer tick, asking Buildbucket for the build status
[00:40:18.868] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:18.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:12:0) after 1m0s
[00:41:19.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:12:0)
[00:41:19.004] Timer tick, asking Buildbucket for the build status
[00:41:19.135] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:19.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:13:0) after 1m0s
[00:42:19.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:13:0)
[00:42:19.150] Timer tick, asking Buildbucket for the build status
[00:42:19.403] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:19.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:14:0) after 1m0s
[00:43:19.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:14:0)
[00:43:19.451] Timer tick, asking Buildbucket for the build status
[00:43:19.593] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:19.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:15:0) after 1m0s
[00:44:19.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:15:0)
[00:44:19.645] Timer tick, asking Buildbucket for the build status
[00:44:19.710] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:19.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:16:0) after 1m0s
[00:45:19.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:16:0)
[00:45:19.770] Timer tick, asking Buildbucket for the build status
[00:45:19.836] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:19.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:17:0) after 1m0s
[00:46:20.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:17:0)
[00:46:20.315] Timer tick, asking Buildbucket for the build status
[00:46:20.452] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:20.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:18:0) after 1m0s
[00:47:20.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:18:0)
[00:47:20.914] Timer tick, asking Buildbucket for the build status
[00:47:20.977] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:20.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:19:0) after 1m0s
[00:48:21.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:19:0)
[00:48:21.184] Timer tick, asking Buildbucket for the build status
[00:48:21.286] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:21.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:20:0) after 1m0s
[00:49:21.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:20:0)
[00:49:21.339] Timer tick, asking Buildbucket for the build status
[00:49:21.397] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:21.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:21:0) after 1m0s
[00:50:21.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:21:0)
[00:50:21.415] Timer tick, asking Buildbucket for the build status
[00:50:21.481] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:21.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:22:0) after 1m0s
[00:51:21.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:22:0)
[00:51:21.603] Timer tick, asking Buildbucket for the build status
[00:51:21.715] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:21.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:23:0) after 1m0s
[00:52:21.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:23:0)
[00:52:21.869] Timer tick, asking Buildbucket for the build status
[00:52:21.941] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:21.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:24:0) after 1m0s
[00:53:22.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:24:0)
[00:53:22.109] Timer tick, asking Buildbucket for the build status
[00:53:22.182] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:22.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:25:0) after 1m0s
[00:54:22.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:25:0)
[00:54:22.251] Timer tick, asking Buildbucket for the build status
[00:54:22.332] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:22.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:26:0) after 1m0s
[00:55:22.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:26:0)
[00:55:22.555] Timer tick, asking Buildbucket for the build status
[00:55:22.637] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:22.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:27:0) after 1m0s
[00:56:22.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:27:0)
[00:56:22.815] Timer tick, asking Buildbucket for the build status
[00:56:22.921] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:22.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:28:0) after 1m0s
[00:57:23.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:28:0)
[00:57:23.019] Timer tick, asking Buildbucket for the build status
[00:57:23.074] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:23.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:29:0) after 1m0s
[00:58:23.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:29:0)
[00:58:23.177] Timer tick, asking Buildbucket for the build status
[00:58:23.342] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:23.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:30:0) after 1m0s
[00:59:23.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:30:0)
[00:59:23.422] Timer tick, asking Buildbucket for the build status
[00:59:23.485] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:23.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:31:0) after 1m0s
[01:00:23.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:31:0)
[01:00:23.570] Timer tick, asking Buildbucket for the build status
[01:00:23.644] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:23.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:32:0) after 1m0s
[01:01:23.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:32:0)
[01:01:23.658] Timer tick, asking Buildbucket for the build status
[01:01:23.775] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:23.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:33:0) after 1m0s
[01:02:23.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:33:0)
[01:02:23.811] Timer tick, asking Buildbucket for the build status
[01:02:23.895] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:23.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:34:0) after 1m0s
[01:03:23.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:34:0)
[01:03:23.940] Timer tick, asking Buildbucket for the build status
[01:03:24.004] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:24.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:35:0) after 1m0s
[01:04:24.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:35:0)
[01:04:24.097] Timer tick, asking Buildbucket for the build status
[01:04:24.162] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:24.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:36:0) after 1m0s
[01:05:24.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:36:0)
[01:05:24.241] Timer tick, asking Buildbucket for the build status
[01:05:24.535] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:24.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:37:0) after 1m0s
[01:06:24.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:37:0)
[01:06:24.519] Timer tick, asking Buildbucket for the build status
[01:06:24.793] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:24.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:38:0) after 1m0s
[01:07:24.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:38:0)
[01:07:24.894] Timer tick, asking Buildbucket for the build status
[01:07:24.960] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:24.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:39:0) after 1m0s
[01:08:24.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:39:0)
[01:08:24.944] Timer tick, asking Buildbucket for the build status
[01:08:25.033] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:25.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:40:0) after 1m0s
[01:09:25.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:40:0)
[01:09:25.138] Timer tick, asking Buildbucket for the build status
[01:09:25.199] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:25.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:41:0) after 1m0s
[01:10:25.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:41:0)
[01:10:25.237] Timer tick, asking Buildbucket for the build status
[01:10:25.498] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:25.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:42:0) after 1m0s
[01:11:25.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:42:0)
[01:11:25.574] Timer tick, asking Buildbucket for the build status
[01:11:25.835] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:25.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:43:0) after 1m0s
[01:12:25.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:43:0)
[01:12:25.954] Timer tick, asking Buildbucket for the build status
[01:12:26.138] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:26.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:44:0) after 1m0s
[01:13:26.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:44:0)
[01:13:26.295] Timer tick, asking Buildbucket for the build status
[01:13:26.365] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:26.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:45:0) after 1m0s
[01:14:26.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:45:0)
[01:14:26.552] Timer tick, asking Buildbucket for the build status
[01:14:26.655] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:26.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:46:0) after 1m0s
[01:15:26.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:46:0)
[01:15:26.893] Timer tick, asking Buildbucket for the build status
[01:15:27.034] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:27.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:47:0) after 1m0s
[01:16:27.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:47:0)
[01:16:27.040] Timer tick, asking Buildbucket for the build status
[01:16:27.815] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:27.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:48:0) after 1m0s
[01:17:27.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:48:0)
[01:17:27.845] Timer tick, asking Buildbucket for the build status
[01:17:27.992] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:27.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:49:0) after 1m0s
[01:18:27.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:49:0)
[01:18:27.994] Timer tick, asking Buildbucket for the build status
[01:18:28.093] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:28.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:50:0) after 1m0s
[01:19:28.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:50:0)
[01:19:28.184] Timer tick, asking Buildbucket for the build status
[01:19:28.354] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:28.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:51:0) after 1m0s
[01:20:28.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:51:0)
[01:20:28.388] Timer tick, asking Buildbucket for the build status
[01:20:28.735] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:28.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:52:0) after 1m0s
[01:21:28.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:52:0)
[01:21:28.828] Timer tick, asking Buildbucket for the build status
[01:21:28.945] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:28.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:53:0) after 1m0s
[01:22:28.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:53:0)
[01:22:28.943] Timer tick, asking Buildbucket for the build status
[01:22:29.426] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:29.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:54:0) after 1m0s
[01:23:29.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:54:0)
[01:23:29.513] Timer tick, asking Buildbucket for the build status
[01:23:30.116] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:30.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:55:0) after 1m0s
[01:24:30.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:55:0)
[01:24:30.248] Timer tick, asking Buildbucket for the build status
[01:24:30.647] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:30.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:56:0) after 1m0s
[01:25:30.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:56:0)
[01:25:30.691] Timer tick, asking Buildbucket for the build status
[01:25:30.777] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:30.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:57:0) after 1m0s
[01:26:30.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:57:0)
[01:26:30.896] Timer tick, asking Buildbucket for the build status
[01:26:31.142] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:31.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:58:0) after 1m0s
[01:27:31.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:58:0)
[01:27:31.255] Timer tick, asking Buildbucket for the build status
[01:27:31.614] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:31.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:59:0) after 1m0s
[01:28:31.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:59:0)
[01:28:31.648] Timer tick, asking Buildbucket for the build status
[01:28:31.737] Build 8856361759147064080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:31.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021791821429032528:60:0) after 1m0s
[01:28:42.083] Received PubSub notification, asking Buildbucket for the build status
[01:28:42.173] Build 8856361759147064080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:28:42.173] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612315717226356",
"created_by": "project:chromium",
"created_ts": "1612312275706969",
"id": "8856361759147064080",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"98caa68c71baa8226984b5354051683adc474550\"}}",
"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\": \"98caa68c71baa8226984b5354051683adc474550\", \"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-mh2j\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45095, \"got_angle_revision\": \"926d1cea1a0c52325cc66dc51dd8b941a0dfa783\", \"got_dawn_revision\": \"dd988bca844a6003a7249221680fc3e4f2d8b445\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"98caa68c71baa8226984b5354051683adc474550\", \"got_revision_cp\": \"refs/heads/master@{#849858}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"51045556acd0fe0a1b687ef00725a57f0f19a91b\", \"got_v8_revision\": \"3f037e8e983f58d3efe01425c31a524001f9fb34\", \"got_v8_revision_cp\": \"refs/heads/9.0.118@{#1}\", \"got_webrtc_revision\": \"e7c79fd3d66e0f6c54c027f880a8b1682ebae58a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33124}\", \"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\": \"98caa68c71baa8226984b5354051683adc474550\", \"swarm_hashes_refs/heads/master(at){#849858}_without_patch\": {\"absl_hardening_tests\": \"4642a82ee14699f369f2b4c138e14eb6d0f48157\", \"accessibility_unittests\": \"9cd899d2c7f8e8ec9a08696ec6d1465a4c5825ed\", \"angle_unittests\": \"172b9085688f8b928099ec20a78c186dfdd68ed3\", \"app_list_unittests\": \"7a572a39eda32e53f9df53cb46a45a018115fe48\", \"app_shell_unittests\": \"7c2e753575248784019ef9d26560a5b76e02b209\", \"ash_unittests\": \"cb9491069629308d1f939effe5c790b5fc2fd77f\", \"aura_unittests\": \"9528a111edf3be9b21140edd111b2ed9946a60be\", \"base_unittests\": \"febd9e1f9ebf9475356bbb3b4a14bbe5aab370a3\", \"base_util_unittests\": \"ee517618b73b6c0d85a144c532645c8740a67157\", \"blink_common_unittests\": \"b21720600c4218aeb1b2c084df34c7264d407008\", \"blink_fuzzer_unittests\": \"bd7d7535993952982685dae16ab0311d288e01e5\", \"blink_heap_unittests\": \"abfc13086c34b10050d5bb19060aff5a7d653fc2\", \"blink_platform_unittests\": \"b0381a3570c330da73bec196f8673c8869823dce\", \"blink_unittests\": \"40a80edc024e941111c2352a088176f5d6dfd0c7\", \"boringssl_crypto_tests\": \"039068d5fe9ae21727c5f1a66e6a7fb6277ba9ab\", \"boringssl_ssl_tests\": \"0e80e5f100e36fb62a75e69de43cf2e88f5790aa\", \"browser_tests\": \"c2160209a118cb4b3e34fde495c3d52a89bb33a0\", \"capture_unittests\": \"11baa0ef5db058e760b785d42856dd01afbc2fd1\", \"cast_unittests\": \"cdf9d8e9ddfad6bc20223f818f6a410a032f24d4\", \"cc_unittests\": \"a427595e288c6ece282ce7def2d08cab5b133cd8\", \"chrome_app_unittests\": \"756eff2c32ec71105ade621dd9f3b02dea5e1f44\", \"chromedriver_unittests\": \"244cc461ddac6a69a243a2a444296a549ec12d6b\", \"chromeos_components_unittests\": \"d7dce4c907115d90cfc4cd69d82557a82cfcd81d\", \"chromeos_unittests\": \"3a63226d9582d5a82ebab2372adfcabefd667009\", \"components_browsertests\": \"73c144be888e10b9cc45c1ea37eaeda94f04d841\", \"components_unittests\": \"df658f00d7be649a9891b38281c532bd7624549f\", \"compositor_unittests\": \"6d79e2a3789a7b794bdcff674ce1e0e537c23fa7\", \"content_browsertests\": \"a7114da827965dcbcf18dc189d1b890a9c3d454a\", \"content_unittests\": \"3f58efdacd102eeb287797a43f2e56ee7d4ea524\", \"crashpad_tests\": \"fe57e361b7708bd3089383ea99d4b48155ed63e1\", \"crypto_unittests\": \"9de4dab01588737445639bb883db27aa5bc6f40d\", \"dbus_unittests\": \"dc349397260db8df038d10d90aad6024d6038ca2\", \"device_unittests\": \"4213b30ddc44f6968f48f75a2e2255cef9c7f4e7\", \"display_unittests\": \"b24ddcb4527801dc5ffd1c53260bd1111bd5c558\", \"events_unittests\": \"6457593d2cc050e41b68cd097a23445eef6c4fe3\", \"exo_unittests\": \"1758c896adad2cb8bf5aa7bffdcb3d395f79da0b\", \"extensions_browsertests\": \"3e1bb9711f6ca439da684cc1925645ce640a832d\", \"extensions_unittests\": \"3c1d1db16c317a1c1337f7d2cf57e5c6ab4cd696\", \"filesystem_service_unittests\": \"7b0040678de5d4d6947a7b8cab96a4852ca9f3d1\", \"gcm_unit_tests\": \"4afdf08d3b3cc3ab80bfa22afa5de8e5bb6897ba\", \"gfx_unittests\": \"7f13e190a9fc75d82184d41f5e3337cd95c04f88\", \"gin_unittests\": \"02c47953c7b1397e47c9c504495e8bb9e8c20a8c\", \"gl_unittests_ozone\": \"93a4afdf2f3b23e7a8ad3b159c030c2c0793fd5a\", \"google_apis_unittests\": \"53eac35fac815af97586f204a4c446cdfcacf651\", \"gpu_unittests\": \"7b1f76b8c2521e5fcb8365537b8b71a61517b78c\", \"gwp_asan_unittests\": \"3a59c7226333afd89b4e9c87c6bec83669fad56f\", \"interactive_ui_tests\": \"3a95ebd9a75881637010bd7ee5f867c93223596e\", \"ipc_tests\": \"926d749852a61bc6a48d4588d907c9a2da54905f\", \"jingle_unittests\": \"894e0d95c6e62e7f7be40a1dcf49ca2ebb83207a\", \"keyboard_unittests\": \"bc3ab66000d6863698c15397ac11fa9aa1eab52b\", \"latency_unittests\": \"e9f9ea4bad8ef4e9620c394b99581338d8e71c25\", \"libjingle_xmpp_unittests\": \"03d5d09d59ee3c1ae1e4d7eeef070e5546837c73\", \"liburlpattern_unittests\": \"77acefe0e6a4bbddcb44461af9e829f5177a7126\", \"media_blink_unittests\": \"f204da51c9e8770bba4f490574e10339b33cccbb\", \"media_unittests\": \"7c11a39dbcd322b0807aedf36b091f19925bd203\", \"message_center_unittests\": \"4f80553aa6d7ca78ec9b342e97d9a7a08677ec4d\", \"midi_unittests\": \"ab5fd331f3682489dcfb7f51031b5e842927df3e\", \"mojo_core_unittests\": \"27af55139833906963a6e0f3e89e16f77fa0c5a2\", \"mojo_unittests\": \"4e8dfc419434047f71559b57f78a395b4351c581\", \"nacl_helper_nonsfi_unittests\": \"e919a3c86056a1658fb24a7f31f951964c95bdeb\", \"nacl_loader_unittests\": \"c491e761bd19c3282d68aace1d48cb4c36be2349\", \"native_theme_unittests\": \"2226cafa7e9a6ab77ad1977f6bfccab3ff02cb3f\", \"net_unittests\": \"2eaa1e508b7badc4296d7c75e1f6892719973f87\", \"ozone_gl_unittests\": \"044e6f6d2aa558d0c8f6a6cbd6f48048cdac89c8\", \"ozone_unittests\": \"9f1cb400b0c3ac137b1a2da30482c349ab57c4ec\", \"ozone_x11_unittests\": \"1cbd04ca6091f5592322a8406028d470159814fc\", \"pdf_unittests\": \"30c1128003d0d7c5485cd292311afb946c073775\", \"perfetto_unittests\": \"9192d075680f45e43383d5a8742e7ff333ec5afe\", \"ppapi_unittests\": \"1b31588685c34a507348be95d97f5a2779858222\", \"printing_unittests\": \"b95c8f283f4cbf58cd69aa823ef60e6f1a808447\", \"remoting_unittests\": \"894ffef4d426156aa1dcf51f57ca8fbb83652859\", \"sandbox_linux_unittests\": \"0b6c4ad5b62ea18b1d39f8ae9cb72e306c9989db\", \"service_manager_unittests\": \"7a26f06d194876c2ab66928c6c01e45cecbaee43\", \"services_unittests\": \"b7bd9a7e19c9b1d56b309a84023c314195af4d65\", \"shell_dialogs_unittests\": \"6284709e8abdba5f1b6ab8e3e008662d5a97361d\", \"shell_encryption_unittests\": \"328fbb00725998dcdfddf416eefede53c812b177\", \"skia_unittests\": \"b24643a023618221fe1d8b0cd40537775af0ac84\", \"snapshot_unittests\": \"19b23c19c57227c099259b5c3938782ef50b0534\", \"sql_unittests\": \"3f8e8a0c9a3d4c4e6607d98c2c3fe02c442cbeca\", \"storage_unittests\": \"4e3434fc650f0a09b104fcf2e9c87dbbef6a2f15\", \"sync_integration_tests\": \"81245a550121da28b1f2d0c5e6d76cfba5e6f946\", \"traffic_annotation_auditor_unittests\": \"6ce94ad97f1b75fdf0e45be31df565f3cd49a52c\", \"ui_base_unittests\": \"c87ac15928de38719dc4f0b6f97bb30879bef658\", \"ui_chromeos_unittests\": \"7dee98b44a85fa314bc5a147e39b3dea5d0e89d3\", \"ui_touch_selection_unittests\": \"7f57b6f3f9f1879e9776b72d07c85ca8aa0a53ef\", \"unit_tests\": \"8cc5c5477dcb8919ba8721aa8261a7d2312f1c37\", \"url_unittests\": \"d99ea02081d1606968576b43bc83088b8bdd2b88\", \"usage_time_limit_unittests\": \"ea01c826db081b342345f8fb2680c094e2cc20ba\", \"views_unittests\": \"16432870c693961abd4b827da02c3b12db880987\", \"viz_unittests\": \"42da564c8db8784a22fed8401f22367661b4eacd\", \"wayland_client_perftests\": \"30bf3c7c124341681ce0e5416da4a036d36a8eba\", \"wm_unittests\": \"99a48c8f2c2f05180febd5ed839e09bc2f02ad7a\", \"wtf_unittests\": \"5b413448ee6011497efb51e4e33f363ff94ffc0c\", \"zlib_unittests\": \"43f3c91e914694611d90c229f43777f3a28bfdcc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3ee79eab7726d87d4f9bf92f4b58b9506b0a7a0d17f466f0c3d67bd50a4697d1_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9a735a3fee4d607751977496b4455c795aec36ba7fa141f862fdf473488122eb_v2\", \"builder_abe2adbd32ad911c3e8d1f384e915329cf1f65e427edb6b91a9fbb61a55ed743_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_fe96da9c6a19fa2fc3ad0c2b7020b7cb68e4a92161f4cd6cb7dc1d1e2d5af5dc_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-mh2j\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612312376216737",
"status": "COMPLETED",
"status_changed_ts": "1612315717800584",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45095",
"builder:linux-chromeos-rel",
"buildset:commit/git/98caa68c71baa8226984b5354051683adc474550",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/98caa68c71baa8226984b5354051683adc474550",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021791821429032528",
"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/8856361759147064080/+/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:517e1e7996344210",
"user_agent:luci-scheduler"
],
"updated_ts": "1612315717822405",
"url": "https://ci.chromium.org/b/8856361759147064080",
"utcnow_ts": "1612315722164814"
}
}
[01:28:42.173] Invocation finished in 57m28.026700606s with status SUCCEEDED