[03:29:08.234] New invocation is queued and will start shortly
[03:29:09.316] Starting the invocation (attempt 1)
[03:29:09.379] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:29:09.380] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:29:09.380] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9064089412164658448",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5a679ec549b7e707c966f299a13c12d114bde4a1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9064089412164658448",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/5a679ec549b7e707c966f299a13c12d114bde4a1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5a679ec549b7e707c966f299a13c12d114bde4a1",
"gitiles_ref:refs/heads/master"
]
}
[03:29:10.199] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1571974149548036",
"id": "8898659350121464432",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5a679ec549b7e707c966f299a13c12d114bde4a1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1571974150082830",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/14971",
"builder:linux-chromeos-dbg",
"buildset:commit/git/5a679ec549b7e707c966f299a13c12d114bde4a1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5a679ec549b7e707c966f299a13c12d114bde4a1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064089412164658448",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8898659350121464432/+/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": "1571974150082950",
"url": "https://ci.chromium.org/b/8898659350121464432",
"utcnow_ts": "1571974150191803"
}
}
[03:29:10.199] Task URL: https://ci.chromium.org/b/8898659350121464432
[03:29:10.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:2:0) after 1m0s
[03:30:10.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:2:0)
[03:30:10.393] Timer tick, asking Buildbucket for the build status
[03:30:11.715] Build 8898659350121464432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:30:11.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:3:0) after 1m0s
[03:31:11.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:3:0)
[03:31:11.740] Timer tick, asking Buildbucket for the build status
[03:31:12.743] Build 8898659350121464432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:31:12.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:4:0) after 1m0s
[03:31:43.375] Received PubSub notification, asking Buildbucket for the build status
[03:31:43.552] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:12.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:4:0)
[03:32:12.766] Timer tick, asking Buildbucket for the build status
[03:32:13.154] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:13.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:6:0) after 1m0s
[03:33:13.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:6:0)
[03:33:13.204] Timer tick, asking Buildbucket for the build status
[03:33:14.113] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:14.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:7:0) after 1m0s
[03:34:14.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:7:0)
[03:34:14.149] Timer tick, asking Buildbucket for the build status
[03:34:14.701] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:14.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:8:0) after 1m0s
[03:35:14.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:8:0)
[03:35:14.775] Timer tick, asking Buildbucket for the build status
[03:35:15.266] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:15.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:9:0) after 1m0s
[03:36:15.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:9:0)
[03:36:15.286] Timer tick, asking Buildbucket for the build status
[03:36:15.520] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:15.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:10:0) after 1m0s
[03:37:15.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:10:0)
[03:37:15.539] Timer tick, asking Buildbucket for the build status
[03:37:15.806] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:15.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:11:0) after 1m0s
[03:38:15.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:11:0)
[03:38:15.855] Timer tick, asking Buildbucket for the build status
[03:38:16.319] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:16.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:12:0) after 1m0s
[03:39:16.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:12:0)
[03:39:16.457] Timer tick, asking Buildbucket for the build status
[03:39:17.215] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:17.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:13:0) after 1m0s
[03:40:17.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:13:0)
[03:40:17.656] Timer tick, asking Buildbucket for the build status
[03:40:17.815] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:17.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:14:0) after 1m0s
[03:41:18.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:14:0)
[03:41:18.376] Timer tick, asking Buildbucket for the build status
[03:41:18.813] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:18.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:15:0) after 1m0s
[03:42:18.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:15:0)
[03:42:18.878] Timer tick, asking Buildbucket for the build status
[03:42:19.122] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:19.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:16:0) after 1m0s
[03:43:19.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:16:0)
[03:43:19.240] Timer tick, asking Buildbucket for the build status
[03:43:19.442] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:19.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:17:0) after 1m0s
[03:44:19.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:17:0)
[03:44:19.544] Timer tick, asking Buildbucket for the build status
[03:44:19.752] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:19.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:18:0) after 1m0s
[03:45:19.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:18:0)
[03:45:19.910] Timer tick, asking Buildbucket for the build status
[03:45:20.211] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:20.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:19:0) after 1m0s
[03:46:20.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:19:0)
[03:46:20.633] Timer tick, asking Buildbucket for the build status
[03:46:20.876] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:20.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:20:0) after 1m0s
[03:47:20.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:20:0)
[03:47:20.939] Timer tick, asking Buildbucket for the build status
[03:47:22.724] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:22.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:21:0) after 1m0s
[03:48:22.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:21:0)
[03:48:22.794] Timer tick, asking Buildbucket for the build status
[03:48:23.107] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:23.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:22:0) after 1m0s
[03:49:23.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:22:0)
[03:49:23.171] Timer tick, asking Buildbucket for the build status
[03:49:26.576] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:26.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:23:0) after 1m0s
[03:50:27.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:23:0)
[03:50:27.049] Timer tick, asking Buildbucket for the build status
[03:50:27.805] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:27.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:24:0) after 1m0s
[03:51:27.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:24:0)
[03:51:27.867] Timer tick, asking Buildbucket for the build status
[03:51:30.053] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:30.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:25:0) after 1m0s
[03:52:30.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:25:0)
[03:52:30.112] Timer tick, asking Buildbucket for the build status
[03:52:30.738] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:30.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:26:0) after 1m0s
[03:53:30.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:26:0)
[03:53:30.782] Timer tick, asking Buildbucket for the build status
[03:53:31.098] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:31.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:27:0) after 1m0s
[03:54:31.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:27:0)
[03:54:31.138] Timer tick, asking Buildbucket for the build status
[03:54:31.633] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:31.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:28:0) after 1m0s
[03:55:31.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:28:0)
[03:55:31.655] Timer tick, asking Buildbucket for the build status
[03:55:31.838] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:31.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:29:0) after 1m0s
[03:56:31.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:29:0)
[03:56:31.896] Timer tick, asking Buildbucket for the build status
[03:56:32.158] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:32.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:30:0) after 1m0s
[03:57:32.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:30:0)
[03:57:32.184] Timer tick, asking Buildbucket for the build status
[03:57:32.881] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:32.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:31:0) after 1m0s
[03:58:32.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:31:0)
[03:58:32.970] Timer tick, asking Buildbucket for the build status
[03:58:33.229] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:33.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:32:0) after 1m0s
[03:59:33.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:32:0)
[03:59:33.300] Timer tick, asking Buildbucket for the build status
[03:59:33.629] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:33.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:33:0) after 1m0s
[04:00:33.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:33:0)
[04:00:33.673] Timer tick, asking Buildbucket for the build status
[04:00:34.342] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:34.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:34:0) after 1m0s
[04:01:34.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:34:0)
[04:01:34.376] Timer tick, asking Buildbucket for the build status
[04:01:36.318] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:36.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:35:0) after 1m0s
[04:02:36.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:35:0)
[04:02:36.433] Timer tick, asking Buildbucket for the build status
[04:02:37.342] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:37.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:36:0) after 1m0s
[04:03:37.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:36:0)
[04:03:37.339] Timer tick, asking Buildbucket for the build status
[04:03:37.612] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:37.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:37:0) after 1m0s
[04:04:37.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:37:0)
[04:04:37.656] Timer tick, asking Buildbucket for the build status
[04:04:37.827] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:37.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:38:0) after 1m0s
[04:05:37.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:38:0)
[04:05:37.850] Timer tick, asking Buildbucket for the build status
[04:05:38.300] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:38.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:39:0) after 1m0s
[04:06:38.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:39:0)
[04:06:38.330] Timer tick, asking Buildbucket for the build status
[04:06:38.556] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:38.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:40:0) after 1m0s
[04:07:38.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:40:0)
[04:07:38.685] Timer tick, asking Buildbucket for the build status
[04:07:39.973] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:39.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:41:0) after 1m0s
[04:08:40.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:41:0)
[04:08:40.181] Timer tick, asking Buildbucket for the build status
[04:08:40.665] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:40.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:42:0) after 1m0s
[04:09:40.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:42:0)
[04:09:40.767] Timer tick, asking Buildbucket for the build status
[04:09:41.183] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:41.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:43:0) after 1m0s
[04:10:41.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:43:0)
[04:10:41.243] Timer tick, asking Buildbucket for the build status
[04:10:42.763] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:42.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:44:0) after 1m0s
[04:11:42.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:44:0)
[04:11:42.784] Timer tick, asking Buildbucket for the build status
[04:11:43.056] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:43.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:45:0) after 1m0s
[04:12:43.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:45:0)
[04:12:43.121] Timer tick, asking Buildbucket for the build status
[04:12:43.536] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:43.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:46:0) after 1m0s
[04:13:43.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:46:0)
[04:13:43.825] Timer tick, asking Buildbucket for the build status
[04:13:44.253] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:44.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:47:0) after 1m0s
[04:14:44.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:47:0)
[04:14:44.422] Timer tick, asking Buildbucket for the build status
[04:14:44.841] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:44.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:48:0) after 1m0s
[04:15:44.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:48:0)
[04:15:44.911] Timer tick, asking Buildbucket for the build status
[04:15:45.124] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:45.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:49:0) after 1m0s
[04:16:45.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:49:0)
[04:16:45.233] Timer tick, asking Buildbucket for the build status
[04:16:45.672] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:45.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:50:0) after 1m0s
[04:17:45.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:50:0)
[04:17:45.828] Timer tick, asking Buildbucket for the build status
[04:17:46.317] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:46.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:51:0) after 1m0s
[04:18:46.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:51:0)
[04:18:46.413] Timer tick, asking Buildbucket for the build status
[04:18:46.794] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:46.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:52:0) after 1m0s
[04:19:47.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:52:0)
[04:19:47.008] Timer tick, asking Buildbucket for the build status
[04:19:49.260] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:49.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:53:0) after 1m0s
[04:20:49.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:53:0)
[04:20:49.301] Timer tick, asking Buildbucket for the build status
[04:20:49.852] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:49.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:54:0) after 1m0s
[04:21:49.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:54:0)
[04:21:49.872] Timer tick, asking Buildbucket for the build status
[04:21:50.534] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:50.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:55:0) after 1m0s
[04:22:50.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:55:0)
[04:22:50.591] Timer tick, asking Buildbucket for the build status
[04:22:51.558] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:51.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:56:0) after 1m0s
[04:23:51.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:56:0)
[04:23:51.632] Timer tick, asking Buildbucket for the build status
[04:23:51.794] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:51.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:57:0) after 1m0s
[04:24:51.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:57:0)
[04:24:51.906] Timer tick, asking Buildbucket for the build status
[04:24:53.426] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:53.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:58:0) after 1m0s
[04:25:53.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:58:0)
[04:25:53.487] Timer tick, asking Buildbucket for the build status
[04:25:54.504] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:54.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:59:0) after 1m0s
[04:26:54.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:59:0)
[04:26:54.566] Timer tick, asking Buildbucket for the build status
[04:26:55.053] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:55.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:60:0) after 1m0s
[04:27:55.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:60:0)
[04:27:55.068] Timer tick, asking Buildbucket for the build status
[04:27:55.404] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:55.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:61:0) after 1m0s
[04:28:55.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:61:0)
[04:28:55.422] Timer tick, asking Buildbucket for the build status
[04:28:56.161] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:56.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:62:0) after 1m0s
[04:29:56.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:62:0)
[04:29:56.158] Timer tick, asking Buildbucket for the build status
[04:29:56.501] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:56.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:63:0) after 1m0s
[04:30:56.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:63:0)
[04:30:56.527] Timer tick, asking Buildbucket for the build status
[04:30:56.720] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:56.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:64:0) after 1m0s
[04:31:56.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:64:0)
[04:31:56.752] Timer tick, asking Buildbucket for the build status
[04:31:57.302] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:57.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:65:0) after 1m0s
[04:32:57.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:65:0)
[04:32:57.325] Timer tick, asking Buildbucket for the build status
[04:32:58.036] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:58.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:66:0) after 1m0s
[04:33:58.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:66:0)
[04:33:58.104] Timer tick, asking Buildbucket for the build status
[04:33:58.592] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:58.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:67:0) after 1m0s
[04:34:58.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:67:0)
[04:34:58.612] Timer tick, asking Buildbucket for the build status
[04:34:58.948] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:58.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:68:0) after 1m0s
[04:35:59.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:68:0)
[04:35:59.015] Timer tick, asking Buildbucket for the build status
[04:35:59.288] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:59.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:69:0) after 1m0s
[04:36:59.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:69:0)
[04:36:59.342] Timer tick, asking Buildbucket for the build status
[04:37:02.191] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:02.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:70:0) after 1m0s
[04:38:02.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:70:0)
[04:38:02.289] Timer tick, asking Buildbucket for the build status
[04:38:04.066] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:04.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:71:0) after 1m0s
[04:39:04.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:71:0)
[04:39:04.274] Timer tick, asking Buildbucket for the build status
[04:39:04.724] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:04.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:72:0) after 1m0s
[04:40:04.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:72:0)
[04:40:04.985] Timer tick, asking Buildbucket for the build status
[04:40:06.287] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:06.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:73:0) after 1m0s
[04:41:06.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:73:0)
[04:41:06.690] Timer tick, asking Buildbucket for the build status
[04:41:07.615] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:07.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:74:0) after 1m0s
[04:42:07.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:74:0)
[04:42:07.930] Timer tick, asking Buildbucket for the build status
[04:42:09.044] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:09.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:75:0) after 1m0s
[04:43:09.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:75:0)
[04:43:09.084] Timer tick, asking Buildbucket for the build status
[04:43:09.561] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:09.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:76:0) after 1m0s
[04:44:09.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:76:0)
[04:44:09.700] Timer tick, asking Buildbucket for the build status
[04:44:09.944] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:09.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:77:0) after 1m0s
[04:45:09.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:77:0)
[04:45:09.983] Timer tick, asking Buildbucket for the build status
[04:45:10.284] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:10.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:78:0) after 1m0s
[04:46:10.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:78:0)
[04:46:10.464] Timer tick, asking Buildbucket for the build status
[04:46:13.300] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:13.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:79:0) after 1m0s
[04:47:13.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:79:0)
[04:47:13.404] Timer tick, asking Buildbucket for the build status
[04:47:13.632] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:13.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:80:0) after 1m0s
[04:48:13.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:80:0)
[04:48:13.625] Timer tick, asking Buildbucket for the build status
[04:48:13.960] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:13.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:81:0) after 1m0s
[04:49:14.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:81:0)
[04:49:14.032] Timer tick, asking Buildbucket for the build status
[04:49:16.596] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:16.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:82:0) after 1m0s
[04:50:16.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:82:0)
[04:50:16.706] Timer tick, asking Buildbucket for the build status
[04:50:17.206] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:17.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:83:0) after 1m0s
[04:51:17.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:83:0)
[04:51:17.236] Timer tick, asking Buildbucket for the build status
[04:51:19.176] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:19.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:84:0) after 1m0s
[04:52:19.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:84:0)
[04:52:19.249] Timer tick, asking Buildbucket for the build status
[04:52:19.828] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:19.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:85:0) after 1m0s
[04:53:19.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:85:0)
[04:53:19.907] Timer tick, asking Buildbucket for the build status
[04:53:20.293] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:20.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:86:0) after 1m0s
[04:54:20.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:86:0)
[04:54:20.336] Timer tick, asking Buildbucket for the build status
[04:54:21.859] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:21.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:87:0) after 1m0s
[04:55:21.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:87:0)
[04:55:21.971] Timer tick, asking Buildbucket for the build status
[04:55:22.318] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:22.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:88:0) after 1m0s
[04:56:22.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:88:0)
[04:56:22.352] Timer tick, asking Buildbucket for the build status
[04:56:22.682] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:22.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:89:0) after 1m0s
[04:57:22.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:89:0)
[04:57:22.721] Timer tick, asking Buildbucket for the build status
[04:57:22.990] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:22.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:90:0) after 1m0s
[04:58:23.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:90:0)
[04:58:23.013] Timer tick, asking Buildbucket for the build status
[04:58:23.251] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:23.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:91:0) after 1m0s
[04:59:23.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:91:0)
[04:59:23.329] Timer tick, asking Buildbucket for the build status
[04:59:23.620] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:23.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:92:0) after 1m0s
[05:00:23.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:92:0)
[05:00:23.701] Timer tick, asking Buildbucket for the build status
[05:00:24.213] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:24.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:93:0) after 1m0s
[05:01:24.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:93:0)
[05:01:24.411] Timer tick, asking Buildbucket for the build status
[05:01:25.263] Build 8898659350121464432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:25.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9064089412164658448:94:0) after 1m0s
[05:02:09.347] Received PubSub notification, asking Buildbucket for the build status
[05:02:09.701] Build 8898659350121464432: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:02:09.703] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1571979725839793",
"created_by": "project:chromium",
"created_ts": "1571974149548036",
"failure_reason": "BUILD_FAILURE",
"id": "8898659350121464432",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5a679ec549b7e707c966f299a13c12d114bde4a1\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 Test Suite(s) failed.\\n\\n**non_viz_browser_tests** failed because of:\\n\\n- ChromeOsMirrorAccountConsistencyTest.TestMirrorRequestChromeOsNotChildAccount\\n\\n- OobeGuestButtonPolicy.VisibilityAfterEnrollment/0\\n\\n- SAMLPasswordAttributesSuite/SAMLPasswordAttributesTest.LoginSucceeded/1\\n\\n- SAMLPasswordAttributesSuite/SAMLPasswordAttributesTest.LoginSucceeded/0\\n\\n- ...9 more failure(s) (13 total)...\\n\\n**browser_tests** failed because of:\\n\\n- ChromeVoxBackgroundTest.ReinsertedNodeRecovery\\n\\n- ShareAndManageDialog/FilesAppBrowserTest.Test/shareTeamDrive\\n\\n- OAuth2Test.VerifyNotInAdvancedProtectionAfterOnlineAuth\\n\\n- ChromeVoxLiveRegionsTest.LiveRegionChangeAtomicText\\n\\n- ...40 more failure(s) (44 total)...\\n\\n**unit_tests** failed because of:\\n\\n- WebAppDataRetrieverTest.GetWebApplicationInfo_FrameNavigated\\n\\n- ...174 more failure(s) (175 total)...\"}, \"properties\": {\"$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-52-i66j\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 14971, \"got_angle_revision\": \"6b652b335259295d90702fff9f3b34988eef36f7\", \"got_dawn_revision\": \"1fdcb16b6995c54c645f17566d019ebf46229fd0\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"5a679ec549b7e707c966f299a13c12d114bde4a1\", \"got_revision_cp\": \"refs/heads/master@{#709350}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"24fd62c58cd1260918cf35ef6837045d96298b13\", \"got_v8_revision_cp\": \"refs/heads/8.0.62@{#1}\", \"got_webrtc_revision\": \"a9229043e357edfa882e80a226d4653079ee730d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29601}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5a679ec549b7e707c966f299a13c12d114bde4a1\", \"swarm_hashes\": {\"accessibility_unittests\": \"9fc123c127ec3877ed4ad8b11312af288e6bcf8c\", \"angle_unittests\": \"ce6f7f4257f80fcc7dc5c6b469af10ba338664c3\", \"app_list_unittests\": \"6df19e6eb901ed7072feb1fbcac18fa651267d4a\", \"app_shell_unittests\": \"7e3437abc09e2b942bea784eac7e6a1f2e7d3b1c\", \"ash_unittests\": \"c5e3eecedac7704c5ea57e3d634edf946c77c723\", \"aura_unittests\": \"6a9ea2193a9d41b9673ac6084da8104030002c1a\", \"base_unittests\": \"9eba2f244082c3aa5633d6464162a5df56d9c395\", \"base_util_unittests\": \"45092edc9e29d80728b07c38edf6135e0467918b\", \"blink_common_unittests\": \"e0ab83d61ffe38f1310f1e7c1960398e9b6db093\", \"blink_fuzzer_unittests\": \"763e6f233dbbdfe8dc451ee9b54f95d42df8cffe\", \"blink_heap_unittests\": \"868fb11961d27c13556294e3a41193612ad445bd\", \"blink_platform_unittests\": \"25bc9d33e4d809643d0144e947968c9f4db0f91a\", \"blink_unittests\": \"6cb78edfe0b26a0d650be568105b1a1e7a5b222f\", \"boringssl_crypto_tests\": \"225fe1e85f46ab78b3db9f42efb46c2901d21d9f\", \"boringssl_ssl_tests\": \"e1540f987157632fa3565a5f6246663d5ee0b51f\", \"browser_tests\": \"ed57d879f5c5d9f218e5d9813b557fef8b54a8f7\", \"cacheinvalidation_unittests\": \"df0ffca3285d01233e9ef30549d677ba0786f134\", \"capture_unittests\": \"557d87e9368bc54c2a95f72ed733b54dbfdec764\", \"cast_unittests\": \"faa1cf397fc2a26cb625d384fbb472555674ac58\", \"cc_unittests\": \"e4a8ac463292de4cd11585d1a645f2d18a45f6ec\", \"chrome_app_unittests\": \"044a175a215706a1834986ef3c112e8db15da1ac\", \"chromedriver_unittests\": \"2028973b667ebd2d712e12ce6ceb82a062fc3526\", \"chromeos_components_unittests\": \"a3aa198ab57b076c1200e95be23dc54936130c30\", \"chromeos_unittests\": \"5c3d81ce0e519c94ed54ac868334b1db6515a45b\", \"color_unittests\": \"1726bf4d9cfd714debcb7af5209f62209d5879a1\", \"components_browsertests\": \"9edf71c3c687ad268c9a649d385d178d55e4cef0\", \"components_unittests\": \"c2a2983bbc2bfc6980da1c2097e74bf50a6b86cc\", \"compositor_unittests\": \"a0c73c593590b0ef3223f36c81498715d3b5f4a1\", \"content_browsertests\": \"e0afec07d2f7a79a7e3d76ee962abe291940d2e3\", \"content_unittests\": \"25a3b27adfb2484ab5c8f77c81c758cc06f2a5ef\", \"crypto_unittests\": \"d4e60183278c5516c95ef3fa85d3032a8a7e3e4d\", \"dbus_unittests\": \"361d6063022cd9866f65455d13c97cc29f3c4f48\", \"device_unittests\": \"7b129f82c9f7a6c622fde24b101b378a7cbc288b\", \"display_unittests\": \"9b0a6ed43706137138de02ee9a33cf47082eb7a4\", \"events_unittests\": \"60cd2f45829bd99bece60489531ee72c272da2c7\", \"exo_unittests\": \"90292981f3fae1b6ed52a6a90dc2a7c3bcef33dd\", \"extensions_browsertests\": \"3d1b9def246b44b14e8c7dd5436119e1ca3a35da\", \"extensions_unittests\": \"553bb69933bb825280983d37217f8d9e91f5e5c6\", \"filesystem_service_unittests\": \"6be3f6958a6d1f9ee4948217094b137a2da757a4\", \"gcm_unit_tests\": \"842d8e0ebce37b611b8b68d3ae7e55008fd6700a\", \"gfx_unittests\": \"ce52623ce791de367932f44887b38bd906b444a9\", \"gin_unittests\": \"7c5fa0a8c3b4cb5291326d8d44796a65c2f4b7c8\", \"gl_unittests_ozone\": \"07deac1c07bd4ca58b468bb1e7332f202405e97f\", \"google_apis_unittests\": \"3c87dea97c6b8366f3b6a3d45d111771f18f03a8\", \"gpu_unittests\": \"f5bfa3b068051e70b301316441a61a5b17130f9d\", \"gwp_asan_unittests\": \"63997379fd06b3755aa740ee6543f94d4dc029a5\", \"interactive_ui_tests\": \"c3544cc0c11e8789b44f0273e69c8dd535fbd1cf\", \"ipc_tests\": \"93fa9a9afdda5b910e8c93b4dc8991f8827f157a\", \"jingle_unittests\": \"1cdefb9236d6debffea9318489fa37ceb59aefd7\", \"keyboard_unittests\": \"95e5addd81a07a322ceb3f0ba6f3e4b2d8835028\", \"latency_unittests\": \"9ddc71bf088cf7a95331a43e53833662bc9932ef\", \"libjingle_xmpp_unittests\": \"cfe2ccdbc95503b300aae21151c34aabe981e476\", \"media_blink_unittests\": \"7a6da49d7fb3b80eadfa4cac5700e4e4bbb3ab4b\", \"media_service_unittests\": \"67211f69e8776f19f47bd3958cc1ffffc1abc22f\", \"media_unittests\": \"de53620e79df94ff9709a880cc1721afcd259b6b\", \"message_center_unittests\": \"beb336f7d41c2761996a66aca6a173a5c02b8b59\", \"midi_unittests\": \"0fa373a3773b4126c1ac9fbbadf80ccc6282b2aa\", \"mojo_core_unittests\": \"b936f5f5645bc9e907808424d162492b26c196d8\", \"mojo_unittests\": \"50877d6a22b04a56938fddc417200dee78f4ce67\", \"nacl_helper_nonsfi_unittests\": \"8e7ccdaeea13fe10748cc7ce7375c8159083bf1b\", \"nacl_loader_unittests\": \"93514dfbc75290ab17a75adb17f2be4cafdf0e87\", \"native_theme_unittests\": \"2c468ad32e1270b382cbc095fe78133dd8ad2ad3\", \"net_unittests\": \"49b8457d66744685adfcda07f47a8c8abaa0207d\", \"ozone_gl_unittests\": \"7837f3a41af5682ad7dfa08766981fa5085f9707\", \"ozone_unittests\": \"dd60b056f3b65027c8e73975dedaa70a4db4e358\", \"ozone_x11_unittests\": \"c72f351e49152ed283988c84869ad36c845a49f0\", \"pdf_unittests\": \"ba5619d3dac0c055c6b4599c2f1b0a3c2f8f00ab\", \"perfetto_unittests\": \"c131c52be83644490710dfcf20d27a9be05bd86d\", \"ppapi_unittests\": \"d29d58d2e470afb838892c5b10a15b303017c433\", \"printing_unittests\": \"b77bc6376097baa80eacae3483015df9d3f8122d\", \"remoting_unittests\": \"0dd8406dcbd151deda328acdf467f4acdd368ff5\", \"sandbox_linux_unittests\": \"7ec5d4d8c53de776ca753bacdcca746323f01d32\", \"service_manager_unittests\": \"baeb094d8aa591a794862df711e2b97ef3efb5de\", \"services_unittests\": \"bce678f08635397447d5c3b640568289a01722b4\", \"shell_dialogs_unittests\": \"0bd05cd06bc64f96dec7ef1c0303a21d6eddd783\", \"skia_unittests\": \"3dcdc34d88128efa9180c64f4ad289b6ea16ef80\", \"snapshot_unittests\": \"d9be5178b57579a1181accef80983a0be2b7a743\", \"sql_unittests\": \"c8dd7eff07fcdab26a54504a45fe91543803cd66\", \"storage_unittests\": \"46c5b2bf604bbb9f02f11050f02997d00b1bb1ac\", \"sync_integration_tests\": \"4e6a24db92d0d4e154b4d6db9246b92dd062ee06\", \"traffic_annotation_auditor_unittests\": \"3887c70ee7dfc3ec490c8ec84be6ab85afc2e386\", \"ui_base_unittests\": \"93433c39bfa487934c24728459153398b6a4c102\", \"ui_chromeos_unittests\": \"967525d87fa157b285981933824d4aabe8716ba3\", \"ui_touch_selection_unittests\": \"7b47fc9a2a5504f1f03c1676ac52c0389064cf4f\", \"unit_tests\": \"0631dbe31a4eae7c83f7a9d344b5eb6939078a20\", \"url_unittests\": \"451f1b3ff8bcaf5b94a69266808453b1076b894e\", \"usage_time_limit_unittests\": \"73e10b3b06df06976a515b3a91f1cdea68512922\", \"views_unittests\": \"d68dfe6357225e8abeb0e43d3a6871eb27382060\", \"viz_unittests\": \"320c1e115397c2eb3cfd25ae0cededf97dc47e01\", \"wm_unittests\": \"b038961143589e3f43506f6b8a2ab39f5573053f\", \"wtf_unittests\": \"b86d21c25e4a1d0a9b327b4ae2d6df3c2796c1ac\"}, \"swarm_hashes_refs/heads/master(at){#709350}_without_patch\": {\"accessibility_unittests\": \"9fc123c127ec3877ed4ad8b11312af288e6bcf8c\", \"angle_unittests\": \"ce6f7f4257f80fcc7dc5c6b469af10ba338664c3\", \"app_list_unittests\": \"6df19e6eb901ed7072feb1fbcac18fa651267d4a\", \"app_shell_unittests\": \"7e3437abc09e2b942bea784eac7e6a1f2e7d3b1c\", \"ash_unittests\": \"c5e3eecedac7704c5ea57e3d634edf946c77c723\", \"aura_unittests\": \"6a9ea2193a9d41b9673ac6084da8104030002c1a\", \"base_unittests\": \"9eba2f244082c3aa5633d6464162a5df56d9c395\", \"base_util_unittests\": \"45092edc9e29d80728b07c38edf6135e0467918b\", \"blink_common_unittests\": \"e0ab83d61ffe38f1310f1e7c1960398e9b6db093\", \"blink_fuzzer_unittests\": \"763e6f233dbbdfe8dc451ee9b54f95d42df8cffe\", \"blink_heap_unittests\": \"868fb11961d27c13556294e3a41193612ad445bd\", \"blink_platform_unittests\": \"25bc9d33e4d809643d0144e947968c9f4db0f91a\", \"blink_unittests\": \"6cb78edfe0b26a0d650be568105b1a1e7a5b222f\", \"boringssl_crypto_tests\": \"225fe1e85f46ab78b3db9f42efb46c2901d21d9f\", \"boringssl_ssl_tests\": \"e1540f987157632fa3565a5f6246663d5ee0b51f\", \"browser_tests\": \"ed57d879f5c5d9f218e5d9813b557fef8b54a8f7\", \"cacheinvalidation_unittests\": \"df0ffca3285d01233e9ef30549d677ba0786f134\", \"capture_unittests\": \"557d87e9368bc54c2a95f72ed733b54dbfdec764\", \"cast_unittests\": \"faa1cf397fc2a26cb625d384fbb472555674ac58\", \"cc_unittests\": \"e4a8ac463292de4cd11585d1a645f2d18a45f6ec\", \"chrome_app_unittests\": \"044a175a215706a1834986ef3c112e8db15da1ac\", \"chromedriver_unittests\": \"2028973b667ebd2d712e12ce6ceb82a062fc3526\", \"chromeos_components_unittests\": \"a3aa198ab57b076c1200e95be23dc54936130c30\", \"chromeos_unittests\": \"5c3d81ce0e519c94ed54ac868334b1db6515a45b\", \"color_unittests\": \"1726bf4d9cfd714debcb7af5209f62209d5879a1\", \"components_browsertests\": \"9edf71c3c687ad268c9a649d385d178d55e4cef0\", \"components_unittests\": \"c2a2983bbc2bfc6980da1c2097e74bf50a6b86cc\", \"compositor_unittests\": \"a0c73c593590b0ef3223f36c81498715d3b5f4a1\", \"content_browsertests\": \"e0afec07d2f7a79a7e3d76ee962abe291940d2e3\", \"content_unittests\": \"25a3b27adfb2484ab5c8f77c81c758cc06f2a5ef\", \"crypto_unittests\": \"d4e60183278c5516c95ef3fa85d3032a8a7e3e4d\", \"dbus_unittests\": \"361d6063022cd9866f65455d13c97cc29f3c4f48\", \"device_unittests\": \"7b129f82c9f7a6c622fde24b101b378a7cbc288b\", \"display_unittests\": \"9b0a6ed43706137138de02ee9a33cf47082eb7a4\", \"events_unittests\": \"60cd2f45829bd99bece60489531ee72c272da2c7\", \"exo_unittests\": \"90292981f3fae1b6ed52a6a90dc2a7c3bcef33dd\", \"extensions_browsertests\": \"3d1b9def246b44b14e8c7dd5436119e1ca3a35da\", \"extensions_unittests\": \"553bb69933bb825280983d37217f8d9e91f5e5c6\", \"filesystem_service_unittests\": \"6be3f6958a6d1f9ee4948217094b137a2da757a4\", \"gcm_unit_tests\": \"842d8e0ebce37b611b8b68d3ae7e55008fd6700a\", \"gfx_unittests\": \"ce52623ce791de367932f44887b38bd906b444a9\", \"gin_unittests\": \"7c5fa0a8c3b4cb5291326d8d44796a65c2f4b7c8\", \"gl_unittests_ozone\": \"07deac1c07bd4ca58b468bb1e7332f202405e97f\", \"google_apis_unittests\": \"3c87dea97c6b8366f3b6a3d45d111771f18f03a8\", \"gpu_unittests\": \"f5bfa3b068051e70b301316441a61a5b17130f9d\", \"gwp_asan_unittests\": \"63997379fd06b3755aa740ee6543f94d4dc029a5\", \"interactive_ui_tests\": \"c3544cc0c11e8789b44f0273e69c8dd535fbd1cf\", \"ipc_tests\": \"93fa9a9afdda5b910e8c93b4dc8991f8827f157a\", \"jingle_unittests\": \"1cdefb9236d6debffea9318489fa37ceb59aefd7\", \"keyboard_unittests\": \"95e5addd81a07a322ceb3f0ba6f3e4b2d8835028\", \"latency_unittests\": \"9ddc71bf088cf7a95331a43e53833662bc9932ef\", \"libjingle_xmpp_unittests\": \"cfe2ccdbc95503b300aae21151c34aabe981e476\", \"media_blink_unittests\": \"7a6da49d7fb3b80eadfa4cac5700e4e4bbb3ab4b\", \"media_service_unittests\": \"67211f69e8776f19f47bd3958cc1ffffc1abc22f\", \"media_unittests\": \"de53620e79df94ff9709a880cc1721afcd259b6b\", \"message_center_unittests\": \"beb336f7d41c2761996a66aca6a173a5c02b8b59\", \"midi_unittests\": \"0fa373a3773b4126c1ac9fbbadf80ccc6282b2aa\", \"mojo_core_unittests\": \"b936f5f5645bc9e907808424d162492b26c196d8\", \"mojo_unittests\": \"50877d6a22b04a56938fddc417200dee78f4ce67\", \"nacl_helper_nonsfi_unittests\": \"8e7ccdaeea13fe10748cc7ce7375c8159083bf1b\", \"nacl_loader_unittests\": \"93514dfbc75290ab17a75adb17f2be4cafdf0e87\", \"native_theme_unittests\": \"2c468ad32e1270b382cbc095fe78133dd8ad2ad3\", \"net_unittests\": \"49b8457d66744685adfcda07f47a8c8abaa0207d\", \"ozone_gl_unittests\": \"7837f3a41af5682ad7dfa08766981fa5085f9707\", \"ozone_unittests\": \"dd60b056f3b65027c8e73975dedaa70a4db4e358\", \"ozone_x11_unittests\": \"c72f351e49152ed283988c84869ad36c845a49f0\", \"pdf_unittests\": \"ba5619d3dac0c055c6b4599c2f1b0a3c2f8f00ab\", \"perfetto_unittests\": \"c131c52be83644490710dfcf20d27a9be05bd86d\", \"ppapi_unittests\": \"d29d58d2e470afb838892c5b10a15b303017c433\", \"printing_unittests\": \"b77bc6376097baa80eacae3483015df9d3f8122d\", \"remoting_unittests\": \"0dd8406dcbd151deda328acdf467f4acdd368ff5\", \"sandbox_linux_unittests\": \"7ec5d4d8c53de776ca753bacdcca746323f01d32\", \"service_manager_unittests\": \"baeb094d8aa591a794862df711e2b97ef3efb5de\", \"services_unittests\": \"bce678f08635397447d5c3b640568289a01722b4\", \"shell_dialogs_unittests\": \"0bd05cd06bc64f96dec7ef1c0303a21d6eddd783\", \"skia_unittests\": \"3dcdc34d88128efa9180c64f4ad289b6ea16ef80\", \"snapshot_unittests\": \"d9be5178b57579a1181accef80983a0be2b7a743\", \"sql_unittests\": \"c8dd7eff07fcdab26a54504a45fe91543803cd66\", \"storage_unittests\": \"46c5b2bf604bbb9f02f11050f02997d00b1bb1ac\", \"sync_integration_tests\": \"4e6a24db92d0d4e154b4d6db9246b92dd062ee06\", \"traffic_annotation_auditor_unittests\": \"3887c70ee7dfc3ec490c8ec84be6ab85afc2e386\", \"ui_base_unittests\": \"93433c39bfa487934c24728459153398b6a4c102\", \"ui_chromeos_unittests\": \"967525d87fa157b285981933824d4aabe8716ba3\", \"ui_touch_selection_unittests\": \"7b47fc9a2a5504f1f03c1676ac52c0389064cf4f\", \"unit_tests\": \"0631dbe31a4eae7c83f7a9d344b5eb6939078a20\", \"url_unittests\": \"451f1b3ff8bcaf5b94a69266808453b1076b894e\", \"usage_time_limit_unittests\": \"73e10b3b06df06976a515b3a91f1cdea68512922\", \"views_unittests\": \"d68dfe6357225e8abeb0e43d3a6871eb27382060\", \"viz_unittests\": \"320c1e115397c2eb3cfd25ae0cededf97dc47e01\", \"wm_unittests\": \"b038961143589e3f43506f6b8a2ab39f5573053f\", \"wtf_unittests\": \"b86d21c25e4a1d0a9b327b4ae2d6df3c2796c1ac\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_58f95b007ea60c168bc176676490abae5757dcf141e4048bdc7ee9af9ae02cf5_v2\", \"builder_6a38e0474de1b7f2422cff5410334c2aadd58906a655d607d612452c757696a4_v2\", \"builder_b9373cfdcc5f43b5e07cc4931fc34027757a424c7183ae2b31ae65ec7718ca12_v2\", \"builder_e7fd4b7a9e211f8d968af60263c508e13e49814167aff980c2bf239c05ea48ef_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-52-i66j\"], \"image\": [\"chrome-xenial-19101700-60651c0b41e\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4549-8dc3ae7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"3 Test Suite(s) failed.\\n\\n**non_viz_browser_tests** failed because of:\\n\\n- ChromeOsMirrorAccountConsistencyTest.TestMirrorRequestChromeOsNotChildAccount\\n\\n- OobeGuestButtonPolicy.VisibilityAfterEnrollment/0\\n\\n- SAMLPasswordAttributesSuite/SAMLPasswordAttributesTest.LoginSucceeded/1\\n\\n- SAMLPasswordAttributesSuite/SAMLPasswordAttributesTest.LoginSucceeded/0\\n\\n- ...9 more failure(s) (13 total)...\\n\\n**browser_tests** failed because of:\\n\\n- ChromeVoxBackgroundTest.ReinsertedNodeRecovery\\n\\n- ShareAndManageDialog/FilesAppBrowserTest.Test/shareTeamDrive\\n\\n- OAuth2Test.VerifyNotInAdvancedProtectionAfterOnlineAuth\\n\\n- ChromeVoxLiveRegionsTest.LiveRegionChangeAtomicText\\n\\n- ...40 more failure(s) (44 total)...\\n\\n**unit_tests** failed because of:\\n\\n- WebAppDataRetrieverTest.GetWebApplicationInfo_FrameNavigated\\n\\n- ...174 more failure(s) (175 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1571974302206505",
"status": "COMPLETED",
"status_changed_ts": "1571974302900936",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/14971",
"builder:linux-chromeos-dbg",
"buildset:commit/git/5a679ec549b7e707c966f299a13c12d114bde4a1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5a679ec549b7e707c966f299a13c12d114bde4a1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064089412164658448",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8898659350121464432/+/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:4819c7fe4a8edc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1571979727049954",
"url": "https://ci.chromium.org/b/8898659350121464432",
"utcnow_ts": "1571979729670960"
}
}
[05:02:09.704] Invocation finished in 1h33m1.487373899s with status FAILED