[21:50:36.438] New invocation is queued and will start shortly
[21:50:37.614] Starting the invocation (attempt 1)
[21:50:37.665] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:50:37.665] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:50:37.665] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026694163505058752",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5e0d4018c5f9b741c45cc4cc7bb4c23bd64a3eba\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9026694163505058752",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/5e0d4018c5f9b741c45cc4cc7bb4c23bd64a3eba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5e0d4018c5f9b741c45cc4cc7bb4c23bd64a3eba",
"gitiles_ref:refs/heads/master"
]
}
[21:50:38.615] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607637037812721",
"id": "8861264101397348992",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5e0d4018c5f9b741c45cc4cc7bb4c23bd64a3eba\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607637038304323",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43620",
"builder:linux-chromeos-rel",
"buildset:commit/git/5e0d4018c5f9b741c45cc4cc7bb4c23bd64a3eba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5e0d4018c5f9b741c45cc4cc7bb4c23bd64a3eba",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026694163505058752",
"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/8861264101397348992/+/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": "1607637038304452",
"url": "https://ci.chromium.org/b/8861264101397348992",
"utcnow_ts": "1607637038608228"
}
}
[21:50:38.615] Task URL: https://ci.chromium.org/b/8861264101397348992
[21:50:38.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:2:0) after 1m0s
[21:51:38.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:2:0)
[21:51:38.728] Timer tick, asking Buildbucket for the build status
[21:51:38.822] Build 8861264101397348992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:51:38.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:3:0) after 1m0s
[21:52:02.185] Received PubSub notification, asking Buildbucket for the build status
[21:52:02.464] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:38.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:3:0)
[21:52:38.952] Timer tick, asking Buildbucket for the build status
[21:52:39.134] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:39.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:5:0) after 1m0s
[21:53:39.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:5:0)
[21:53:39.176] Timer tick, asking Buildbucket for the build status
[21:53:39.278] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:39.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:6:0) after 1m0s
[21:54:39.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:6:0)
[21:54:39.319] Timer tick, asking Buildbucket for the build status
[21:54:40.121] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:40.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:7:0) after 1m0s
[21:55:40.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:7:0)
[21:55:40.188] Timer tick, asking Buildbucket for the build status
[21:55:40.715] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:40.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:8:0) after 1m0s
[21:56:40.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:8:0)
[21:56:40.784] Timer tick, asking Buildbucket for the build status
[21:56:40.911] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:40.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:9:0) after 1m0s
[21:57:41.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:9:0)
[21:57:41.034] Timer tick, asking Buildbucket for the build status
[21:57:41.170] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:41.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:10:0) after 1m0s
[21:58:41.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:10:0)
[21:58:41.283] Timer tick, asking Buildbucket for the build status
[21:58:41.385] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:41.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:11:0) after 1m0s
[21:59:41.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:11:0)
[21:59:41.467] Timer tick, asking Buildbucket for the build status
[21:59:41.647] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:41.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:12:0) after 1m0s
[22:00:41.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:12:0)
[22:00:41.706] Timer tick, asking Buildbucket for the build status
[22:00:42.148] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:42.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:13:0) after 1m0s
[22:01:42.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:13:0)
[22:01:42.147] Timer tick, asking Buildbucket for the build status
[22:01:42.241] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:42.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:14:0) after 1m0s
[22:02:42.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:14:0)
[22:02:42.290] Timer tick, asking Buildbucket for the build status
[22:02:42.359] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:42.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:15:0) after 1m0s
[22:03:42.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:15:0)
[22:03:42.416] Timer tick, asking Buildbucket for the build status
[22:03:42.550] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:42.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:16:0) after 1m0s
[22:04:42.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:16:0)
[22:04:42.586] Timer tick, asking Buildbucket for the build status
[22:04:42.844] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:42.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:17:0) after 1m0s
[22:05:42.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:17:0)
[22:05:42.941] Timer tick, asking Buildbucket for the build status
[22:05:43.144] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:43.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:18:0) after 1m0s
[22:06:43.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:18:0)
[22:06:43.236] Timer tick, asking Buildbucket for the build status
[22:06:43.316] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:43.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:19:0) after 1m0s
[22:07:43.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:19:0)
[22:07:43.406] Timer tick, asking Buildbucket for the build status
[22:07:43.516] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:43.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:20:0) after 1m0s
[22:08:43.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:20:0)
[22:08:43.599] Timer tick, asking Buildbucket for the build status
[22:08:43.687] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:43.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:21:0) after 1m0s
[22:09:43.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:21:0)
[22:09:43.766] Timer tick, asking Buildbucket for the build status
[22:09:43.847] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:43.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:22:0) after 1m0s
[22:10:43.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:22:0)
[22:10:43.822] Timer tick, asking Buildbucket for the build status
[22:10:44.120] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:44.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:23:0) after 1m0s
[22:11:44.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:23:0)
[22:11:44.114] Timer tick, asking Buildbucket for the build status
[22:11:44.177] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:44.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:24:0) after 1m0s
[22:12:44.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:24:0)
[22:12:44.203] Timer tick, asking Buildbucket for the build status
[22:12:44.355] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:44.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:25:0) after 1m0s
[22:13:44.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:25:0)
[22:13:44.416] Timer tick, asking Buildbucket for the build status
[22:13:44.498] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:44.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:26:0) after 1m0s
[22:14:44.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:26:0)
[22:14:44.545] Timer tick, asking Buildbucket for the build status
[22:14:44.873] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:44.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:27:0) after 1m0s
[22:15:45.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:27:0)
[22:15:45.458] Timer tick, asking Buildbucket for the build status
[22:15:45.584] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:45.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:28:0) after 1m0s
[22:16:45.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:28:0)
[22:16:45.644] Timer tick, asking Buildbucket for the build status
[22:16:45.708] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:45.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:29:0) after 1m0s
[22:17:45.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:29:0)
[22:17:45.945] Timer tick, asking Buildbucket for the build status
[22:17:46.037] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:46.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:30:0) after 1m0s
[22:18:46.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:30:0)
[22:18:46.163] Timer tick, asking Buildbucket for the build status
[22:18:46.251] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:46.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:31:0) after 1m0s
[22:19:46.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:31:0)
[22:19:46.345] Timer tick, asking Buildbucket for the build status
[22:19:46.425] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:46.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:32:0) after 1m0s
[22:20:46.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:32:0)
[22:20:46.595] Timer tick, asking Buildbucket for the build status
[22:20:46.772] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:46.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:33:0) after 1m0s
[22:21:46.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:33:0)
[22:21:46.839] Timer tick, asking Buildbucket for the build status
[22:21:46.900] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:46.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:34:0) after 1m0s
[22:22:46.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:34:0)
[22:22:46.983] Timer tick, asking Buildbucket for the build status
[22:22:47.287] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:47.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:35:0) after 1m0s
[22:23:47.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:35:0)
[22:23:47.416] Timer tick, asking Buildbucket for the build status
[22:23:47.524] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:47.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:36:0) after 1m0s
[22:24:47.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:36:0)
[22:24:47.589] Timer tick, asking Buildbucket for the build status
[22:24:47.667] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:47.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:37:0) after 1m0s
[22:25:47.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:37:0)
[22:25:47.758] Timer tick, asking Buildbucket for the build status
[22:25:47.864] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:47.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:38:0) after 1m0s
[22:26:48.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:38:0)
[22:26:48.104] Timer tick, asking Buildbucket for the build status
[22:26:48.187] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:48.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:39:0) after 1m0s
[22:27:48.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:39:0)
[22:27:48.353] Timer tick, asking Buildbucket for the build status
[22:27:48.482] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:48.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:40:0) after 1m0s
[22:28:48.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:40:0)
[22:28:48.571] Timer tick, asking Buildbucket for the build status
[22:28:48.727] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:48.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:41:0) after 1m0s
[22:29:48.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:41:0)
[22:29:48.751] Timer tick, asking Buildbucket for the build status
[22:29:48.848] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:48.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:42:0) after 1m0s
[22:30:48.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:42:0)
[22:30:48.963] Timer tick, asking Buildbucket for the build status
[22:30:49.155] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:49.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:43:0) after 1m0s
[22:31:49.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:43:0)
[22:31:49.222] Timer tick, asking Buildbucket for the build status
[22:31:49.597] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:49.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:44:0) after 1m0s
[22:32:49.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:44:0)
[22:32:49.811] Timer tick, asking Buildbucket for the build status
[22:32:49.965] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:49.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:45:0) after 1m0s
[22:33:50.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:45:0)
[22:33:50.173] Timer tick, asking Buildbucket for the build status
[22:33:50.482] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:50.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:46:0) after 1m0s
[22:34:50.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:46:0)
[22:34:50.842] Timer tick, asking Buildbucket for the build status
[22:34:50.958] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:50.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:47:0) after 1m0s
[22:35:51.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:47:0)
[22:35:51.115] Timer tick, asking Buildbucket for the build status
[22:35:51.293] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:51.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:48:0) after 1m0s
[22:36:51.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:48:0)
[22:36:51.406] Timer tick, asking Buildbucket for the build status
[22:36:51.824] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:51.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:49:0) after 1m0s
[22:37:52.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:49:0)
[22:37:52.300] Timer tick, asking Buildbucket for the build status
[22:37:52.468] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:52.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:50:0) after 1m0s
[22:38:52.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:50:0)
[22:38:52.509] Timer tick, asking Buildbucket for the build status
[22:38:52.627] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:52.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:51:0) after 1m0s
[22:39:52.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:51:0)
[22:39:52.757] Timer tick, asking Buildbucket for the build status
[22:39:53.160] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:53.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:52:0) after 1m0s
[22:40:53.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:52:0)
[22:40:53.147] Timer tick, asking Buildbucket for the build status
[22:40:53.274] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:53.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:53:0) after 1m0s
[22:41:53.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:53:0)
[22:41:53.403] Timer tick, asking Buildbucket for the build status
[22:41:53.539] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:53.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:54:0) after 1m0s
[22:42:53.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:54:0)
[22:42:53.612] Timer tick, asking Buildbucket for the build status
[22:42:53.740] Build 8861264101397348992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:53.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026694163505058752:55:0) after 1m0s
[22:43:15.924] Received PubSub notification, asking Buildbucket for the build status
[22:43:16.014] Build 8861264101397348992: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:43:16.014] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607640194012825",
"created_by": "project:chromium",
"created_ts": "1607637037812721",
"id": "8861264101397348992",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5e0d4018c5f9b741c45cc4cc7bb4c23bd64a3eba\"}}",
"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}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"5e0d4018c5f9b741c45cc4cc7bb4c23bd64a3eba\", \"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-107-ecpm\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43620, \"got_angle_revision\": \"108b759ef91bd51e76e3d9ca025fc27e4067fea8\", \"got_dawn_revision\": \"6bcd4aceef100810284d61bd9dad0e9bd05e4c92\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"5e0d4018c5f9b741c45cc4cc7bb4c23bd64a3eba\", \"got_revision_cp\": \"refs/heads/master@{#835834}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"35f077086ef34ae8d0cabfba346b602d08c49160\", \"got_v8_revision\": \"0937070d01bcf37e336b226612516ff2e86f7463\", \"got_v8_revision_cp\": \"refs/heads/8.9.130@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"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\": \"5e0d4018c5f9b741c45cc4cc7bb4c23bd64a3eba\", \"swarm_hashes_refs/heads/master(at){#835834}_without_patch\": {\"absl_hardening_tests\": \"9cf7298f267ff0cef91b9d2c84ef879821e3b23f\", \"accessibility_unittests\": \"f36fb1729459e54076b63718134ee34a7a8eaae1\", \"angle_unittests\": \"ae5e821fc912802604590580015ed07950013baf\", \"app_list_unittests\": \"f6cdc69470adb9d092434629af7b7515e9b911be\", \"app_shell_unittests\": \"d946d4c3583324d955fac5a5ff42dff0f53601ed\", \"ash_unittests\": \"4f5ba8b6274f75072dbe6606efdd1ddc61af69cf\", \"aura_unittests\": \"e05fe606f7350801dd5bc66b632330b46c92831b\", \"base_unittests\": \"9c8a912f21b9c90304461b34a07cd31cd65dddf6\", \"base_util_unittests\": \"c0590072833d08aac3ffac20806fcf5704f9bd82\", \"blink_common_unittests\": \"c0ae09c9d2c7dc7167af13ba463498ed7469ae5d\", \"blink_fuzzer_unittests\": \"e8928b73fd4400a91c9a94497123dddf2339133e\", \"blink_heap_unittests\": \"730b2260ff2bcac17a36204a8529ebea4c1d351f\", \"blink_platform_unittests\": \"1611dc93f82139e1cdee2f7d4ca16b1fbf7ab817\", \"blink_unittests\": \"5e3f42f8854075237cb0a144f5bfc8603f720b5e\", \"boringssl_crypto_tests\": \"ab0c6d25e4b471e300378c884f44d0ec5ace42ca\", \"boringssl_ssl_tests\": \"20dc66cec0ef68c6d15ea575bad2b432c8412971\", \"browser_tests\": \"b87652086a3f6b22c3f3a9e2e8f65b05fd920720\", \"capture_unittests\": \"1ce744729449148a0dfe95668254aa5ca482f6be\", \"cast_unittests\": \"7ea4222dc1bd18e10d3ce4d24fd1f2617e97b77b\", \"cc_unittests\": \"5023190dd7dde0f7daf1075680f6fa8639c5955d\", \"chrome_app_unittests\": \"82f362eb68c3de6b018ec364e3cd9e945cb97ff6\", \"chromedriver_unittests\": \"b164c68dfbd0c1cad30f74d27795bb60d847cda5\", \"chromeos_components_unittests\": \"5fcf1590693b39e3f91e9be0c56d08038ed0947d\", \"chromeos_unittests\": \"5ab72ef7d0e498abd7cf6eb1e06a60b5b84db8c0\", \"components_browsertests\": \"71aef548cae1402463d44a5bb1c36c1b95e6f53b\", \"components_unittests\": \"d44b24c6cf5c423e3afea4b011fdd438cb2af117\", \"compositor_unittests\": \"7fb2dc919dc85fb3aea12b19a1a3fbfbd9154d9e\", \"content_browsertests\": \"e4b1d2b9ff10fda225d305175b2df2f2694872d3\", \"content_unittests\": \"6755d1d7303d22aad7adfdbc59d2e27767ff3cd4\", \"crashpad_tests\": \"82e45e3d59adb10c9a24f6219f3f3307265f29ec\", \"crypto_unittests\": \"59f7560e7276fb9baeefc6a5e20b1bb1cf6b26a7\", \"dbus_unittests\": \"44db7e12450bc7b0170e2cf36d26c68f6f5a6ab4\", \"device_unittests\": \"da8a6f24ba860f4ae610d26f80000677d825caf7\", \"display_unittests\": \"e7fa56bb0e57204fb69c5f9fce794262bea861e7\", \"events_unittests\": \"a6af0b46cd1aac02b769fb40cb5899ab78c1a1e4\", \"exo_unittests\": \"299db9e982fdf704668c5e5af48d2a4053ee8c5a\", \"extensions_browsertests\": \"0a7d4c01f9feb7ba21f1077e530f9d1d4fc437e3\", \"extensions_unittests\": \"6af5a27750cc48e336ea86e7d1de834ba3bf0b55\", \"filesystem_service_unittests\": \"1f468405d789a6c31726ca63dbc60466049be9dc\", \"gcm_unit_tests\": \"e4663dd02b23a8b705a50382af38de6322b19302\", \"gfx_unittests\": \"ed072bcf47670cd0b0b142920d9ba39dd8180ee2\", \"gin_unittests\": \"c933bdc0cd50cbf4adacb1e5f439719535e1f26f\", \"gl_unittests_ozone\": \"370801ccd2370c309c00ce4fda51c62e72f5bafb\", \"google_apis_unittests\": \"e4f21b1dd9972184450e492099a7ce558550a3a7\", \"gpu_unittests\": \"0b551086a1cd4e28781ab8861b6d48a189d53543\", \"gwp_asan_unittests\": \"6c5dd203192eba84ef426d140056f0349642349d\", \"interactive_ui_tests\": \"92b743495bd53658e7cf59aad7160552a3846762\", \"ipc_tests\": \"bd6183461fe0c7080407004d6455968d9683aacb\", \"jingle_unittests\": \"6eb073be24c44a03d1744a5cc153fad6679afad7\", \"keyboard_unittests\": \"58de7e109c59f9911eea331c394ea67140c6f52a\", \"latency_unittests\": \"8e25bd659dcf5e227d30248b9d01ba0626b60550\", \"libjingle_xmpp_unittests\": \"e8055601c84bd5544296e12580464ecfe31b66f1\", \"liburlpattern_unittests\": \"d5a0d3fce9d3241306a95eed0b0b871bea256ecf\", \"media_blink_unittests\": \"3e13fde84b30b0844590c390b260f5cf3ed1b0ea\", \"media_unittests\": \"e90f8933125d1880183d9f24837b6fc972bb733e\", \"message_center_unittests\": \"74897947a3e555f9d575ccaf98fe372005f23a46\", \"midi_unittests\": \"d3fed22ea5b33cfeda9f2fdb4777c55d8566e0e3\", \"mojo_core_unittests\": \"b88c96e37018eb739dc8ac25d521c289eefd9f40\", \"mojo_unittests\": \"f3a58ccc0a623fa9e7f3eeac020f032835417c64\", \"nacl_helper_nonsfi_unittests\": \"d6fc364a01af34e76a641c167984275226abf1ce\", \"nacl_loader_unittests\": \"c7da47749c0fc49865e081cb5c5aeb6389295837\", \"native_theme_unittests\": \"58aebb62c1b2a8b5ff6414758c7dbddb443836f8\", \"net_unittests\": \"7a31503358584352670110a5a5987370447c41f4\", \"ozone_gl_unittests\": \"150f73d149375b5fd402938b63179f2ce0c6c07d\", \"ozone_unittests\": \"d9ab0d027a5dfc7000489deb91da5ca364910325\", \"ozone_x11_unittests\": \"90bb35fa470fab7ae70a371c1b8a857c6d927710\", \"pdf_unittests\": \"d68f14d6ef55e23923ee61f5ef3712c7e73342ab\", \"perfetto_unittests\": \"80d615383ecbb7737b434e2358d5353e3ef0ba99\", \"ppapi_unittests\": \"ede184e5c8b74c1e74d270a1879fb8a11e42e5e1\", \"printing_unittests\": \"c1d9ab1efbb2db047932d8f2872abb25bd645e15\", \"remoting_unittests\": \"89e641af875219724a2ce4631864ffb19d6bf03b\", \"sandbox_linux_unittests\": \"b3003b885919708777bc44d4701bb8e985b46471\", \"service_manager_unittests\": \"445a69bc9dead7797aefb9f65cbaa4a712362d08\", \"services_unittests\": \"543c12bc8f3352e387d3c870e024722966ca5643\", \"shell_dialogs_unittests\": \"0d0efb16d063c159d0ed855bccb020a18d0fb0c0\", \"shell_encryption_unittests\": \"28fdf4632394fa8044afb0370599ab828cdc0877\", \"skia_unittests\": \"a94715390a90e520f73446ae364df0830580c72b\", \"snapshot_unittests\": \"2404833cd191949d60f8d98cff73f455f0ad04ad\", \"sql_unittests\": \"f8fcfb807957230670ad0f18bd9fba602ebdeefc\", \"storage_unittests\": \"7972d65607d6eb9a26916f8a04834b6f9801f5f1\", \"sync_integration_tests\": \"e446315d81ef9dfb7b565e6b87691eb7d3ece9ab\", \"traffic_annotation_auditor_unittests\": \"687ef385cabe18885fdc83a33e8fc39acd280fac\", \"ui_base_unittests\": \"647c0e0747b25019062e102e69c4bbc3eeffa416\", \"ui_chromeos_unittests\": \"6688545757f45ea316f4d27d441f196c96fd7cf0\", \"ui_touch_selection_unittests\": \"cc935044849e2bb1cf768e68a48fae0730ea59a2\", \"unit_tests\": \"66a21a986ee330b0e579b2412f07d838aaf12bce\", \"url_unittests\": \"1d20bf3ad8a9c53e614b9466369f70f9030039a3\", \"usage_time_limit_unittests\": \"15f0518540f4c7c912cea5af6ac132f294e515d4\", \"views_unittests\": \"1a20b911d9629518fc77c42d6eee067fe2af6be9\", \"viz_unittests\": \"7e297a98e066da6868870b1cc587d16b85942b18\", \"wayland_client_perftests\": \"88c4f494f1afa09fd715cf51d6f8a7eda72bf454\", \"wm_unittests\": \"b0eb8e3a1650c4891ce1d6d562cdee3a655b1a17\", \"wtf_unittests\": \"74684598b4923a6a3498bc8ecc6822b0ee62677c\", \"zlib_unittests\": \"c53d60213e792b1b20e4ae6a73b797c724d5968e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9a735a3fee4d607751977496b4455c795aec36ba7fa141f862fdf473488122eb_v2\", \"builder_e7ad59aa200d68ebcc1a02549d22b636b3b4d989b688240b853e1dce9c0a2c9f_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-107-ecpm\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607637120686569",
"status": "COMPLETED",
"status_changed_ts": "1607640194481312",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43620",
"builder:linux-chromeos-rel",
"buildset:commit/git/5e0d4018c5f9b741c45cc4cc7bb4c23bd64a3eba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5e0d4018c5f9b741c45cc4cc7bb4c23bd64a3eba",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026694163505058752",
"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/8861264101397348992/+/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:506773fe7f26a810",
"user_agent:luci-scheduler"
],
"updated_ts": "1607640194560906",
"url": "https://ci.chromium.org/b/8861264101397348992",
"utcnow_ts": "1607640196003103"
}
}
[22:43:16.014] Invocation finished in 52m39.594987486s with status SUCCEEDED