[14:18:08.964] New invocation is queued and will start shortly
[14:18:10.257] Starting the invocation (attempt 1)
[14:18:10.314] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:18:10.315] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:18:10.315] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029531135655024768",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f230d9a5b13325d25206a08bfaed967fddb63659\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029531135655024768",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/f230d9a5b13325d25206a08bfaed967fddb63659",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f230d9a5b13325d25206a08bfaed967fddb63659",
"gitiles_ref:refs/heads/master"
]
}
[14:18:11.849] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604931490756276",
"id": "8864101073107101712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f230d9a5b13325d25206a08bfaed967fddb63659\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604931491665447",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42718",
"builder:linux-chromeos-rel",
"buildset:commit/git/f230d9a5b13325d25206a08bfaed967fddb63659",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f230d9a5b13325d25206a08bfaed967fddb63659",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029531135655024768",
"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/8864101073107101712/+/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": "1604931491665732",
"url": "https://ci.chromium.org/b/8864101073107101712",
"utcnow_ts": "1604931491810275"
}
}
[14:18:11.849] Task URL: https://ci.chromium.org/b/8864101073107101712
[14:18:11.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:2:0) after 1m0s
[14:18:13.533] Received PubSub notification, asking Buildbucket for the build status
[14:18:13.656] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:11.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:2:0)
[14:19:11.882] Timer tick, asking Buildbucket for the build status
[14:19:12.119] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:12.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:4:0) after 1m0s
[14:20:12.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:4:0)
[14:20:12.280] Timer tick, asking Buildbucket for the build status
[14:20:12.388] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:12.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:5:0) after 1m0s
[14:21:12.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:5:0)
[14:21:12.462] Timer tick, asking Buildbucket for the build status
[14:21:12.602] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:12.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:6:0) after 1m0s
[14:22:12.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:6:0)
[14:22:12.678] Timer tick, asking Buildbucket for the build status
[14:22:12.783] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:12.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:7:0) after 1m0s
[14:23:12.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:7:0)
[14:23:12.884] Timer tick, asking Buildbucket for the build status
[14:23:12.983] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:12.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:8:0) after 1m0s
[14:24:13.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:8:0)
[14:24:13.161] Timer tick, asking Buildbucket for the build status
[14:24:13.508] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:13.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:9:0) after 1m0s
[14:25:13.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:9:0)
[14:25:13.556] Timer tick, asking Buildbucket for the build status
[14:25:13.646] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:13.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:10:0) after 1m0s
[14:26:13.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:10:0)
[14:26:13.857] Timer tick, asking Buildbucket for the build status
[14:26:14.017] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:14.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:11:0) after 1m0s
[14:27:14.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:11:0)
[14:27:14.164] Timer tick, asking Buildbucket for the build status
[14:27:14.260] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:14.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:12:0) after 1m0s
[14:28:14.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:12:0)
[14:28:14.260] Timer tick, asking Buildbucket for the build status
[14:28:14.452] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:14.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:13:0) after 1m0s
[14:29:14.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:13:0)
[14:29:14.527] Timer tick, asking Buildbucket for the build status
[14:29:14.637] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:14.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:14:0) after 1m0s
[14:30:14.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:14:0)
[14:30:14.692] Timer tick, asking Buildbucket for the build status
[14:30:14.784] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:14.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:15:0) after 1m0s
[14:31:14.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:15:0)
[14:31:14.903] Timer tick, asking Buildbucket for the build status
[14:31:15.116] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:15.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:16:0) after 1m0s
[14:32:15.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:16:0)
[14:32:15.168] Timer tick, asking Buildbucket for the build status
[14:32:15.346] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:15.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:17:0) after 1m0s
[14:33:15.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:17:0)
[14:33:15.421] Timer tick, asking Buildbucket for the build status
[14:33:15.670] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:15.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:18:0) after 1m0s
[14:34:15.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:18:0)
[14:34:15.762] Timer tick, asking Buildbucket for the build status
[14:34:15.924] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:15.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:19:0) after 1m0s
[14:35:15.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:19:0)
[14:35:15.993] Timer tick, asking Buildbucket for the build status
[14:35:16.142] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:16.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:20:0) after 1m0s
[14:36:16.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:20:0)
[14:36:16.266] Timer tick, asking Buildbucket for the build status
[14:36:16.342] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:16.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:21:0) after 1m0s
[14:37:16.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:21:0)
[14:37:16.392] Timer tick, asking Buildbucket for the build status
[14:37:16.462] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:16.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:22:0) after 1m0s
[14:38:16.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:22:0)
[14:38:16.511] Timer tick, asking Buildbucket for the build status
[14:38:17.144] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:17.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:23:0) after 1m0s
[14:39:17.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:23:0)
[14:39:17.255] Timer tick, asking Buildbucket for the build status
[14:39:17.558] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:17.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:24:0) after 1m0s
[14:40:17.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:24:0)
[14:40:17.621] Timer tick, asking Buildbucket for the build status
[14:40:17.702] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:17.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:25:0) after 1m0s
[14:41:17.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:25:0)
[14:41:17.742] Timer tick, asking Buildbucket for the build status
[14:41:17.813] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:17.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:26:0) after 1m0s
[14:42:17.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:26:0)
[14:42:17.878] Timer tick, asking Buildbucket for the build status
[14:42:17.957] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:17.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:27:0) after 1m0s
[14:43:18.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:27:0)
[14:43:18.027] Timer tick, asking Buildbucket for the build status
[14:43:18.330] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:18.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:28:0) after 1m0s
[14:44:18.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:28:0)
[14:44:18.421] Timer tick, asking Buildbucket for the build status
[14:44:18.601] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:18.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:29:0) after 1m0s
[14:45:18.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:29:0)
[14:45:18.631] Timer tick, asking Buildbucket for the build status
[14:45:18.709] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:18.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:30:0) after 1m0s
[14:46:18.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:30:0)
[14:46:18.736] Timer tick, asking Buildbucket for the build status
[14:46:18.817] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:18.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:31:0) after 1m0s
[14:47:18.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:31:0)
[14:47:18.942] Timer tick, asking Buildbucket for the build status
[14:47:19.056] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:19.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:32:0) after 1m0s
[14:48:19.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:32:0)
[14:48:19.153] Timer tick, asking Buildbucket for the build status
[14:48:19.262] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:19.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:33:0) after 1m0s
[14:49:19.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:33:0)
[14:49:19.314] Timer tick, asking Buildbucket for the build status
[14:49:19.399] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:19.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:34:0) after 1m0s
[14:50:19.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:34:0)
[14:50:19.511] Timer tick, asking Buildbucket for the build status
[14:50:19.706] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:19.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:35:0) after 1m0s
[14:51:19.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:35:0)
[14:51:19.763] Timer tick, asking Buildbucket for the build status
[14:51:19.864] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:19.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:36:0) after 1m0s
[14:52:19.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:36:0)
[14:52:19.857] Timer tick, asking Buildbucket for the build status
[14:52:19.922] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:19.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:37:0) after 1m0s
[14:53:20.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:37:0)
[14:53:20.001] Timer tick, asking Buildbucket for the build status
[14:53:20.229] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:20.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:38:0) after 1m0s
[14:54:20.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:38:0)
[14:54:20.334] Timer tick, asking Buildbucket for the build status
[14:54:20.453] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:20.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:39:0) after 1m0s
[14:55:20.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:39:0)
[14:55:20.492] Timer tick, asking Buildbucket for the build status
[14:55:20.985] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:20.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:40:0) after 1m0s
[14:56:21.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:40:0)
[14:56:21.081] Timer tick, asking Buildbucket for the build status
[14:56:21.207] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:21.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:41:0) after 1m0s
[14:57:21.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:41:0)
[14:57:21.301] Timer tick, asking Buildbucket for the build status
[14:57:21.459] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:21.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:42:0) after 1m0s
[14:58:21.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:42:0)
[14:58:21.561] Timer tick, asking Buildbucket for the build status
[14:58:21.956] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:21.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:43:0) after 1m0s
[14:59:22.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:43:0)
[14:59:22.001] Timer tick, asking Buildbucket for the build status
[14:59:22.147] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:22.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:44:0) after 1m0s
[15:00:22.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:44:0)
[15:00:22.231] Timer tick, asking Buildbucket for the build status
[15:00:22.417] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:22.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:45:0) after 1m0s
[15:01:22.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:45:0)
[15:01:22.569] Timer tick, asking Buildbucket for the build status
[15:01:22.773] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:22.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:46:0) after 1m0s
[15:02:22.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:46:0)
[15:02:22.882] Timer tick, asking Buildbucket for the build status
[15:02:23.072] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:23.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:47:0) after 1m0s
[15:03:23.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:47:0)
[15:03:23.183] Timer tick, asking Buildbucket for the build status
[15:03:23.732] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:23.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:48:0) after 1m0s
[15:04:23.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:48:0)
[15:04:23.751] Timer tick, asking Buildbucket for the build status
[15:04:23.886] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:23.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:49:0) after 1m0s
[15:05:23.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:49:0)
[15:05:23.941] Timer tick, asking Buildbucket for the build status
[15:05:24.063] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:24.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:50:0) after 1m0s
[15:06:24.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:50:0)
[15:06:24.123] Timer tick, asking Buildbucket for the build status
[15:06:24.361] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:24.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:51:0) after 1m0s
[15:07:24.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:51:0)
[15:07:24.405] Timer tick, asking Buildbucket for the build status
[15:07:24.650] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:24.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:52:0) after 1m0s
[15:08:24.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:52:0)
[15:08:24.770] Timer tick, asking Buildbucket for the build status
[15:08:25.092] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:25.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:53:0) after 1m0s
[15:09:25.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:53:0)
[15:09:25.142] Timer tick, asking Buildbucket for the build status
[15:09:25.348] Build 8864101073107101712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:25.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029531135655024768:54:0) after 1m0s
[15:10:09.751] Received PubSub notification, asking Buildbucket for the build status
[15:10:09.830] Build 8864101073107101712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:10:09.830] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604934608670237",
"created_by": "project:chromium",
"created_ts": "1604931490756276",
"id": "8864101073107101712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f230d9a5b13325d25206a08bfaed967fddb63659\"}}",
"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\": \"f230d9a5b13325d25206a08bfaed967fddb63659\", \"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-east1-d-8-114-jw8n\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42718, \"got_angle_revision\": \"46f5f4386f7c7489a66884b9062287a7cb9798de\", \"got_dawn_revision\": \"3e17e33724b4d0b4c4fc1985340882e1f543e3a0\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"f230d9a5b13325d25206a08bfaed967fddb63659\", \"got_revision_cp\": \"refs/heads/master@{#825326}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"b01fdf67620796b3498f657b5ba71d34cfddccb1\", \"got_v8_revision_cp\": \"refs/heads/8.8.258@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f230d9a5b13325d25206a08bfaed967fddb63659\", \"swarm_hashes_refs/heads/master(at){#825326}_without_patch\": {\"absl_hardening_tests\": \"5cf8548fdf5883830b1823d60d8e32d0609e1000\", \"accessibility_unittests\": \"db69096d6728b2cc12f556e6798891cffc0b0674\", \"angle_unittests\": \"398e5bbf2fabb6f3b50d12a86c1b3aaf18b05861\", \"app_list_unittests\": \"48bea31a01107bc846039569eb23ded4f819fbeb\", \"app_shell_unittests\": \"775c1153343c32174560d982f9884df20774d4d9\", \"ash_unittests\": \"554ba91ccfc7da7d95aed6192c78b6224fc9e2f4\", \"aura_unittests\": \"e871c5f28829f590a3f2b70befee7769e19d7dca\", \"base_unittests\": \"558236ecefff56efc6db835f5d4b8baa456a64d6\", \"base_util_unittests\": \"fc88f4085b2ac870a6882ec27a38474d2784ae4d\", \"blink_common_unittests\": \"0a99db8aa8e7d0909c6a24c3d22ad414f6fef60b\", \"blink_fuzzer_unittests\": \"ebb0ce355f752cfc33f7a25885959543162bf858\", \"blink_heap_unittests\": \"37a410d42da87275331a1afe15b27720537868cd\", \"blink_platform_unittests\": \"b182933de2ac3f53e379bb43c93e5e2642b90838\", \"blink_unittests\": \"5720d1a665936c1e14d14b06303478a02a6ea966\", \"boringssl_crypto_tests\": \"e99bc3ef7cce01970d721ef22f7064aaa9ebeb29\", \"boringssl_ssl_tests\": \"5ad12f3267be23f5c172440092f6540b9d69e79f\", \"browser_tests\": \"e0fd8bff81cba575b51dac22d26ec463c51b5702\", \"capture_unittests\": \"ff71fee7704b13486068b27843128ebb91ae79c9\", \"cast_unittests\": \"74ec44376c2bb61d1dc41e8e284807174bb064e3\", \"cc_unittests\": \"4544b8f9ceb6a212182bff8061559b9500d8408e\", \"chrome_app_unittests\": \"bdb833367663a3dd75fd4b8351dd7ecee5a190de\", \"chromedriver_unittests\": \"1363d2b4ef8ac5a53f329ff198376b12fbf0068b\", \"chromeos_components_unittests\": \"f4842b9360e4548b090162c01114d1283e6d69d8\", \"chromeos_unittests\": \"01588bcf6b2570ff344a53f924eeeb8f3efa6101\", \"components_browsertests\": \"cd203f5884e1c23e0404614504e86eb9b190e567\", \"components_unittests\": \"5d9f92744c28c711257b39901604d8e9d8a59f1f\", \"compositor_unittests\": \"03d5f9897df315d67528872db70f6df07b64270d\", \"content_browsertests\": \"b3bf87a1d0dd9892f3468722645d205dd8905eb3\", \"content_unittests\": \"1de1e58d2c9ed798068181262292f612d3cd8d51\", \"crypto_unittests\": \"ec573648c50f3780cafb2b0a851b5668fc495668\", \"dbus_unittests\": \"fdb4032f6f6d5ef927c41e70d29fec5f1efabe24\", \"device_unittests\": \"5542a3a910f5e6f0794bf19cdbeb3fb64d4fe789\", \"display_unittests\": \"9030a00a696cfba91457a72c8938851bd4aa9229\", \"events_unittests\": \"e39a75e076d6789c58c054810b87e2c205b1bb7b\", \"exo_unittests\": \"b4c09a338abeee9d19501e4870a4f20405663401\", \"extensions_browsertests\": \"47ea24b859acb38e12e1bde69a83909841603cf9\", \"extensions_unittests\": \"35f0fe5c74392e67f7207dcd4faca28128e70e46\", \"filesystem_service_unittests\": \"789a5e12cd06139580816bc5b2207f1986c4c1dd\", \"gcm_unit_tests\": \"24cf5def0636f707bfb38799315350933eccfebb\", \"gfx_unittests\": \"799ad961badd300614d99c7c4ffd5110085392f3\", \"gin_unittests\": \"4b118d34da4bfe9b690e4dfe5828d58d3d91af09\", \"gl_unittests_ozone\": \"f60cc2521aee15eae92f38eca58a46aea20ba850\", \"google_apis_unittests\": \"0dd1fa66cee6b24aa279e266bd1d3c2a00c3eec4\", \"gpu_unittests\": \"ed3958342bfd4f41c1be2b9054ceca0aff0478cb\", \"gwp_asan_unittests\": \"b59c6e96a54857e9b3394d3da14848b87e6f0eaf\", \"interactive_ui_tests\": \"3832a677180ee1dfe7505f40641c03f243407414\", \"ipc_tests\": \"0463c9a0e153bf56c662323827a29f407074ce80\", \"jingle_unittests\": \"687b4fd7adcc7b9a0e882acb7f6943972428987a\", \"keyboard_unittests\": \"de4d9ab4eef7fc28e5535df352eaad7218bcf010\", \"latency_unittests\": \"bb53ee09e72648639149e989b51d22eca9132d01\", \"libjingle_xmpp_unittests\": \"c0b31692d067ce2b1670abee65724326652bc492\", \"liburlpattern_unittests\": \"ba6825c71aa24f0e29a7c19717f1f98ad45e73ad\", \"media_blink_unittests\": \"bc302b4c4ffb81d1980725a8907b3cd5bb2185e9\", \"media_unittests\": \"1adf794d26b828fcc27dfd3c05dea01e36d39dd4\", \"message_center_unittests\": \"636cbf7b91dbe825562d3eff50bb552abefbf09b\", \"midi_unittests\": \"3c4da349d4effa5f4c40f054faab57689c1c7e85\", \"mojo_core_unittests\": \"8d7d1b7d7ce3180f10a9b6517cb09ff70da98009\", \"mojo_unittests\": \"95b01b8cb18add568ff853877651c5b7417bfba4\", \"nacl_helper_nonsfi_unittests\": \"e3a04913b51809456f3311c0c424cfcfbf4d10cf\", \"nacl_loader_unittests\": \"0ada30003c6ab8426b4c8f8ad6a3f2789e3d8435\", \"native_theme_unittests\": \"f60cf9d75b67f21ad05d9363348f546e646d0ed6\", \"net_unittests\": \"8a15e901506326d0633bbe8e25d2ae0021561d17\", \"ozone_gl_unittests\": \"dc62a71155ae74778fe28404a916c2858c1e909a\", \"ozone_unittests\": \"7327bc89fd9977f552c80a30622f3e5eddaa72cc\", \"ozone_x11_unittests\": \"7ec17b0cd97b77df792b8bdbcd9446347d77ce69\", \"pdf_unittests\": \"e81b283cf444ca0d224e144d79a222464df243a1\", \"perfetto_unittests\": \"df6b79f0018c1f869788a199bf8ea1ed310fc787\", \"ppapi_unittests\": \"dd3c6d1ba4af92f64958869ccb0db8674c7266f9\", \"printing_unittests\": \"7392691dd256d4874d440e313f741a11d4260e32\", \"remoting_unittests\": \"d7a0dbd9683599db4be74b6f0ec9bea2944e3c37\", \"sandbox_linux_unittests\": \"c22e116ef96cc1f01e4d1f32ecf4f5c12a30af30\", \"service_manager_unittests\": \"5edeeb88accf8575bbd02ca21fbc48ee9c4ffd6d\", \"services_unittests\": \"ef65f74f844115c713abf37e4bb94fa28880c002\", \"shell_dialogs_unittests\": \"ddf1b6587a0f57e17fa6b2bfd5e17a1003c0f123\", \"skia_unittests\": \"56a4ad77b46add45ebb291ac86baa39dbb510131\", \"snapshot_unittests\": \"2a1edb164feb42f8e5302cbd683c4886261f0f14\", \"sql_unittests\": \"e93b1ea709eb5a5f28809f50c5c89a1a25721801\", \"storage_unittests\": \"9c4e477545df8a0df17cc9b0599d203fc5d0f060\", \"sync_integration_tests\": \"b633db87b0b78e49a0a942e894f5dd7e62def56b\", \"traffic_annotation_auditor_unittests\": \"30c2f08b06e8ab1447888f0f9b0267ef248704e2\", \"ui_base_unittests\": \"6f921e4e33d72ea6dd4209723fe9816d624a5583\", \"ui_chromeos_unittests\": \"fe4056b65bbf11687abe4b868d2bf66cdd5565db\", \"ui_touch_selection_unittests\": \"0d0807a9203354ae0dae5eb248e750221d101c44\", \"unit_tests\": \"5d906d14c5791f463565e66396599101fa97b461\", \"url_unittests\": \"47ab65cccc03001cd80555637d9bed0aee345ed9\", \"usage_time_limit_unittests\": \"b71068f713afe340c6a510c280ccf44968cef924\", \"views_unittests\": \"87c0ebddb16c461431ac6eeea49fc20a08e8dc07\", \"viz_unittests\": \"66cc546921935f2588b35c83e759ae98b08397b9\", \"wayland_client_perftests\": \"6127ad418d37e708fd572a5694d0fd460aab0caf\", \"wm_unittests\": \"439429dfe7a7dc76bfa35767ce0a3ecd9d726f9b\", \"wtf_unittests\": \"55f3a60a61ba677f9f468e7f50daee2595eb77ea\", \"zlib_unittests\": \"04dbf045a83ba96b5879a8c030db6289bdce2b35\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_510bb217f1fbd7cfc6f82b4f5538258f70582616cab4052bd10c7cd8994fe33a_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_d6e5378aee5938d080eb0dcdbd0211f3098981aa309245e37202498e30b4f23b_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-east1-d-8-114-jw8n\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604931492589131",
"status": "COMPLETED",
"status_changed_ts": "1604934609163876",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42718",
"builder:linux-chromeos-rel",
"buildset:commit/git/f230d9a5b13325d25206a08bfaed967fddb63659",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f230d9a5b13325d25206a08bfaed967fddb63659",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029531135655024768",
"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/8864101073107101712/+/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:4fc630a0c54cbb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604934609193931",
"url": "https://ci.chromium.org/b/8864101073107101712",
"utcnow_ts": "1604934609819048"
}
}
[15:10:09.830] Invocation finished in 52m0.886382036s with status SUCCEEDED