[13:42:58.516] New invocation is queued and will start shortly
[13:42:59.947] Starting the invocation (attempt 1)
[13:42:59.984] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:42:59.984] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:42:59.984] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9066225120009877488",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"f9ffca114b52deb6afee0a8f88e308b75f800cba\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9066225120009877488",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/f9ffca114b52deb6afee0a8f88e308b75f800cba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f9ffca114b52deb6afee0a8f88e308b75f800cba",
"gitiles_ref:refs/heads/master"
]
}
[13:43:01.958] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1569937380596265",
"id": "8900795057162757728",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f9ffca114b52deb6afee0a8f88e308b75f800cba\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1569937381627904",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/14623",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f9ffca114b52deb6afee0a8f88e308b75f800cba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f9ffca114b52deb6afee0a8f88e308b75f800cba",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9066225120009877488",
"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/8900795057162757728/+/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": "1569937381628023",
"url": "https://ci.chromium.org/b/8900795057162757728",
"utcnow_ts": "1569937381937976"
}
}
[13:43:01.958] Task URL: https://ci.chromium.org/b/8900795057162757728
[13:43:01.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:2:0) after 1m0s
[13:43:33.678] Received PubSub notification, asking Buildbucket for the build status
[13:43:34.073] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:02.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:2:0)
[13:44:02.028] Timer tick, asking Buildbucket for the build status
[13:44:03.036] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:03.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:4:0) after 1m0s
[13:45:03.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:4:0)
[13:45:03.108] Timer tick, asking Buildbucket for the build status
[13:45:03.295] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:03.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:5:0) after 1m0s
[13:46:03.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:5:0)
[13:46:03.337] Timer tick, asking Buildbucket for the build status
[13:46:03.551] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:03.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:6:0) after 1m0s
[13:47:03.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:6:0)
[13:47:03.706] Timer tick, asking Buildbucket for the build status
[13:47:03.854] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:03.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:7:0) after 1m0s
[13:48:03.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:7:0)
[13:48:03.938] Timer tick, asking Buildbucket for the build status
[13:48:04.316] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:04.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:8:0) after 1m0s
[13:49:04.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:8:0)
[13:49:04.346] Timer tick, asking Buildbucket for the build status
[13:49:05.330] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:05.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:9:0) after 1m0s
[13:50:05.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:9:0)
[13:50:05.372] Timer tick, asking Buildbucket for the build status
[13:50:06.711] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:06.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:10:0) after 1m0s
[13:51:06.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:10:0)
[13:51:06.740] Timer tick, asking Buildbucket for the build status
[13:51:07.494] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:07.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:11:0) after 1m0s
[13:52:07.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:11:0)
[13:52:07.584] Timer tick, asking Buildbucket for the build status
[13:52:08.886] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:08.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:12:0) after 1m0s
[13:53:08.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:12:0)
[13:53:08.947] Timer tick, asking Buildbucket for the build status
[13:53:09.811] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:09.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:13:0) after 1m0s
[13:54:09.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:13:0)
[13:54:09.927] Timer tick, asking Buildbucket for the build status
[13:54:11.111] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:11.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:14:0) after 1m0s
[13:55:11.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:14:0)
[13:55:11.231] Timer tick, asking Buildbucket for the build status
[13:55:11.541] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:11.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:15:0) after 1m0s
[13:56:11.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:15:0)
[13:56:11.651] Timer tick, asking Buildbucket for the build status
[13:56:11.870] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:11.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:16:0) after 1m0s
[13:57:11.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:16:0)
[13:57:11.994] Timer tick, asking Buildbucket for the build status
[13:57:12.198] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:12.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:17:0) after 1m0s
[13:58:12.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:17:0)
[13:58:12.258] Timer tick, asking Buildbucket for the build status
[13:58:13.128] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:13.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:18:0) after 1m0s
[13:59:13.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:18:0)
[13:59:13.229] Timer tick, asking Buildbucket for the build status
[13:59:15.170] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:15.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:19:0) after 1m0s
[14:00:15.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:19:0)
[14:00:15.232] Timer tick, asking Buildbucket for the build status
[14:00:15.526] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:15.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:20:0) after 1m0s
[14:01:15.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:20:0)
[14:01:15.648] Timer tick, asking Buildbucket for the build status
[14:01:16.184] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:16.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:21:0) after 1m0s
[14:02:16.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:21:0)
[14:02:16.212] Timer tick, asking Buildbucket for the build status
[14:02:17.349] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:17.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:22:0) after 1m0s
[14:03:17.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:22:0)
[14:03:17.472] Timer tick, asking Buildbucket for the build status
[14:03:17.694] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:17.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:23:0) after 1m0s
[14:04:17.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:23:0)
[14:04:17.763] Timer tick, asking Buildbucket for the build status
[14:04:18.014] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:18.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:24:0) after 1m0s
[14:05:18.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:24:0)
[14:05:18.099] Timer tick, asking Buildbucket for the build status
[14:05:18.287] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:18.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:25:0) after 1m0s
[14:06:18.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:25:0)
[14:06:18.339] Timer tick, asking Buildbucket for the build status
[14:06:18.559] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:18.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:26:0) after 1m0s
[14:07:18.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:26:0)
[14:07:18.740] Timer tick, asking Buildbucket for the build status
[14:07:18.923] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:18.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:27:0) after 1m0s
[14:08:18.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:27:0)
[14:08:18.989] Timer tick, asking Buildbucket for the build status
[14:08:19.648] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:19.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:28:0) after 1m0s
[14:09:19.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:28:0)
[14:09:19.675] Timer tick, asking Buildbucket for the build status
[14:09:20.199] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:20.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:29:0) after 1m0s
[14:10:20.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:29:0)
[14:10:20.257] Timer tick, asking Buildbucket for the build status
[14:10:20.443] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:20.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:30:0) after 1m0s
[14:11:20.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:30:0)
[14:11:20.457] Timer tick, asking Buildbucket for the build status
[14:11:21.909] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:21.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:31:0) after 1m0s
[14:12:21.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:31:0)
[14:12:21.972] Timer tick, asking Buildbucket for the build status
[14:12:23.140] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:23.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:32:0) after 1m0s
[14:13:23.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:32:0)
[14:13:23.157] Timer tick, asking Buildbucket for the build status
[14:13:23.511] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:23.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:33:0) after 1m0s
[14:14:23.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:33:0)
[14:14:23.620] Timer tick, asking Buildbucket for the build status
[14:14:24.108] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:24.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:34:0) after 1m0s
[14:15:24.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:34:0)
[14:15:24.178] Timer tick, asking Buildbucket for the build status
[14:15:24.912] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:24.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:35:0) after 1m0s
[14:16:24.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:35:0)
[14:16:24.979] Timer tick, asking Buildbucket for the build status
[14:16:29.115] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:29.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:36:0) after 1m0s
[14:17:29.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:36:0)
[14:17:29.237] Timer tick, asking Buildbucket for the build status
[14:17:30.135] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:30.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:37:0) after 1m0s
[14:18:30.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:37:0)
[14:18:30.222] Timer tick, asking Buildbucket for the build status
[14:18:32.499] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:32.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:38:0) after 1m0s
[14:19:32.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:38:0)
[14:19:32.574] Timer tick, asking Buildbucket for the build status
[14:19:33.576] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:33.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:39:0) after 1m0s
[14:20:33.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:39:0)
[14:20:33.673] Timer tick, asking Buildbucket for the build status
[14:20:33.909] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:33.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:40:0) after 1m0s
[14:21:34.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:40:0)
[14:21:34.093] Timer tick, asking Buildbucket for the build status
[14:21:36.045] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:36.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:41:0) after 1m0s
[14:22:36.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:41:0)
[14:22:36.382] Timer tick, asking Buildbucket for the build status
[14:22:36.656] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:36.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:42:0) after 1m0s
[14:23:36.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:42:0)
[14:23:36.772] Timer tick, asking Buildbucket for the build status
[14:23:37.344] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:37.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:43:0) after 1m0s
[14:24:37.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:43:0)
[14:24:37.471] Timer tick, asking Buildbucket for the build status
[14:24:41.745] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:41.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:44:0) after 1m0s
[14:25:41.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:44:0)
[14:25:41.863] Timer tick, asking Buildbucket for the build status
[14:25:43.467] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:43.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:45:0) after 1m0s
[14:26:43.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:45:0)
[14:26:43.565] Timer tick, asking Buildbucket for the build status
[14:26:43.756] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:43.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:46:0) after 1m0s
[14:27:43.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:46:0)
[14:27:43.781] Timer tick, asking Buildbucket for the build status
[14:27:44.019] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:44.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:47:0) after 1m0s
[14:28:44.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:47:0)
[14:28:44.152] Timer tick, asking Buildbucket for the build status
[14:28:44.317] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:44.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:48:0) after 1m0s
[14:29:44.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:48:0)
[14:29:44.416] Timer tick, asking Buildbucket for the build status
[14:29:45.192] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:45.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:49:0) after 1m0s
[14:30:45.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:49:0)
[14:30:45.237] Timer tick, asking Buildbucket for the build status
[14:30:45.987] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:45.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:50:0) after 1m0s
[14:31:46.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:50:0)
[14:31:46.086] Timer tick, asking Buildbucket for the build status
[14:31:47.394] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:47.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:51:0) after 1m0s
[14:32:47.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:51:0)
[14:32:47.477] Timer tick, asking Buildbucket for the build status
[14:32:47.761] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:47.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:52:0) after 1m0s
[14:33:47.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:52:0)
[14:33:47.826] Timer tick, asking Buildbucket for the build status
[14:33:48.241] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:48.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:53:0) after 1m0s
[14:34:48.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:53:0)
[14:34:48.277] Timer tick, asking Buildbucket for the build status
[14:34:48.640] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:48.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:54:0) after 1m0s
[14:35:48.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:54:0)
[14:35:48.726] Timer tick, asking Buildbucket for the build status
[14:35:48.924] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:48.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:55:0) after 1m0s
[14:36:48.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:55:0)
[14:36:48.999] Timer tick, asking Buildbucket for the build status
[14:36:49.847] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:49.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:56:0) after 1m0s
[14:37:49.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:56:0)
[14:37:49.878] Timer tick, asking Buildbucket for the build status
[14:37:50.064] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:50.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:57:0) after 1m0s
[14:38:50.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:57:0)
[14:38:50.073] Timer tick, asking Buildbucket for the build status
[14:38:50.271] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:50.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:58:0) after 1m0s
[14:39:50.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:58:0)
[14:39:50.884] Timer tick, asking Buildbucket for the build status
[14:39:53.140] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:53.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:59:0) after 1m0s
[14:40:53.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:59:0)
[14:40:53.228] Timer tick, asking Buildbucket for the build status
[14:40:53.410] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:53.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:60:0) after 1m0s
[14:41:53.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:60:0)
[14:41:53.500] Timer tick, asking Buildbucket for the build status
[14:41:54.014] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:54.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:61:0) after 1m0s
[14:42:54.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:61:0)
[14:42:54.192] Timer tick, asking Buildbucket for the build status
[14:42:54.823] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:54.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:62:0) after 1m0s
[14:43:54.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:62:0)
[14:43:54.964] Timer tick, asking Buildbucket for the build status
[14:43:57.741] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:57.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:63:0) after 1m0s
[14:44:57.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:63:0)
[14:44:57.843] Timer tick, asking Buildbucket for the build status
[14:45:00.637] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:00.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:64:0) after 1m0s
[14:46:00.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:64:0)
[14:46:00.783] Timer tick, asking Buildbucket for the build status
[14:46:01.637] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:01.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:65:0) after 1m0s
[14:47:01.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:65:0)
[14:47:01.784] Timer tick, asking Buildbucket for the build status
[14:47:04.561] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:04.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:66:0) after 1m0s
[14:48:04.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:66:0)
[14:48:04.638] Timer tick, asking Buildbucket for the build status
[14:48:04.828] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:04.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:67:0) after 1m0s
[14:49:04.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:67:0)
[14:49:04.974] Timer tick, asking Buildbucket for the build status
[14:49:05.272] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:05.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:68:0) after 1m0s
[14:50:05.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:68:0)
[14:50:05.407] Timer tick, asking Buildbucket for the build status
[14:50:05.750] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:05.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:69:0) after 1m0s
[14:51:05.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:69:0)
[14:51:05.842] Timer tick, asking Buildbucket for the build status
[14:51:06.298] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:06.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:70:0) after 1m0s
[14:52:06.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:70:0)
[14:52:06.366] Timer tick, asking Buildbucket for the build status
[14:52:07.134] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:07.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:71:0) after 1m0s
[14:53:07.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:71:0)
[14:53:07.282] Timer tick, asking Buildbucket for the build status
[14:53:07.434] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:07.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:72:0) after 1m0s
[14:54:07.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:72:0)
[14:54:07.583] Timer tick, asking Buildbucket for the build status
[14:54:08.309] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:08.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:73:0) after 1m0s
[14:55:08.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:73:0)
[14:55:08.379] Timer tick, asking Buildbucket for the build status
[14:55:08.731] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:08.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:74:0) after 1m0s
[14:56:08.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:74:0)
[14:56:08.814] Timer tick, asking Buildbucket for the build status
[14:56:09.839] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:09.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:75:0) after 1m0s
[14:57:09.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:75:0)
[14:57:09.941] Timer tick, asking Buildbucket for the build status
[14:57:10.296] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:10.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:76:0) after 1m0s
[14:58:10.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:76:0)
[14:58:10.447] Timer tick, asking Buildbucket for the build status
[14:58:10.578] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:10.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:77:0) after 1m0s
[14:59:10.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:77:0)
[14:59:10.640] Timer tick, asking Buildbucket for the build status
[14:59:10.869] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:10.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:78:0) after 1m0s
[15:00:10.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:78:0)
[15:00:10.946] Timer tick, asking Buildbucket for the build status
[15:00:11.161] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:11.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:79:0) after 1m0s
[15:01:11.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:79:0)
[15:01:11.278] Timer tick, asking Buildbucket for the build status
[15:01:12.055] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:12.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:80:0) after 1m0s
[15:02:12.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:80:0)
[15:02:12.137] Timer tick, asking Buildbucket for the build status
[15:02:12.444] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:12.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:81:0) after 1m0s
[15:03:12.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:81:0)
[15:03:12.602] Timer tick, asking Buildbucket for the build status
[15:03:12.819] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:12.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:82:0) after 1m0s
[15:04:12.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:82:0)
[15:04:12.977] Timer tick, asking Buildbucket for the build status
[15:04:13.362] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:13.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:83:0) after 1m0s
[15:05:13.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:83:0)
[15:05:13.612] Timer tick, asking Buildbucket for the build status
[15:05:13.795] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:13.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:84:0) after 1m0s
[15:06:13.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:84:0)
[15:06:13.969] Timer tick, asking Buildbucket for the build status
[15:06:14.279] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:14.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:85:0) after 1m0s
[15:07:14.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:85:0)
[15:07:14.314] Timer tick, asking Buildbucket for the build status
[15:07:16.369] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:16.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:86:0) after 1m0s
[15:08:16.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:86:0)
[15:08:16.536] Timer tick, asking Buildbucket for the build status
[15:08:18.318] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:18.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:87:0) after 1m0s
[15:09:18.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:87:0)
[15:09:18.446] Timer tick, asking Buildbucket for the build status
[15:09:19.056] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:19.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:88:0) after 1m0s
[15:10:19.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:88:0)
[15:10:19.178] Timer tick, asking Buildbucket for the build status
[15:10:19.429] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:19.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:89:0) after 1m0s
[15:11:19.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:89:0)
[15:11:19.506] Timer tick, asking Buildbucket for the build status
[15:11:19.700] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:19.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:90:0) after 1m0s
[15:12:19.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:90:0)
[15:12:19.739] Timer tick, asking Buildbucket for the build status
[15:12:20.174] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:20.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:91:0) after 1m0s
[15:13:20.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:91:0)
[15:13:20.240] Timer tick, asking Buildbucket for the build status
[15:13:20.511] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:20.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:92:0) after 1m0s
[15:14:20.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:92:0)
[15:14:20.579] Timer tick, asking Buildbucket for the build status
[15:14:20.829] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:20.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:93:0) after 1m0s
[15:15:20.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:93:0)
[15:15:20.940] Timer tick, asking Buildbucket for the build status
[15:15:21.173] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:21.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:94:0) after 1m0s
[15:16:21.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:94:0)
[15:16:21.295] Timer tick, asking Buildbucket for the build status
[15:16:21.922] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:21.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:95:0) after 1m0s
[15:17:21.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:95:0)
[15:17:21.972] Timer tick, asking Buildbucket for the build status
[15:17:22.590] Build 8900795057162757728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:22.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9066225120009877488:96:0) after 1m0s
[15:17:54.402] Received PubSub notification, asking Buildbucket for the build status
[15:17:55.982] Build 8900795057162757728: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[15:17:55.982] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1569943072858853",
"created_by": "project:chromium",
"created_ts": "1569937380596265",
"failure_reason": "BUILD_FAILURE",
"id": "8900795057162757728",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f9ffca114b52deb6afee0a8f88e308b75f800cba\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**non_viz_browser_tests** failed because of:\\n\\n- DirectoryTreeContextMenu/FilesAppBrowserTest.Test/dirCreateMultipleFolders\"}, \"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-central1-b-8-72-48ch\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 14623, \"got_angle_revision\": \"087f1384f233792921d34c0ca5b5a90fac75b070\", \"got_dawn_revision\": \"deb28ea45d0dd00e52026ae227d856582546ca9d\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"f9ffca114b52deb6afee0a8f88e308b75f800cba\", \"got_revision_cp\": \"refs/heads/master@{#701543}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"f85c93271e01607faa00cbc330301d5b0418c3d1\", \"got_v8_revision_cp\": \"refs/heads/7.9.170@{#1}\", \"got_webrtc_revision\": \"b3bb2040a15c90ba9aff4a73e8dc028b42289edc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29354}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f9ffca114b52deb6afee0a8f88e308b75f800cba\", \"swarm_hashes\": {\"accessibility_unittests\": \"72e3d81ecec2b096f3a6c22a8c6fcdd55262bfcc\", \"angle_unittests\": \"e2beea66b6a3c50236f2aed4224bb2e58a7623f5\", \"app_list_unittests\": \"f1d658ff64306e1e8f9f9ff696562b018f7c043c\", \"app_shell_unittests\": \"1eb10b348204c4a5945e62a8561c3e7ca274b3c0\", \"ash_unittests\": \"9dc005fd21fd437a6bf198faee020a5ada6f3280\", \"aura_unittests\": \"c24daa77e23c6623a6ca3197ed76986b64c0fc4b\", \"base_unittests\": \"397ebb307dfc12648259d12b17c561cf703b60df\", \"base_util_unittests\": \"66bd2443610abce1c27fe4fa7ac0068182520fad\", \"blink_common_unittests\": \"306fd418cdbecd1d07b1243ea22506e2a4acba5d\", \"blink_fuzzer_unittests\": \"2db4efb111929ec2ea825a15ff83b5e808e9d2c9\", \"blink_heap_unittests\": \"545cfdab51a5b36c68eda2f524d1ed64e253fc92\", \"blink_platform_unittests\": \"b549efb34128a3da0b23537ae2b01199bed0bd1b\", \"blink_unittests\": \"f03795a5a51750386481d5a390ff581645b2e8e4\", \"boringssl_crypto_tests\": \"3eff93dcb90a51cb5994ad671a575d24bd35910b\", \"boringssl_ssl_tests\": \"bbf51b47a93d6fbce748a104a829dbc19683239b\", \"browser_tests\": \"ded0e2c72d9d01ed258acb2ec819bf66d912bdbe\", \"cacheinvalidation_unittests\": \"138d0754b017199c55175340a0008525c8a8a1eb\", \"capture_unittests\": \"33a57d9c81b7a09f21c9649b27b8f86d7d6116e0\", \"cast_unittests\": \"dbb8cc030cb3bbf643647f09000daa301c53cd01\", \"cc_unittests\": \"5075938bc5f2c515c1593c7791aff30e2b01e597\", \"chrome_app_unittests\": \"f8ab60b6e726a429e9a8b147204e142d418dd923\", \"chromedriver_unittests\": \"c14dedf524c5e4f0e4f67fefd15c1d243eca6aa8\", \"chromeos_components_unittests\": \"5ef80a57c969fdcf1ffcea63af452bd51cea7c9e\", \"chromeos_unittests\": \"421942e5e63a7ce2d65c6fb8a4ac82464477a1a7\", \"color_unittests\": \"70da7e4418562430636c4ef76977b3ba4e21481f\", \"components_browsertests\": \"e3d2d5e63e9c6f47313cc84cc69230afee62fa86\", \"components_unittests\": \"fdee3f891fa8411ce6015537dd8a1fbbd0d25c74\", \"compositor_unittests\": \"0cedb06b7f143c414837359de4b0464ddb40975e\", \"content_browsertests\": \"740fae6822882368722d4db38ac08747180afa2b\", \"content_unittests\": \"b06e9e00c125967f3a8f2aaf8ad2c7fbaab13e7a\", \"crypto_unittests\": \"38e0ef91e576b0110d5ecdcd7b0868f5c7627aaa\", \"dbus_unittests\": \"cce2b0e75aa9595ab3071f8f4273cc71327a7eb2\", \"device_unittests\": \"2c966a35dd60caec0dd1555ae04488f34d39af59\", \"display_unittests\": \"2203d8e9c177043ecfb51020adf3ff6009e24528\", \"events_unittests\": \"eca98fcbfc0698d9a6ed8b946f10c36ddc6df58b\", \"exo_unittests\": \"9d97d4a87a33f8f3f28e9719e6f607bd1672940f\", \"extensions_browsertests\": \"c079d2e72e5ff750b65a4c9ddcd71fa071607ac8\", \"extensions_unittests\": \"2a6ce8634a785123879f7cd453512616ea2eb9c5\", \"filesystem_service_unittests\": \"0eb88ec58c13563200acaed999c8cb42559b8139\", \"gcm_unit_tests\": \"a115253d082a1c9a907a68854c5ce37d91313817\", \"gfx_unittests\": \"da09a0992fde3cc078e67855697cef467ced78f3\", \"gin_unittests\": \"6e3ba967b5cfbaeb76786d1d52270489da63beb2\", \"gl_unittests_ozone\": \"10ac8f6a74ea519ac727019188464ca2d5e44a0c\", \"google_apis_unittests\": \"8f9ad8da1e5d8a784a5c020c4091afb692eef38d\", \"gpu_unittests\": \"d2eb9c81c6b40b2364db045f3dc10d147b55cd42\", \"gwp_asan_unittests\": \"8a9c25a31e4d70a60b45d32bebee7a9303a91ccc\", \"interactive_ui_tests\": \"2d8e429ba10f598a8643ca97520f30cfdc8f7812\", \"ipc_tests\": \"51978626b27aa1eb45704ceaf472c6484084cf24\", \"jingle_unittests\": \"e54a1623354ee29767ed86195bb99c6dbefa18f1\", \"keyboard_unittests\": \"7ddb78760aca8080e7c01670afea164949a03ecd\", \"latency_unittests\": \"79785c208bd700ed8a39420e7878f0692bad0e52\", \"leveldb_service_unittests\": \"46a8415a975f277b9393648e830a795d9b5d914b\", \"libjingle_xmpp_unittests\": \"89b88da213333daa496ba70c2bf93a5c8caea561\", \"media_blink_unittests\": \"210adde34f483045783b51db777ce5a45932e251\", \"media_service_unittests\": \"81e47e1e7a17acdec82eeb1ab41d928d42b90030\", \"media_unittests\": \"863a9f45f903da6f9534507c89a6591daa481a9f\", \"message_center_unittests\": \"7acf195b19d0aa41675cddb15e449f4aafe94b61\", \"midi_unittests\": \"1ffa54452ba752d19de20d275cef23331791eaaf\", \"mojo_core_unittests\": \"e0bad75294e02cc42825c55cab4cdb573c25ff4e\", \"mojo_unittests\": \"1b36020f392779e42346a358dbe161102c3d629f\", \"nacl_helper_nonsfi_unittests\": \"a5f431a7611e00dd8ec1f0ddc3ff57ec994d8f4f\", \"nacl_loader_unittests\": \"7196955d0a0a193a5ca744304fd99a2c2bfb1178\", \"native_theme_unittests\": \"b00275666badcc7c3ad4beaf941be4983b8a768c\", \"net_unittests\": \"f03bf4279ff0e9ecdf1f4649fd364c3e0d552cea\", \"ozone_gl_unittests\": \"5eb68a36115a594d0566f1c84c4408f93ce73909\", \"ozone_unittests\": \"5be8cf8a9e1654594d2171380605a20ee5d3f3b3\", \"ozone_x11_unittests\": \"07c37a0f20e3c41ca6b53b3c6ba985fbbb662920\", \"pdf_unittests\": \"8af42d8af4ea78c118e22c445dc88510feb2c682\", \"perfetto_unittests\": \"4437ced05d10fa20c8958c4b2301facd31d7b708\", \"ppapi_unittests\": \"aa483623f2b2db9973b7dbd726b70b58e61f1f9c\", \"printing_unittests\": \"cd5cfb15cf80853fe5e507d3566c91505fadfb9e\", \"remoting_unittests\": \"ccc24c104cb44f6100a90954245d85ff0f827a1c\", \"sandbox_linux_unittests\": \"612d5ff9586106cbc25e93a5d549b2152a7f0fb9\", \"service_manager_unittests\": \"7b5fc4b3fee8496d10c80a2d74af96b51f47f834\", \"services_unittests\": \"ae9e2f4cc2fab4f6daa5042e6fbe18bdabff1a2b\", \"shell_dialogs_unittests\": \"2d8ff28d5389ca4406c8ebee6816a7dabcc6ba26\", \"skia_unittests\": \"08f32cd617b4ccab2fd44405d817c85882be2670\", \"snapshot_unittests\": \"236be073653d6708a48b34fb9f66cfcf4cbc4878\", \"sql_unittests\": \"026173c1269e990c5ae0536100705e9ef67a1ced\", \"storage_unittests\": \"d980387cc5334446d1d23de4eeadd33837cf5590\", \"sync_integration_tests\": \"6625ab92eba80421c3b7a0baebd95840f9f52929\", \"traffic_annotation_auditor_unittests\": \"8bc178e237731271932fc941caa9225c6dff1d19\", \"ui_base_unittests\": \"36fa87b4340cfe54ed179277f5a54fd6e5c48b59\", \"ui_chromeos_unittests\": \"78fc3943eb2e4cce05c6a3c873b4d5a03ad917d7\", \"ui_touch_selection_unittests\": \"1c7c30822e9937a228df5cef208a24aa2a50f63d\", \"unit_tests\": \"6705497f2c785785c4cd2d2d9478ac85e4731077\", \"url_unittests\": \"c6db0e4e6b82d292441dc32e58b8c566e7f4288a\", \"usage_time_limit_unittests\": \"bfa048b28ab8351d1b01972a827c4797e000b185\", \"views_unittests\": \"025ec21e6eae423dc32604598b84a103643243be\", \"viz_unittests\": \"247212fb69894e9ec7c0cbb824177ac9ec19ad2e\", \"wm_unittests\": \"bdba852acaa53f6c40112833c82a329e2c4f1aad\", \"wtf_unittests\": \"43a61ef4019ddb565ccf42b5099cbdafc2f5ccf7\"}, \"swarm_hashes_refs/heads/master(at){#701543}_without_patch\": {\"accessibility_unittests\": \"72e3d81ecec2b096f3a6c22a8c6fcdd55262bfcc\", \"angle_unittests\": \"e2beea66b6a3c50236f2aed4224bb2e58a7623f5\", \"app_list_unittests\": \"f1d658ff64306e1e8f9f9ff696562b018f7c043c\", \"app_shell_unittests\": \"1eb10b348204c4a5945e62a8561c3e7ca274b3c0\", \"ash_unittests\": \"9dc005fd21fd437a6bf198faee020a5ada6f3280\", \"aura_unittests\": \"c24daa77e23c6623a6ca3197ed76986b64c0fc4b\", \"base_unittests\": \"397ebb307dfc12648259d12b17c561cf703b60df\", \"base_util_unittests\": \"66bd2443610abce1c27fe4fa7ac0068182520fad\", \"blink_common_unittests\": \"306fd418cdbecd1d07b1243ea22506e2a4acba5d\", \"blink_fuzzer_unittests\": \"2db4efb111929ec2ea825a15ff83b5e808e9d2c9\", \"blink_heap_unittests\": \"545cfdab51a5b36c68eda2f524d1ed64e253fc92\", \"blink_platform_unittests\": \"b549efb34128a3da0b23537ae2b01199bed0bd1b\", \"blink_unittests\": \"f03795a5a51750386481d5a390ff581645b2e8e4\", \"boringssl_crypto_tests\": \"3eff93dcb90a51cb5994ad671a575d24bd35910b\", \"boringssl_ssl_tests\": \"bbf51b47a93d6fbce748a104a829dbc19683239b\", \"browser_tests\": \"ded0e2c72d9d01ed258acb2ec819bf66d912bdbe\", \"cacheinvalidation_unittests\": \"138d0754b017199c55175340a0008525c8a8a1eb\", \"capture_unittests\": \"33a57d9c81b7a09f21c9649b27b8f86d7d6116e0\", \"cast_unittests\": \"dbb8cc030cb3bbf643647f09000daa301c53cd01\", \"cc_unittests\": \"5075938bc5f2c515c1593c7791aff30e2b01e597\", \"chrome_app_unittests\": \"f8ab60b6e726a429e9a8b147204e142d418dd923\", \"chromedriver_unittests\": \"c14dedf524c5e4f0e4f67fefd15c1d243eca6aa8\", \"chromeos_components_unittests\": \"5ef80a57c969fdcf1ffcea63af452bd51cea7c9e\", \"chromeos_unittests\": \"421942e5e63a7ce2d65c6fb8a4ac82464477a1a7\", \"color_unittests\": \"70da7e4418562430636c4ef76977b3ba4e21481f\", \"components_browsertests\": \"e3d2d5e63e9c6f47313cc84cc69230afee62fa86\", \"components_unittests\": \"fdee3f891fa8411ce6015537dd8a1fbbd0d25c74\", \"compositor_unittests\": \"0cedb06b7f143c414837359de4b0464ddb40975e\", \"content_browsertests\": \"740fae6822882368722d4db38ac08747180afa2b\", \"content_unittests\": \"b06e9e00c125967f3a8f2aaf8ad2c7fbaab13e7a\", \"crypto_unittests\": \"38e0ef91e576b0110d5ecdcd7b0868f5c7627aaa\", \"dbus_unittests\": \"cce2b0e75aa9595ab3071f8f4273cc71327a7eb2\", \"device_unittests\": \"2c966a35dd60caec0dd1555ae04488f34d39af59\", \"display_unittests\": \"2203d8e9c177043ecfb51020adf3ff6009e24528\", \"events_unittests\": \"eca98fcbfc0698d9a6ed8b946f10c36ddc6df58b\", \"exo_unittests\": \"9d97d4a87a33f8f3f28e9719e6f607bd1672940f\", \"extensions_browsertests\": \"c079d2e72e5ff750b65a4c9ddcd71fa071607ac8\", \"extensions_unittests\": \"2a6ce8634a785123879f7cd453512616ea2eb9c5\", \"filesystem_service_unittests\": \"0eb88ec58c13563200acaed999c8cb42559b8139\", \"gcm_unit_tests\": \"a115253d082a1c9a907a68854c5ce37d91313817\", \"gfx_unittests\": \"da09a0992fde3cc078e67855697cef467ced78f3\", \"gin_unittests\": \"6e3ba967b5cfbaeb76786d1d52270489da63beb2\", \"gl_unittests_ozone\": \"10ac8f6a74ea519ac727019188464ca2d5e44a0c\", \"google_apis_unittests\": \"8f9ad8da1e5d8a784a5c020c4091afb692eef38d\", \"gpu_unittests\": \"d2eb9c81c6b40b2364db045f3dc10d147b55cd42\", \"gwp_asan_unittests\": \"8a9c25a31e4d70a60b45d32bebee7a9303a91ccc\", \"interactive_ui_tests\": \"2d8e429ba10f598a8643ca97520f30cfdc8f7812\", \"ipc_tests\": \"51978626b27aa1eb45704ceaf472c6484084cf24\", \"jingle_unittests\": \"e54a1623354ee29767ed86195bb99c6dbefa18f1\", \"keyboard_unittests\": \"7ddb78760aca8080e7c01670afea164949a03ecd\", \"latency_unittests\": \"79785c208bd700ed8a39420e7878f0692bad0e52\", \"leveldb_service_unittests\": \"46a8415a975f277b9393648e830a795d9b5d914b\", \"libjingle_xmpp_unittests\": \"89b88da213333daa496ba70c2bf93a5c8caea561\", \"media_blink_unittests\": \"210adde34f483045783b51db777ce5a45932e251\", \"media_service_unittests\": \"81e47e1e7a17acdec82eeb1ab41d928d42b90030\", \"media_unittests\": \"863a9f45f903da6f9534507c89a6591daa481a9f\", \"message_center_unittests\": \"7acf195b19d0aa41675cddb15e449f4aafe94b61\", \"midi_unittests\": \"1ffa54452ba752d19de20d275cef23331791eaaf\", \"mojo_core_unittests\": \"e0bad75294e02cc42825c55cab4cdb573c25ff4e\", \"mojo_unittests\": \"1b36020f392779e42346a358dbe161102c3d629f\", \"nacl_helper_nonsfi_unittests\": \"a5f431a7611e00dd8ec1f0ddc3ff57ec994d8f4f\", \"nacl_loader_unittests\": \"7196955d0a0a193a5ca744304fd99a2c2bfb1178\", \"native_theme_unittests\": \"b00275666badcc7c3ad4beaf941be4983b8a768c\", \"net_unittests\": \"f03bf4279ff0e9ecdf1f4649fd364c3e0d552cea\", \"ozone_gl_unittests\": \"5eb68a36115a594d0566f1c84c4408f93ce73909\", \"ozone_unittests\": \"5be8cf8a9e1654594d2171380605a20ee5d3f3b3\", \"ozone_x11_unittests\": \"07c37a0f20e3c41ca6b53b3c6ba985fbbb662920\", \"pdf_unittests\": \"8af42d8af4ea78c118e22c445dc88510feb2c682\", \"perfetto_unittests\": \"4437ced05d10fa20c8958c4b2301facd31d7b708\", \"ppapi_unittests\": \"aa483623f2b2db9973b7dbd726b70b58e61f1f9c\", \"printing_unittests\": \"cd5cfb15cf80853fe5e507d3566c91505fadfb9e\", \"remoting_unittests\": \"ccc24c104cb44f6100a90954245d85ff0f827a1c\", \"sandbox_linux_unittests\": \"612d5ff9586106cbc25e93a5d549b2152a7f0fb9\", \"service_manager_unittests\": \"7b5fc4b3fee8496d10c80a2d74af96b51f47f834\", \"services_unittests\": \"ae9e2f4cc2fab4f6daa5042e6fbe18bdabff1a2b\", \"shell_dialogs_unittests\": \"2d8ff28d5389ca4406c8ebee6816a7dabcc6ba26\", \"skia_unittests\": \"08f32cd617b4ccab2fd44405d817c85882be2670\", \"snapshot_unittests\": \"236be073653d6708a48b34fb9f66cfcf4cbc4878\", \"sql_unittests\": \"026173c1269e990c5ae0536100705e9ef67a1ced\", \"storage_unittests\": \"d980387cc5334446d1d23de4eeadd33837cf5590\", \"sync_integration_tests\": \"6625ab92eba80421c3b7a0baebd95840f9f52929\", \"traffic_annotation_auditor_unittests\": \"8bc178e237731271932fc941caa9225c6dff1d19\", \"ui_base_unittests\": \"36fa87b4340cfe54ed179277f5a54fd6e5c48b59\", \"ui_chromeos_unittests\": \"78fc3943eb2e4cce05c6a3c873b4d5a03ad917d7\", \"ui_touch_selection_unittests\": \"1c7c30822e9937a228df5cef208a24aa2a50f63d\", \"unit_tests\": \"6705497f2c785785c4cd2d2d9478ac85e4731077\", \"url_unittests\": \"c6db0e4e6b82d292441dc32e58b8c566e7f4288a\", \"usage_time_limit_unittests\": \"bfa048b28ab8351d1b01972a827c4797e000b185\", \"views_unittests\": \"025ec21e6eae423dc32604598b84a103643243be\", \"viz_unittests\": \"247212fb69894e9ec7c0cbb824177ac9ec19ad2e\", \"wm_unittests\": \"bdba852acaa53f6c40112833c82a329e2c4f1aad\", \"wtf_unittests\": \"43a61ef4019ddb565ccf42b5099cbdafc2f5ccf7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_de511c69feace677f5cd8c21592724bd03d853158dcaa8109be4caaa62bec0b8_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-central1-b-8-72-48ch\"], \"image\": [\"chrome-xenial-19090600-ed917d8233f\"], \"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\"], \"python3\": [\"3.5.2\"], \"server_version\": [\"4466-755d6a2\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**non_viz_browser_tests** failed because of:\\n\\n- DirectoryTreeContextMenu/FilesAppBrowserTest.Test/dirCreateMultipleFolders\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1569937412569856",
"status": "COMPLETED",
"status_changed_ts": "1569937413053709",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/14623",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f9ffca114b52deb6afee0a8f88e308b75f800cba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f9ffca114b52deb6afee0a8f88e308b75f800cba",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9066225120009877488",
"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/8900795057162757728/+/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:47a06105decd4110",
"user_agent:luci-scheduler"
],
"updated_ts": "1569943073349395",
"url": "https://ci.chromium.org/b/8900795057162757728",
"utcnow_ts": "1569943075958660"
}
}
[15:17:55.982] Invocation finished in 1h34m57.485152171s with status FAILED