[05:15:20.240] New invocation is queued and will start shortly
[05:15:21.337] Starting the invocation (attempt 1)
[05:15:21.377] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:15:21.377] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:15:21.377] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029293495534091408",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"05227c04d91944d17949612251f8a35b57e2719f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029293495534091408",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/05227c04d91944d17949612251f8a35b57e2719f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05227c04d91944d17949612251f8a35b57e2719f",
"gitiles_ref:refs/heads/master"
]
}
[05:15:21.966] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605158121474528",
"id": "8863863433575965472",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"05227c04d91944d17949612251f8a35b57e2719f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605158121840818",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42794",
"builder:linux-chromeos-rel",
"buildset:commit/git/05227c04d91944d17949612251f8a35b57e2719f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05227c04d91944d17949612251f8a35b57e2719f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029293495534091408",
"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/8863863433575965472/+/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": "1605158121840924",
"url": "https://ci.chromium.org/b/8863863433575965472",
"utcnow_ts": "1605158121957910"
}
}
[05:15:21.966] Task URL: https://ci.chromium.org/b/8863863433575965472
[05:15:21.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:2:0) after 1m0s
[05:15:25.834] Received PubSub notification, asking Buildbucket for the build status
[05:15:25.924] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:22.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:2:0)
[05:16:22.022] Timer tick, asking Buildbucket for the build status
[05:16:22.158] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:22.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:4:0) after 1m0s
[05:17:22.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:4:0)
[05:17:22.245] Timer tick, asking Buildbucket for the build status
[05:17:22.315] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:22.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:5:0) after 1m0s
[05:18:22.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:5:0)
[05:18:22.383] Timer tick, asking Buildbucket for the build status
[05:18:23.097] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:23.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:6:0) after 1m0s
[05:19:23.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:6:0)
[05:19:23.233] Timer tick, asking Buildbucket for the build status
[05:19:23.362] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:23.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:7:0) after 1m0s
[05:20:23.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:7:0)
[05:20:23.394] Timer tick, asking Buildbucket for the build status
[05:20:23.781] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:23.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:8:0) after 1m0s
[05:21:23.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:8:0)
[05:21:23.833] Timer tick, asking Buildbucket for the build status
[05:21:23.955] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:23.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:9:0) after 1m0s
[05:22:23.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:9:0)
[05:22:23.964] Timer tick, asking Buildbucket for the build status
[05:22:24.035] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:24.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:10:0) after 1m0s
[05:23:24.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:10:0)
[05:23:24.146] Timer tick, asking Buildbucket for the build status
[05:23:24.299] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:24.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:11:0) after 1m0s
[05:24:24.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:11:0)
[05:24:24.408] Timer tick, asking Buildbucket for the build status
[05:24:24.472] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:24.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:12:0) after 1m0s
[05:25:24.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:12:0)
[05:25:24.569] Timer tick, asking Buildbucket for the build status
[05:25:24.662] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:24.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:13:0) after 1m0s
[05:26:24.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:13:0)
[05:26:24.751] Timer tick, asking Buildbucket for the build status
[05:26:25.284] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:25.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:14:0) after 1m0s
[05:27:25.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:14:0)
[05:27:25.310] Timer tick, asking Buildbucket for the build status
[05:27:26.097] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:26.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:15:0) after 1m0s
[05:28:26.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:15:0)
[05:28:26.134] Timer tick, asking Buildbucket for the build status
[05:28:26.545] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:26.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:16:0) after 1m0s
[05:29:26.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:16:0)
[05:29:26.638] Timer tick, asking Buildbucket for the build status
[05:29:26.829] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:26.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:17:0) after 1m0s
[05:30:26.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:17:0)
[05:30:26.868] Timer tick, asking Buildbucket for the build status
[05:30:26.997] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:26.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:18:0) after 1m0s
[05:31:27.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:18:0)
[05:31:27.089] Timer tick, asking Buildbucket for the build status
[05:31:27.332] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:27.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:19:0) after 1m0s
[05:32:27.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:19:0)
[05:32:27.365] Timer tick, asking Buildbucket for the build status
[05:32:27.520] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:27.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:20:0) after 1m0s
[05:33:27.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:20:0)
[05:33:27.553] Timer tick, asking Buildbucket for the build status
[05:33:27.825] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:27.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:21:0) after 1m0s
[05:34:27.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:21:0)
[05:34:27.830] Timer tick, asking Buildbucket for the build status
[05:34:27.994] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:27.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:22:0) after 1m0s
[05:35:28.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:22:0)
[05:35:28.037] Timer tick, asking Buildbucket for the build status
[05:35:28.617] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:28.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:23:0) after 1m0s
[05:36:28.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:23:0)
[05:36:28.645] Timer tick, asking Buildbucket for the build status
[05:36:28.721] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:28.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:24:0) after 1m0s
[05:37:28.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:24:0)
[05:37:28.744] Timer tick, asking Buildbucket for the build status
[05:37:28.862] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:28.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:25:0) after 1m0s
[05:38:28.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:25:0)
[05:38:28.917] Timer tick, asking Buildbucket for the build status
[05:38:29.033] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:29.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:26:0) after 1m0s
[05:39:29.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:26:0)
[05:39:29.068] Timer tick, asking Buildbucket for the build status
[05:39:29.792] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:29.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:27:0) after 1m0s
[05:40:29.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:27:0)
[05:40:29.846] Timer tick, asking Buildbucket for the build status
[05:40:30.028] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:30.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:28:0) after 1m0s
[05:41:30.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:28:0)
[05:41:30.062] Timer tick, asking Buildbucket for the build status
[05:41:30.267] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:30.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:29:0) after 1m0s
[05:42:30.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:29:0)
[05:42:30.326] Timer tick, asking Buildbucket for the build status
[05:42:30.786] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:30.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:30:0) after 1m0s
[05:43:30.861] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:30:0)
[05:43:30.861] Timer tick, asking Buildbucket for the build status
[05:43:31.051] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:31.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:31:0) after 1m0s
[05:44:31.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:31:0)
[05:44:31.135] Timer tick, asking Buildbucket for the build status
[05:44:31.600] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:31.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:32:0) after 1m0s
[05:45:31.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:32:0)
[05:45:31.659] Timer tick, asking Buildbucket for the build status
[05:45:32.376] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:32.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:33:0) after 1m0s
[05:46:32.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:33:0)
[05:46:32.404] Timer tick, asking Buildbucket for the build status
[05:46:32.493] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:32.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:34:0) after 1m0s
[05:47:32.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:34:0)
[05:47:32.586] Timer tick, asking Buildbucket for the build status
[05:47:32.932] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:32.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:35:0) after 1m0s
[05:48:32.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:35:0)
[05:48:32.954] Timer tick, asking Buildbucket for the build status
[05:48:33.033] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:33.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:36:0) after 1m0s
[05:49:33.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:36:0)
[05:49:33.066] Timer tick, asking Buildbucket for the build status
[05:49:33.181] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:33.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:37:0) after 1m0s
[05:50:33.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:37:0)
[05:50:33.234] Timer tick, asking Buildbucket for the build status
[05:50:33.373] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:33.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:38:0) after 1m0s
[05:51:33.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:38:0)
[05:51:33.429] Timer tick, asking Buildbucket for the build status
[05:51:33.707] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:33.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:39:0) after 1m0s
[05:52:33.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:39:0)
[05:52:33.877] Timer tick, asking Buildbucket for the build status
[05:52:33.953] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:33.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:40:0) after 1m0s
[05:53:34.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:40:0)
[05:53:34.085] Timer tick, asking Buildbucket for the build status
[05:53:34.251] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:34.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:41:0) after 1m0s
[05:54:34.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:41:0)
[05:54:34.369] Timer tick, asking Buildbucket for the build status
[05:54:34.443] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:34.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:42:0) after 1m0s
[05:55:34.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:42:0)
[05:55:34.637] Timer tick, asking Buildbucket for the build status
[05:55:34.764] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:34.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:43:0) after 1m0s
[05:56:34.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:43:0)
[05:56:34.762] Timer tick, asking Buildbucket for the build status
[05:56:35.199] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:35.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:44:0) after 1m0s
[05:57:35.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:44:0)
[05:57:35.283] Timer tick, asking Buildbucket for the build status
[05:57:35.375] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:35.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:45:0) after 1m0s
[05:58:35.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:45:0)
[05:58:35.430] Timer tick, asking Buildbucket for the build status
[05:58:35.717] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:35.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:46:0) after 1m0s
[05:59:35.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:46:0)
[05:59:35.741] Timer tick, asking Buildbucket for the build status
[05:59:35.833] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:35.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:47:0) after 1m0s
[06:00:35.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:47:0)
[06:00:35.903] Timer tick, asking Buildbucket for the build status
[06:00:36.220] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:36.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:48:0) after 1m0s
[06:01:48.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:48:0)
[06:01:48.782] Timer tick, asking Buildbucket for the build status
[06:01:49.597] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:49.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:49:0) after 1m0s
[06:02:49.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:49:0)
[06:02:49.646] Timer tick, asking Buildbucket for the build status
[06:02:49.814] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:49.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:50:0) after 1m0s
[06:03:49.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:50:0)
[06:03:49.911] Timer tick, asking Buildbucket for the build status
[06:03:50.398] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:50.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:51:0) after 1m0s
[06:04:50.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:51:0)
[06:04:50.513] Timer tick, asking Buildbucket for the build status
[06:04:50.644] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:50.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:52:0) after 1m0s
[06:05:50.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:52:0)
[06:05:50.671] Timer tick, asking Buildbucket for the build status
[06:05:50.837] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:50.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:53:0) after 1m0s
[06:06:50.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:53:0)
[06:06:50.897] Timer tick, asking Buildbucket for the build status
[06:06:51.395] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:51.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:54:0) after 1m0s
[06:07:51.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:54:0)
[06:07:51.537] Timer tick, asking Buildbucket for the build status
[06:07:51.655] Build 8863863433575965472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:51.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029293495534091408:55:0) after 1m0s
[06:08:21.044] Received PubSub notification, asking Buildbucket for the build status
[06:08:21.212] Build 8863863433575965472: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[06:08:21.213] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605161299719299",
"created_by": "project:chromium",
"created_ts": "1605158121474528",
"failure_reason": "BUILD_FAILURE",
"id": "8863863433575965472",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"05227c04d91944d17949612251f8a35b57e2719f\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**blink_platform_unittests** failed because of:\\n\\n- AllTimerTaskTypes/FrameSchedulerImplStopInBackgroundDisabledTest.ThrottledTaskExecution/JavascriptTimerDelayedHighNesting\"}, \"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\": \"05227c04d91944d17949612251f8a35b57e2719f\", \"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-115-pmft\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42794, \"got_angle_revision\": \"6067e9ce8bb3bde028dfa613af4d7b1ac41391e3\", \"got_dawn_revision\": \"b70a5b02e9712693ffb796c0b0d8cfa24ca5eba5\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"05227c04d91944d17949612251f8a35b57e2719f\", \"got_revision_cp\": \"refs/heads/master@{#826658}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"b638dfe160a17f288c774fd98f725f212f843c2b\", \"got_v8_revision\": \"034eac1ebbf1ccd6d8ac6ac08764664a66066a86\", \"got_v8_revision_cp\": \"refs/heads/8.8.292@{#1}\", \"got_webrtc_revision\": \"06bbeb3398afa8651ca76ea7eb56b7d046edfca8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32588}\", \"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\": \"05227c04d91944d17949612251f8a35b57e2719f\", \"swarm_hashes_refs/heads/master(at){#826658}_without_patch\": {\"absl_hardening_tests\": \"2a03d1456f77be65ba45022e923e8feae718fceb\", \"accessibility_unittests\": \"6e72b0d3edcb8b3fda830ee1f06a2d66b8d2b598\", \"angle_unittests\": \"c62d22b3bf64ca944902b250d8d52c37b8067d15\", \"app_list_unittests\": \"68eee8d9bb711147b1f871b8c8c996b9663c8e09\", \"app_shell_unittests\": \"55f7b3a9bcdb24267a991c77e414c7f5142e3f8c\", \"ash_unittests\": \"b0846b4896fda1201936916b0f7e4ecbb4249b10\", \"aura_unittests\": \"3ac8cabc384e41e6978d5d9d10cc3f5b915161ef\", \"base_unittests\": \"010ca237616aa3918b066a68fc32c4cfe2294e76\", \"base_util_unittests\": \"565b586e74e54f6b2fa7aa96514c9d648f175402\", \"blink_common_unittests\": \"879ddbe0c40aec4be58925164ea5d5e0fae9fc22\", \"blink_fuzzer_unittests\": \"f704d1e5c4f3a04103d35fe2eec25e252e34c15d\", \"blink_heap_unittests\": \"025ed02236f09ee234a9cffc71e9393b91908451\", \"blink_platform_unittests\": \"f40b3d1baf825bb470a2ceb7e3629ff077457e86\", \"blink_unittests\": \"143c45b5d2a77359f9e54d3e29146de687ee0854\", \"boringssl_crypto_tests\": \"d66153b343ba7f33eddea384d51f5d287f918033\", \"boringssl_ssl_tests\": \"4c463b937c82ecacc5051517ef4fbd804f232b11\", \"browser_tests\": \"5f807e14b03150589a252d68e96e306ca3822cc0\", \"capture_unittests\": \"e157d040f8808b6d5f2c5030f746f9f176663e99\", \"cast_unittests\": \"b51b4a6c09fcfbd566e76ccd1cbf77e89ded094f\", \"cc_unittests\": \"4357de2e57e4d3cd157947d17340314fe0492034\", \"chrome_app_unittests\": \"1f6a4e45c3a19e3d3aff86d1cc0632ba7e2a43d4\", \"chromedriver_unittests\": \"10c4d76b27cc4faf6077c4803bf0cac7de0f3acb\", \"chromeos_components_unittests\": \"f7245bf436c0aba33a271b9bc3c2f35f7205001c\", \"chromeos_unittests\": \"cb193e2095f8182bcf2101b9bd940d16d638d509\", \"components_browsertests\": \"c3ea70bacc4db90d1990c3e62dd1646a72ecab78\", \"components_unittests\": \"9e29c09d9ed78ab06e9163b6f8ab4debf2f9882a\", \"compositor_unittests\": \"66115fea8212bb6bb4ac779b3599ff04250d8f88\", \"content_browsertests\": \"aa59db7ba204e54232fe188cc56227dda705b59b\", \"content_unittests\": \"ebd845a0cded26587af44ae4b4743ff1cf33ac05\", \"crashpad_tests\": \"995cfb8d999e20345f777e5737dba545f7498757\", \"crypto_unittests\": \"74a6602101c4c3807fee2d1e4d820db90d30f1f1\", \"dbus_unittests\": \"d39c1bc058528d993f36d43b42f2fc1a788d5980\", \"device_unittests\": \"577ab3dab413ff7195eb39a538a56bc36a5e3533\", \"display_unittests\": \"0c9d4289c03661e51c84857755351d77f0955e2f\", \"events_unittests\": \"47d9b65b9aac54495aae624535f7a1ff72c43f65\", \"exo_unittests\": \"00bdba80957a89798f075dceb2592d55ad817c64\", \"extensions_browsertests\": \"36b10b5336e6c082b4e6c5ff53ac91f108c9f055\", \"extensions_unittests\": \"627a3b50e50a2ff519e83b52c0e049a15d4fcd2b\", \"filesystem_service_unittests\": \"c3b52fd9bd2c792f21105b1d5b90511a81afc47f\", \"gcm_unit_tests\": \"14a28a0b556c5df3db3384f42fde6f82f640dac0\", \"gfx_unittests\": \"9c88ef5f51b5bf715921c19031c5591a129adc19\", \"gin_unittests\": \"acd2e8a048824c23ae427f7d3ed7becceaa1f395\", \"gl_unittests_ozone\": \"96d0157e653b54ebd2f76a93416528d6c65421b4\", \"google_apis_unittests\": \"20cebb3a471097ca7e7e3be40d232c097c541bba\", \"gpu_unittests\": \"211c09c0070808a37cb69a84d34c9ba137d4fe61\", \"gwp_asan_unittests\": \"5d96172d7bca696ab957dab8dda9df3454d3fae6\", \"interactive_ui_tests\": \"401f311f12c472b286bcbd4b015aea8c826e14a3\", \"ipc_tests\": \"327ca2868b392733e6accba0c363fab89ee7f8f3\", \"jingle_unittests\": \"a3251aa1d6979c83c6077dab2ab50aca3114b0a0\", \"keyboard_unittests\": \"739d162e340578a037a8d93229c50dfe68ee1c57\", \"latency_unittests\": \"b3242b409fde0e744abfc49748cba89768545f6d\", \"libjingle_xmpp_unittests\": \"205878e2987d3b738b42caa8e6d8eab4a21d9caf\", \"liburlpattern_unittests\": \"b45420dd17b424a8f2771463490804782a878cfb\", \"media_blink_unittests\": \"f6f13bdf7c60024b8d630af0b5f7c0e3a2ccbe15\", \"media_unittests\": \"f8da703154a48c60bbbae49a9e123b8450be7bd7\", \"message_center_unittests\": \"cce88ce0b3d561d0ab05eb8cca90d0ceeecc87da\", \"midi_unittests\": \"0c3f4a8498240005548eb899de58931ef4a03749\", \"mojo_core_unittests\": \"f2caf9c0502c5c593a3128101a745db58525c2f0\", \"mojo_unittests\": \"e0cf6c8ad9ff6c0b4c9fa68721e8df8c6762e815\", \"nacl_helper_nonsfi_unittests\": \"f05b74af1b25f56513f065ee6fa6c17257a68c87\", \"nacl_loader_unittests\": \"bbc82d303d720b2e78809bb1f3bb7a4939f45330\", \"native_theme_unittests\": \"a4e7ec87784467ba07b8f915b45786e19cccf7de\", \"net_unittests\": \"c242c744dbd61b5d2a764acf2d2886a7bcab0f16\", \"ozone_gl_unittests\": \"63cc6ed97c55d23e495ccc1734887f2e5f243c26\", \"ozone_unittests\": \"3d9d184b3226fdbd3efdedff8367c994b41cdfd7\", \"ozone_x11_unittests\": \"4d5a053b25683bdf5bbf02b2d79bf2e6b7135131\", \"pdf_unittests\": \"6b08208df75342ed0d7e67b34757b5b95671f083\", \"perfetto_unittests\": \"0d7f3224a5314568203ef2626598a05899c2b7f1\", \"ppapi_unittests\": \"1579dc3fc83cbce4fecbda0f03aed38ac11bda29\", \"printing_unittests\": \"ab720d2997f702b615868afe53c0a2584c86d729\", \"remoting_unittests\": \"f5dbac01c8e0c24267c9333e71f33aced3d3cd4c\", \"sandbox_linux_unittests\": \"ed94295ae449abe3f222442eb376477888fe9f3e\", \"service_manager_unittests\": \"96b6f0005f44dcca48be3b81fc05948f515f963e\", \"services_unittests\": \"4061e16be890b279f052d15c94577b528598b1c2\", \"shell_dialogs_unittests\": \"86152e6ad8012a514ba83f288684780b7910e5ac\", \"skia_unittests\": \"3232ab67d0d6bce88de934c3680c2b0a2a4da80e\", \"snapshot_unittests\": \"b3e95b9f33322d0d6e59287b87b326540002a0ed\", \"sql_unittests\": \"653f22fb0a4164c772143b1c97a336ef21ea9ab1\", \"storage_unittests\": \"c9b4c8af7ede726f289129af474213ca6fdf20c8\", \"sync_integration_tests\": \"aa73f15b9d6847614276641e139a8019a352a365\", \"traffic_annotation_auditor_unittests\": \"209d1ca8f4a2ed795d4ded2e13111ff5c5dcf21e\", \"ui_base_unittests\": \"e3071065944e3d885760b72b26bcdf90c3273048\", \"ui_chromeos_unittests\": \"91ac76088551dbba0bb66d42564e275b1948aa26\", \"ui_touch_selection_unittests\": \"0b85802c6d01c792c9277a324dee8c0cac21bd36\", \"unit_tests\": \"d57560c47703c3f00066cb401f8b9a18802d6d7b\", \"url_unittests\": \"e1080848d6e5babde61c7c1932cf2f56e1b6cdf3\", \"usage_time_limit_unittests\": \"ca88346ba837a69b4fc1bfb1c5165ea38931d1b1\", \"views_unittests\": \"5ec586620154d40db4eb576ef4de1c58a2c080c8\", \"viz_unittests\": \"1955739d2e87e722b1a07ef9237c0ec4cceaadf4\", \"wayland_client_perftests\": \"717b224d9dbe574ea46f6d630a9c9d4a5200ba9c\", \"wm_unittests\": \"d67ea71362c50dba8892008a31969548f084ddfd\", \"wtf_unittests\": \"48d0bf1a89b231a8637bae8849cda111e3dd018c\", \"zlib_unittests\": \"2489aed28308b467682da5903623066800f7e7d8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_70d81bd75c8665fc1e9b8928c4ede9b8726627f1f0cc1bd77b1f6c94d85edb40_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_f5174a4d80cdc4c8aa1989fa45d69979d28910f768af140dd646791c34143bfe_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-115-pmft\"], \"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\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**blink_platform_unittests** failed because of:\\n\\n- AllTimerTaskTypes/FrameSchedulerImplStopInBackgroundDisabledTest.ThrottledTaskExecution/JavascriptTimerDelayedHighNesting\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605158124286596",
"status": "COMPLETED",
"status_changed_ts": "1605158125482474",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42794",
"builder:linux-chromeos-rel",
"buildset:commit/git/05227c04d91944d17949612251f8a35b57e2719f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05227c04d91944d17949612251f8a35b57e2719f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029293495534091408",
"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/8863863433575965472/+/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:4fd3b2bc66e80a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605161300575320",
"url": "https://ci.chromium.org/b/8863863433575965472",
"utcnow_ts": "1605161301199838"
}
}
[06:08:21.213] Invocation finished in 53m0.98938372s with status FAILED