[22:47:26.365] New invocation is queued and will start shortly
[22:47:27.502] Starting the invocation (attempt 1)
[22:47:27.538] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:47:27.538] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:47:27.538] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021073576019263120",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"638f1974aa838f558af7ebc5cdc207fb876bea3c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9021073576019263120",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/638f1974aa838f558af7ebc5cdc207fb876bea3c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/638f1974aa838f558af7ebc5cdc207fb876bea3c",
"gitiles_ref:refs/heads/master"
]
}
[22:47:28.131] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612997247622494",
"id": "8855643514035712736",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"638f1974aa838f558af7ebc5cdc207fb876bea3c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612997247963362",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45310",
"builder:linux-chromeos-rel",
"buildset:commit/git/638f1974aa838f558af7ebc5cdc207fb876bea3c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/638f1974aa838f558af7ebc5cdc207fb876bea3c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021073576019263120",
"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/8855643514035712736/+/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": "1612997247963472",
"url": "https://ci.chromium.org/b/8855643514035712736",
"utcnow_ts": "1612997248123203"
}
}
[22:47:28.131] Task URL: https://ci.chromium.org/b/8855643514035712736
[22:47:28.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:2:0) after 1m0s
[22:47:29.985] Received PubSub notification, asking Buildbucket for the build status
[22:47:30.057] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:28.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:2:0)
[22:48:28.220] Timer tick, asking Buildbucket for the build status
[22:48:28.537] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:28.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:4:0) after 1m0s
[22:49:28.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:4:0)
[22:49:28.646] Timer tick, asking Buildbucket for the build status
[22:49:28.851] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:28.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:5:0) after 1m0s
[22:50:28.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:5:0)
[22:50:28.903] Timer tick, asking Buildbucket for the build status
[22:50:29.103] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:29.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:6:0) after 1m0s
[22:51:29.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:6:0)
[22:51:29.157] Timer tick, asking Buildbucket for the build status
[22:51:29.838] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:29.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:7:0) after 1m0s
[22:52:29.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:7:0)
[22:52:29.855] Timer tick, asking Buildbucket for the build status
[22:52:29.971] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:29.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:8:0) after 1m0s
[22:53:30.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:8:0)
[22:53:30.047] Timer tick, asking Buildbucket for the build status
[22:53:30.144] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:30.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:9:0) after 1m0s
[22:54:30.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:9:0)
[22:54:30.262] Timer tick, asking Buildbucket for the build status
[22:54:30.708] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:30.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:10:0) after 1m0s
[22:55:30.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:10:0)
[22:55:30.835] Timer tick, asking Buildbucket for the build status
[22:55:31.055] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:31.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:11:0) after 1m0s
[22:56:31.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:11:0)
[22:56:31.065] Timer tick, asking Buildbucket for the build status
[22:56:31.353] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:31.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:12:0) after 1m0s
[22:57:31.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:12:0)
[22:57:31.367] Timer tick, asking Buildbucket for the build status
[22:57:31.506] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:31.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:13:0) after 1m0s
[22:58:31.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:13:0)
[22:58:31.572] Timer tick, asking Buildbucket for the build status
[22:58:31.678] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:31.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:14:0) after 1m0s
[22:59:31.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:14:0)
[22:59:31.761] Timer tick, asking Buildbucket for the build status
[22:59:31.850] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:31.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:15:0) after 1m0s
[23:00:31.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:15:0)
[23:00:31.908] Timer tick, asking Buildbucket for the build status
[23:00:32.110] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:32.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:16:0) after 1m0s
[23:01:32.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:16:0)
[23:01:32.160] Timer tick, asking Buildbucket for the build status
[23:01:32.437] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:32.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:17:0) after 1m0s
[23:02:32.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:17:0)
[23:02:32.467] Timer tick, asking Buildbucket for the build status
[23:02:32.558] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:32.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:18:0) after 1m0s
[23:03:32.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:18:0)
[23:03:32.632] Timer tick, asking Buildbucket for the build status
[23:03:32.718] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:32.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:19:0) after 1m0s
[23:04:32.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:19:0)
[23:04:32.743] Timer tick, asking Buildbucket for the build status
[23:04:33.072] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:33.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:20:0) after 1m0s
[23:05:33.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:20:0)
[23:05:33.118] Timer tick, asking Buildbucket for the build status
[23:05:33.226] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:33.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:21:0) after 1m0s
[23:06:33.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:21:0)
[23:06:33.327] Timer tick, asking Buildbucket for the build status
[23:06:34.005] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:34.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:22:0) after 1m0s
[23:07:34.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:22:0)
[23:07:34.086] Timer tick, asking Buildbucket for the build status
[23:07:34.414] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:34.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:23:0) after 1m0s
[23:08:34.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:23:0)
[23:08:34.490] Timer tick, asking Buildbucket for the build status
[23:08:34.840] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:34.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:24:0) after 1m0s
[23:09:34.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:24:0)
[23:09:34.958] Timer tick, asking Buildbucket for the build status
[23:09:35.146] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:35.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:25:0) after 1m0s
[23:10:35.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:25:0)
[23:10:35.297] Timer tick, asking Buildbucket for the build status
[23:10:35.531] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:35.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:26:0) after 1m0s
[23:11:35.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:26:0)
[23:11:35.527] Timer tick, asking Buildbucket for the build status
[23:11:35.614] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:35.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:27:0) after 1m0s
[23:12:35.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:27:0)
[23:12:35.761] Timer tick, asking Buildbucket for the build status
[23:12:36.018] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:36.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:28:0) after 1m0s
[23:13:36.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:28:0)
[23:13:36.275] Timer tick, asking Buildbucket for the build status
[23:13:36.354] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:36.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:29:0) after 1m0s
[23:14:36.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:29:0)
[23:14:36.521] Timer tick, asking Buildbucket for the build status
[23:14:36.622] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:36.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:30:0) after 1m0s
[23:15:36.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:30:0)
[23:15:36.896] Timer tick, asking Buildbucket for the build status
[23:15:36.973] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:36.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:31:0) after 1m0s
[23:16:37.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:31:0)
[23:16:37.127] Timer tick, asking Buildbucket for the build status
[23:16:37.232] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:37.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:32:0) after 1m0s
[23:17:37.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:32:0)
[23:17:37.346] Timer tick, asking Buildbucket for the build status
[23:17:37.451] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:37.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:33:0) after 1m0s
[23:18:37.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:33:0)
[23:18:37.586] Timer tick, asking Buildbucket for the build status
[23:18:37.680] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:37.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:34:0) after 1m0s
[23:19:37.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:34:0)
[23:19:37.822] Timer tick, asking Buildbucket for the build status
[23:19:37.897] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:37.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:35:0) after 1m0s
[23:20:37.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:35:0)
[23:20:37.930] Timer tick, asking Buildbucket for the build status
[23:20:38.148] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:38.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:36:0) after 1m0s
[23:21:38.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:36:0)
[23:21:38.231] Timer tick, asking Buildbucket for the build status
[23:21:38.314] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:38.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:37:0) after 1m0s
[23:22:38.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:37:0)
[23:22:38.337] Timer tick, asking Buildbucket for the build status
[23:22:38.431] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:38.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:38:0) after 1m0s
[23:23:38.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:38:0)
[23:23:38.584] Timer tick, asking Buildbucket for the build status
[23:23:38.664] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:38.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:39:0) after 1m0s
[23:24:38.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:39:0)
[23:24:38.888] Timer tick, asking Buildbucket for the build status
[23:24:38.963] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:38.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:40:0) after 1m0s
[23:25:39.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:40:0)
[23:25:39.035] Timer tick, asking Buildbucket for the build status
[23:25:39.121] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:39.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:41:0) after 1m0s
[23:26:39.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:41:0)
[23:26:39.287] Timer tick, asking Buildbucket for the build status
[23:26:39.388] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:39.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:42:0) after 1m0s
[23:27:39.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:42:0)
[23:27:39.366] Timer tick, asking Buildbucket for the build status
[23:27:39.474] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:39.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:43:0) after 1m0s
[23:28:39.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:43:0)
[23:28:39.688] Timer tick, asking Buildbucket for the build status
[23:28:39.823] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:39.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:44:0) after 1m0s
[23:29:39.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:44:0)
[23:29:39.920] Timer tick, asking Buildbucket for the build status
[23:29:40.065] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:40.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:45:0) after 1m0s
[23:30:41.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:45:0)
[23:30:41.657] Timer tick, asking Buildbucket for the build status
[23:30:41.779] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:41.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:46:0) after 1m0s
[23:31:41.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:46:0)
[23:31:41.818] Timer tick, asking Buildbucket for the build status
[23:31:41.885] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:41.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:47:0) after 1m0s
[23:32:41.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:47:0)
[23:32:41.933] Timer tick, asking Buildbucket for the build status
[23:32:42.026] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:42.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:48:0) after 1m0s
[23:33:42.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:48:0)
[23:33:42.079] Timer tick, asking Buildbucket for the build status
[23:33:42.166] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:42.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:49:0) after 1m0s
[23:34:42.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:49:0)
[23:34:42.180] Timer tick, asking Buildbucket for the build status
[23:34:42.526] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:42.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:50:0) after 1m0s
[23:35:42.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:50:0)
[23:35:42.671] Timer tick, asking Buildbucket for the build status
[23:35:42.767] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:42.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:51:0) after 1m0s
[23:36:42.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:51:0)
[23:36:42.850] Timer tick, asking Buildbucket for the build status
[23:36:42.974] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:42.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:52:0) after 1m0s
[23:37:42.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:52:0)
[23:37:42.982] Timer tick, asking Buildbucket for the build status
[23:37:43.083] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:43.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:53:0) after 1m0s
[23:38:43.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:53:0)
[23:38:43.176] Timer tick, asking Buildbucket for the build status
[23:38:43.703] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:43.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:54:0) after 1m0s
[23:39:43.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:54:0)
[23:39:43.736] Timer tick, asking Buildbucket for the build status
[23:39:43.842] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:43.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:55:0) after 1m0s
[23:40:43.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:55:0)
[23:40:43.891] Timer tick, asking Buildbucket for the build status
[23:40:43.976] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:43.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:56:0) after 1m0s
[23:41:43.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:56:0)
[23:41:43.964] Timer tick, asking Buildbucket for the build status
[23:41:44.313] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:44.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:57:0) after 1m0s
[23:42:44.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:57:0)
[23:42:44.427] Timer tick, asking Buildbucket for the build status
[23:42:44.564] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:44.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:58:0) after 1m0s
[23:43:44.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:58:0)
[23:43:44.688] Timer tick, asking Buildbucket for the build status
[23:43:44.822] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:44.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:59:0) after 1m0s
[23:44:44.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:59:0)
[23:44:44.892] Timer tick, asking Buildbucket for the build status
[23:44:45.544] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:45.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:60:0) after 1m0s
[23:45:45.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:60:0)
[23:45:45.719] Timer tick, asking Buildbucket for the build status
[23:45:45.999] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:45.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:61:0) after 1m0s
[23:46:46.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:61:0)
[23:46:46.038] Timer tick, asking Buildbucket for the build status
[23:46:46.248] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:46.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:62:0) after 1m0s
[23:47:46.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:62:0)
[23:47:46.299] Timer tick, asking Buildbucket for the build status
[23:47:47.490] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:47.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:63:0) after 1m0s
[23:48:47.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:63:0)
[23:48:47.534] Timer tick, asking Buildbucket for the build status
[23:48:47.624] Build 8855643514035712736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:47.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021073576019263120:64:0) after 1m0s
[23:49:25.439] Received PubSub notification, asking Buildbucket for the build status
[23:49:31.898] Build 8855643514035712736: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[23:49:31.898] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613000964861138",
"created_by": "project:chromium",
"created_ts": "1612997247622494",
"failure_reason": "BUILD_FAILURE",
"id": "8855643514035712736",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"638f1974aa838f558af7ebc5cdc207fb876bea3c\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**ash_unittests** failed because of:\\n\\n- LayerUtilTest.CopyContentToExistingLayer\"}, \"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\": \"638f1974aa838f558af7ebc5cdc207fb876bea3c\", \"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-162-831p\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45310, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e0a588752c827daef74960bbc80d7f5c4f73c4dd\", \"got_nacl_revision\": \"4de55da44c4b511989359381e8b7a88a01fe0634\", \"got_revision\": \"638f1974aa838f558af7ebc5cdc207fb876bea3c\", \"got_revision_cp\": \"refs/heads/master@{#852850}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"673a7fe5c3ff6686c98951cafb24a93ca5bd1303\", \"got_v8_revision\": \"cf9b85e768229a798eec3d84233fef71de9ec7d8\", \"got_v8_revision_cp\": \"refs/heads/9.0.160@{#1}\", \"got_webrtc_revision\": \"7bad75b3906ae78b67b2a8cec095d877deb58215\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33214}\", \"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\": \"638f1974aa838f558af7ebc5cdc207fb876bea3c\", \"swarm_hashes_refs/heads/master(at){#852850}_without_patch\": {\"absl_hardening_tests\": \"2365a806f5837b1ab3ffce9e598584d8ea5e0fdc\", \"accessibility_unittests\": \"5736608785363f31f5c6edf4ad9c7e6cb2b04cae\", \"angle_unittests\": \"529c1f4abb7818885ff23b56ef27f33eefc50792\", \"app_list_unittests\": \"7927ffda2e40fc3c82b7ee7f99e984edb79af659\", \"app_shell_unittests\": \"205705882fc341ae043370cb11a7986e68c1cf9a\", \"ash_unittests\": \"426b30ed127bed715471068cfa1cb2163aa870de\", \"aura_unittests\": \"4fcade1b5d66c34936bedda7938066ff8f90f10f\", \"base_unittests\": \"82d6aa131e57f4acb1f2a70a792ae5f61695f7ed\", \"base_util_unittests\": \"4032d6acae201b4fb0b2e8101fe8969749357ff9\", \"blink_common_unittests\": \"2be6224f6a3b35fa0cc3e28fc42be5e2a2c19951\", \"blink_fuzzer_unittests\": \"c1b9762a17f8d884234d6210e1c3040b6029d103\", \"blink_heap_unittests\": \"cac596f8c2a92ac482340125230b5c99441e5277\", \"blink_platform_unittests\": \"e9f44bea76d869055c69d19494459557af27861f\", \"blink_unittests\": \"dbec40e7536254304d1d1ad815ec0d62967b61ae\", \"boringssl_crypto_tests\": \"b88a3f47e47bca6f77a99bdeb1a4bf84120917ff\", \"boringssl_ssl_tests\": \"7954b48fac06ed29b1faa64dc2e1e42f4aae054b\", \"browser_tests\": \"082f8974442847dddb42a3ea53b906946a9107f9\", \"capture_unittests\": \"2ec0627f319e93715b94e584e04e06758555ff47\", \"cast_unittests\": \"d1ff1769d26ed49a1032813f1bde5ff7784b0d84\", \"cc_unittests\": \"8fd45c1dac1929ec6b22e9f3b04b181921ee3bc7\", \"chrome_app_unittests\": \"83571e44af449d0bedf14b25cf609919eaaab36b\", \"chromedriver_unittests\": \"9187e04ba900d491df423cb74ed5865facf98331\", \"chromeos_components_unittests\": \"17af5bf9b6b3d2afe2742e15aa7ce304d7c334d2\", \"chromeos_unittests\": \"74b8ab3b8304e5cd4fe00b50b50dd386f86a16b7\", \"components_browsertests\": \"7081bb5e1355bc14b7c78516302d6178fa8e3fa0\", \"components_unittests\": \"1839d2b056ba2abe93c70f640374183bd0ff89ef\", \"compositor_unittests\": \"b51792bd18c0b6c730a472e8cd48c4b2fef34ec5\", \"content_browsertests\": \"1d7379618de0a335ebec7c14322df09b59647a9b\", \"content_unittests\": \"47904168eea5ad1760a6477f68c394fd3e90c608\", \"crashpad_tests\": \"f67e19bfecb44d48711a673d99772ebea2a9c565\", \"crypto_unittests\": \"fc43206fdce0d5973a68a0440e423de3e652f227\", \"dbus_unittests\": \"65d2492628e8944e2203e79599a09fbeaf4afef1\", \"device_unittests\": \"05bfeec97ac0a1818aa083211d0b90e352f350e6\", \"display_unittests\": \"01da10f65e514b073f2ea3ed75c31cc2c033f93c\", \"events_unittests\": \"8f77921ad1cd142e97e3366f9d443bfe4b9e4226\", \"exo_unittests\": \"fd8127936d65e86bc282101f6b803133469e80ee\", \"extensions_browsertests\": \"55ca57d944485f2521315b0f3978a4e223b991de\", \"extensions_unittests\": \"a86b20fafc1ecad7b7447cb3a9d3b0fa8ffacf52\", \"filesystem_service_unittests\": \"07897aa68a730993184a5e21b3c689d2e08a6a4a\", \"gcm_unit_tests\": \"3b9382aa961c791b7c7e766c6d503caf122fd862\", \"gfx_unittests\": \"95f005adbf1c84273374d4bd4820de32b1019e00\", \"gin_unittests\": \"2bf40c1be9e86e4d59141e9c348ce4044a243fd7\", \"gl_unittests_ozone\": \"01e50722b22c62e02a70ce71584fcc0863b4fa6f\", \"google_apis_unittests\": \"d3a99b992092bb83382a4bb2323e8091ac66aa64\", \"gpu_unittests\": \"b0970200acdb0e8f29e2514049a22fa19c9e34d5\", \"gwp_asan_unittests\": \"295548b9932aa9a462babcd96daeb3b891f9eee5\", \"interactive_ui_tests\": \"9ab10a78d06a63a01fcfe1315377c3efa8d6c37b\", \"ipc_tests\": \"3eff8dcf15e6982f853777c035306c3f7a8d8956\", \"jingle_unittests\": \"ae07dcb12cf614cec017781e6af743bd6f24f9f5\", \"keyboard_unittests\": \"0facd1c7201e208624030fef88a605a3ca68144c\", \"latency_unittests\": \"7920398e6e561e373dd71e26b054537b35dec227\", \"libjingle_xmpp_unittests\": \"b27c501999d16366998156bb882395cd0b8ae4ed\", \"liburlpattern_unittests\": \"fe7ddafc20ef5ffafd83dc47c6d8bd912ce995cf\", \"media_blink_unittests\": \"fb673a1899e269f4f548f124f9f952592e8b67e0\", \"media_unittests\": \"c03f22758adb1b2183827ceb8a7b7cbfbcc999d3\", \"message_center_unittests\": \"e806cae93396067b71263f89000275927a7a1388\", \"midi_unittests\": \"e74acc08e089ab0c74e5fae6caf9ca258e0dd234\", \"mojo_core_unittests\": \"5b40924b912379c61ad52041b111a896d67df55d\", \"mojo_unittests\": \"3a5f26f5daeecc06cbd8f9e8ee83d42f40cc1ad7\", \"nacl_helper_nonsfi_unittests\": \"0d8230035852597228130c586f020e324688c902\", \"nacl_loader_unittests\": \"4baa22b00f2ee04c40950607ddf533b8507dd824\", \"native_theme_unittests\": \"913ac33d47a6e5da81c46160eea14dc3abe9150c\", \"net_unittests\": \"0a70184d8e40c2abea2ad560f5842fcff3aead96\", \"ozone_gl_unittests\": \"66aa6c8f18d3e20d8bfdc1969d79e4e7fa5aa23f\", \"ozone_unittests\": \"524ca1d723500d190f12ae489cc0bc71682e546b\", \"ozone_x11_unittests\": \"0ceed5fd942a84b12bb95f525392bfc00cc187f3\", \"pdf_unittests\": \"4373dd784187ab8b64e7780bdd903639f8afa353\", \"perfetto_unittests\": \"dd3355ff0cf887330df021c8be07c27c5f421f44\", \"ppapi_unittests\": \"9b1d818c3cc8d35a45f085c0bfe7324ac1bc451f\", \"printing_unittests\": \"37e65bed49363507b57e20cf40e5c0cdebf2256c\", \"remoting_unittests\": \"f52dbec234c73ad882da295cba37598344461d1e\", \"sandbox_linux_unittests\": \"f493b1cef17d45941331f33d386bc8b3077425c2\", \"service_manager_unittests\": \"b0aa85bda17d89fee07bd008a1cb09c56432e75b\", \"services_unittests\": \"524fa2801d7159a8c0f645c35cc3131adab41c9f\", \"shell_dialogs_unittests\": \"2a49d6852dc28825633e9ba43e7ad4cca5c98eaa\", \"shell_encryption_unittests\": \"99ac8b7f406c05391bee52933aa91dd637cca326\", \"skia_unittests\": \"727b2a3f8839d2df9b378110e24b026e304acc3b\", \"snapshot_unittests\": \"915ab3badef02e2f84d2d24d0dd72741e3469240\", \"sql_unittests\": \"a94232e9a282c1756020c1f0d16189bd0e03776c\", \"storage_unittests\": \"da9ffb4425a2d3dec6a6bcae72d8c23c1aa29d3c\", \"sync_integration_tests\": \"61e1c1d39539928996a80b9ddd4a27e2875a63b1\", \"traffic_annotation_auditor_unittests\": \"4cab6181210b4cab5480dd2fa44f8c8ef925d268\", \"ui_base_unittests\": \"b08c19493f93bf4e3bf68ac303e4a91ab9b28072\", \"ui_chromeos_unittests\": \"74cfc823c5ee027dd4037cfea3932d77fad0d703\", \"ui_touch_selection_unittests\": \"cc3c7c2ed6a33468f8fdafae98cf509c4fded89c\", \"unit_tests\": \"f21249b6312914bd8d6a0475146cf16471ff2726\", \"url_unittests\": \"3a94f695b98d6d21251dde5f2ec48d5b5422e5ea\", \"usage_time_limit_unittests\": \"1d338f26b772e566652e75f6607231c18e455786\", \"views_unittests\": \"21cb6a62efcc998cd510ead30174e85d2c460c40\", \"viz_unittests\": \"429ad37e100b60287881435ad81eaa15bb6e1d6f\", \"wayland_client_perftests\": \"6dd579bc12699deb30236c2014d4092c8a484114\", \"wm_unittests\": \"14a294ac5da297c7dcf734f584dd5ac13073e0e7\", \"wtf_unittests\": \"79e33bad900305236bd2c9e546f1428c4ef35afe\", \"zlib_unittests\": \"06e79c697b1217abcdbef546dc4647f246fe362c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_678d8b556ed6d2ea4aa43b80debb7b547a1d6d4433ddff28e80ab170912c760d_v2\", \"builder_6ab0eeab06ceac077c4f5e67fdebd04a4013e6231a211afb401025a2c2ae11ff_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_v2\", \"builder_bcc6b3e5c0858529730294da730af8ea17f2c5c79b8b0dc7af4e722a8412ac73_v2\", \"builder_d7cc7c59327c05146a034898ae78722818cd22c61c9435c4c4348e98bea5a132_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-162-831p\"], \"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\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**ash_unittests** failed because of:\\n\\n- LayerUtilTest.CopyContentToExistingLayer\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612997249333828",
"status": "COMPLETED",
"status_changed_ts": "1612997249725988",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45310",
"builder:linux-chromeos-rel",
"buildset:commit/git/638f1974aa838f558af7ebc5cdc207fb876bea3c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/638f1974aa838f558af7ebc5cdc207fb876bea3c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021073576019263120",
"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/8855643514035712736/+/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:51a6f24d7e575010",
"user_agent:luci-scheduler"
],
"updated_ts": "1613000965260065",
"url": "https://ci.chromium.org/b/8855643514035712736",
"utcnow_ts": "1613000965954921"
}
}
[23:49:31.899] Invocation finished in 1h2m5.552856477s with status FAILED