[18:49:42.441] New invocation is queued and will start shortly
[18:49:43.711] Starting the invocation (attempt 1)
[18:49:43.747] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:49:43.747] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:49:43.747] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9070192088614815360",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"590f216336b89412bc3ea0927c50294eef755143\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9070192088614815360",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/590f216336b89412bc3ea0927c50294eef755143",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/590f216336b89412bc3ea0927c50294eef755143",
"gitiles_ref:refs/heads/master"
]
}
[18:49:44.778] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1566154183923332",
"id": "8904762026396678608",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"590f216336b89412bc3ea0927c50294eef755143\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1566154184467544",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/13954",
"builder:linux-chromeos-dbg",
"buildset:commit/git/590f216336b89412bc3ea0927c50294eef755143",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/590f216336b89412bc3ea0927c50294eef755143",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070192088614815360",
"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/8904762026396678608/+/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": "1566154184467648",
"url": "https://ci.chromium.org/b/8904762026396678608",
"utcnow_ts": "1566154184762293"
}
}
[18:49:44.778] Task URL: https://ci.chromium.org/b/8904762026396678608
[18:49:44.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:2:0) after 1m0s
[18:50:45.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:2:0)
[18:50:45.018] Timer tick, asking Buildbucket for the build status
[18:50:45.620] Build 8904762026396678608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:50:45.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:3:0) after 1m0s
[18:51:08.308] Received PubSub notification, asking Buildbucket for the build status
[18:51:09.038] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:45.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:3:0)
[18:51:45.662] Timer tick, asking Buildbucket for the build status
[18:51:46.154] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:46.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:5:0) after 1m0s
[18:52:46.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:5:0)
[18:52:46.298] Timer tick, asking Buildbucket for the build status
[18:52:46.443] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:46.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:6:0) after 1m0s
[18:53:46.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:6:0)
[18:53:46.478] Timer tick, asking Buildbucket for the build status
[18:53:46.669] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:46.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:7:0) after 1m0s
[18:54:46.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:7:0)
[18:54:46.729] Timer tick, asking Buildbucket for the build status
[18:54:46.894] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:46.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:8:0) after 1m0s
[18:55:47.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:8:0)
[18:55:47.061] Timer tick, asking Buildbucket for the build status
[18:55:47.753] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:47.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:9:0) after 1m0s
[18:56:47.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:9:0)
[18:56:47.781] Timer tick, asking Buildbucket for the build status
[18:56:47.955] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:47.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:10:0) after 1m0s
[18:57:47.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:10:0)
[18:57:47.976] Timer tick, asking Buildbucket for the build status
[18:57:48.628] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:48.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:11:0) after 1m0s
[18:58:48.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:11:0)
[18:58:48.649] Timer tick, asking Buildbucket for the build status
[18:58:49.448] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:49.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:12:0) after 1m0s
[18:59:49.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:12:0)
[18:59:49.469] Timer tick, asking Buildbucket for the build status
[18:59:49.720] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:49.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:13:0) after 1m0s
[19:00:49.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:13:0)
[19:00:49.747] Timer tick, asking Buildbucket for the build status
[19:00:49.900] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:49.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:14:0) after 1m0s
[19:01:50.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:14:0)
[19:01:50.008] Timer tick, asking Buildbucket for the build status
[19:01:50.134] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:50.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:15:0) after 1m0s
[19:02:50.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:15:0)
[19:02:50.192] Timer tick, asking Buildbucket for the build status
[19:02:50.380] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:50.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:16:0) after 1m0s
[19:03:50.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:16:0)
[19:03:50.454] Timer tick, asking Buildbucket for the build status
[19:03:50.596] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:50.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:17:0) after 1m0s
[19:04:50.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:17:0)
[19:04:50.650] Timer tick, asking Buildbucket for the build status
[19:04:51.151] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:51.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:18:0) after 1m0s
[19:05:51.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:18:0)
[19:05:51.175] Timer tick, asking Buildbucket for the build status
[19:05:51.448] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:51.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:19:0) after 1m0s
[19:06:51.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:19:0)
[19:06:51.476] Timer tick, asking Buildbucket for the build status
[19:06:52.173] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:52.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:20:0) after 1m0s
[19:07:52.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:20:0)
[19:07:52.218] Timer tick, asking Buildbucket for the build status
[19:07:52.694] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:52.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:21:0) after 1m0s
[19:08:52.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:21:0)
[19:08:52.731] Timer tick, asking Buildbucket for the build status
[19:08:53.309] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:53.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:22:0) after 1m0s
[19:09:53.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:22:0)
[19:09:53.341] Timer tick, asking Buildbucket for the build status
[19:09:53.551] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:53.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:23:0) after 1m0s
[19:10:53.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:23:0)
[19:10:53.579] Timer tick, asking Buildbucket for the build status
[19:10:53.763] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:53.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:24:0) after 1m0s
[19:11:53.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:24:0)
[19:11:53.837] Timer tick, asking Buildbucket for the build status
[19:11:54.314] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:54.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:25:0) after 1m0s
[19:12:54.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:25:0)
[19:12:54.342] Timer tick, asking Buildbucket for the build status
[19:12:54.562] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:54.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:26:0) after 1m0s
[19:13:54.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:26:0)
[19:13:54.642] Timer tick, asking Buildbucket for the build status
[19:13:54.758] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:54.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:27:0) after 1m0s
[19:14:54.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:27:0)
[19:14:54.804] Timer tick, asking Buildbucket for the build status
[19:14:55.158] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:55.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:28:0) after 1m0s
[19:15:55.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:28:0)
[19:15:55.198] Timer tick, asking Buildbucket for the build status
[19:15:55.476] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:55.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:29:0) after 1m0s
[19:16:55.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:29:0)
[19:16:55.561] Timer tick, asking Buildbucket for the build status
[19:16:55.786] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:55.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:30:0) after 1m0s
[19:17:55.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:30:0)
[19:17:55.821] Timer tick, asking Buildbucket for the build status
[19:17:56.023] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:56.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:31:0) after 1m0s
[19:18:56.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:31:0)
[19:18:56.050] Timer tick, asking Buildbucket for the build status
[19:18:56.253] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:56.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:32:0) after 1m0s
[19:19:56.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:32:0)
[19:19:56.306] Timer tick, asking Buildbucket for the build status
[19:19:58.105] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:58.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:33:0) after 1m0s
[19:20:58.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:33:0)
[19:20:58.181] Timer tick, asking Buildbucket for the build status
[19:20:58.319] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:58.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:34:0) after 1m0s
[19:21:58.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:34:0)
[19:21:58.352] Timer tick, asking Buildbucket for the build status
[19:22:00.218] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:00.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:35:0) after 1m0s
[19:23:00.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:35:0)
[19:23:00.323] Timer tick, asking Buildbucket for the build status
[19:23:01.056] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:01.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:36:0) after 1m0s
[19:24:01.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:36:0)
[19:24:01.092] Timer tick, asking Buildbucket for the build status
[19:24:01.290] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:01.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:37:0) after 1m0s
[19:25:01.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:37:0)
[19:25:01.373] Timer tick, asking Buildbucket for the build status
[19:25:01.591] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:01.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:38:0) after 1m0s
[19:26:06.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:38:0)
[19:26:06.344] Timer tick, asking Buildbucket for the build status
[19:26:06.533] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:06.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:39:0) after 1m0s
[19:27:06.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:39:0)
[19:27:06.526] Timer tick, asking Buildbucket for the build status
[19:27:07.067] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:07.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:40:0) after 1m0s
[19:28:07.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:40:0)
[19:28:07.096] Timer tick, asking Buildbucket for the build status
[19:28:07.614] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:07.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:41:0) after 1m0s
[19:29:07.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:41:0)
[19:29:07.646] Timer tick, asking Buildbucket for the build status
[19:29:08.775] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:08.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:42:0) after 1m0s
[19:30:08.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:42:0)
[19:30:08.749] Timer tick, asking Buildbucket for the build status
[19:30:09.240] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:09.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:43:0) after 1m0s
[19:31:09.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:43:0)
[19:31:09.266] Timer tick, asking Buildbucket for the build status
[19:31:09.424] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:09.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:44:0) after 1m0s
[19:32:09.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:44:0)
[19:32:09.468] Timer tick, asking Buildbucket for the build status
[19:32:11.361] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:11.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:45:0) after 1m0s
[19:33:11.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:45:0)
[19:33:11.485] Timer tick, asking Buildbucket for the build status
[19:33:11.682] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:11.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:46:0) after 1m0s
[19:34:11.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:46:0)
[19:34:11.703] Timer tick, asking Buildbucket for the build status
[19:34:11.866] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:11.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:47:0) after 1m0s
[19:35:11.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:47:0)
[19:35:11.888] Timer tick, asking Buildbucket for the build status
[19:35:12.256] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:12.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:48:0) after 1m0s
[19:36:12.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:48:0)
[19:36:12.296] Timer tick, asking Buildbucket for the build status
[19:36:14.243] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:14.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:49:0) after 1m0s
[19:37:14.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:49:0)
[19:37:14.275] Timer tick, asking Buildbucket for the build status
[19:37:15.805] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:15.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:50:0) after 1m0s
[19:38:15.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:50:0)
[19:38:15.887] Timer tick, asking Buildbucket for the build status
[19:38:16.073] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:16.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:51:0) after 1m0s
[19:39:16.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:51:0)
[19:39:16.119] Timer tick, asking Buildbucket for the build status
[19:39:18.138] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:18.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:52:0) after 1m0s
[19:40:18.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:52:0)
[19:40:18.229] Timer tick, asking Buildbucket for the build status
[19:40:19.022] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:19.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:53:0) after 1m0s
[19:41:20.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:53:0)
[19:41:20.082] Timer tick, asking Buildbucket for the build status
[19:41:20.892] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:20.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:54:0) after 1m0s
[19:42:21.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:54:0)
[19:42:21.097] Timer tick, asking Buildbucket for the build status
[19:42:21.713] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:21.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:55:0) after 1m0s
[19:43:21.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:55:0)
[19:43:21.791] Timer tick, asking Buildbucket for the build status
[19:43:21.982] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:21.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:56:0) after 1m0s
[19:44:22.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:56:0)
[19:44:22.005] Timer tick, asking Buildbucket for the build status
[19:44:22.250] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:22.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:57:0) after 1m0s
[19:45:22.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:57:0)
[19:45:22.405] Timer tick, asking Buildbucket for the build status
[19:45:22.952] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:22.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:58:0) after 1m0s
[19:46:22.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:58:0)
[19:46:22.960] Timer tick, asking Buildbucket for the build status
[19:46:23.900] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:23.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:59:0) after 1m0s
[19:47:24.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:59:0)
[19:47:24.031] Timer tick, asking Buildbucket for the build status
[19:47:24.277] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:24.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:60:0) after 1m0s
[19:48:24.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:60:0)
[19:48:24.304] Timer tick, asking Buildbucket for the build status
[19:48:24.745] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:24.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:61:0) after 1m0s
[19:49:25.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:61:0)
[19:49:25.132] Timer tick, asking Buildbucket for the build status
[19:49:25.350] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:25.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:62:0) after 1m0s
[19:50:25.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:62:0)
[19:50:25.557] Timer tick, asking Buildbucket for the build status
[19:50:25.702] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:25.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:63:0) after 1m0s
[19:51:25.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:63:0)
[19:51:25.830] Timer tick, asking Buildbucket for the build status
[19:51:26.082] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:26.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:64:0) after 1m0s
[19:52:26.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:64:0)
[19:52:26.230] Timer tick, asking Buildbucket for the build status
[19:52:26.780] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:26.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:65:0) after 1m0s
[19:53:26.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:65:0)
[19:53:26.936] Timer tick, asking Buildbucket for the build status
[19:53:28.985] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:28.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:66:0) after 1m0s
[19:54:29.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:66:0)
[19:54:29.169] Timer tick, asking Buildbucket for the build status
[19:54:29.337] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:29.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:67:0) after 1m0s
[19:55:29.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:67:0)
[19:55:29.536] Timer tick, asking Buildbucket for the build status
[19:55:29.714] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:29.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:68:0) after 1m0s
[19:56:29.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:68:0)
[19:56:29.820] Timer tick, asking Buildbucket for the build status
[19:56:29.995] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:29.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:69:0) after 1m0s
[19:57:30.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:69:0)
[19:57:30.112] Timer tick, asking Buildbucket for the build status
[19:57:30.288] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:30.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:70:0) after 1m0s
[19:58:30.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:70:0)
[19:58:30.336] Timer tick, asking Buildbucket for the build status
[19:58:30.635] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:30.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:71:0) after 1m0s
[19:59:30.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:71:0)
[19:59:30.871] Timer tick, asking Buildbucket for the build status
[19:59:31.105] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:31.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:72:0) after 1m0s
[20:00:31.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:72:0)
[20:00:31.135] Timer tick, asking Buildbucket for the build status
[20:00:31.322] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:31.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:73:0) after 1m0s
[20:01:31.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:73:0)
[20:01:31.613] Timer tick, asking Buildbucket for the build status
[20:01:31.923] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:31.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:74:0) after 1m0s
[20:02:31.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:74:0)
[20:02:31.985] Timer tick, asking Buildbucket for the build status
[20:02:32.583] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:32.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:75:0) after 1m0s
[20:03:32.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:75:0)
[20:03:32.843] Timer tick, asking Buildbucket for the build status
[20:03:33.000] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:33.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:76:0) after 1m0s
[20:04:33.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:76:0)
[20:04:33.156] Timer tick, asking Buildbucket for the build status
[20:04:33.311] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:33.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:77:0) after 1m0s
[20:05:33.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:77:0)
[20:05:33.396] Timer tick, asking Buildbucket for the build status
[20:05:34.227] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:34.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:78:0) after 1m0s
[20:06:34.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:78:0)
[20:06:34.248] Timer tick, asking Buildbucket for the build status
[20:06:34.576] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:34.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:79:0) after 1m0s
[20:07:34.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:79:0)
[20:07:34.615] Timer tick, asking Buildbucket for the build status
[20:07:35.337] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:35.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:80:0) after 1m0s
[20:08:35.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:80:0)
[20:08:35.400] Timer tick, asking Buildbucket for the build status
[20:08:35.625] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:35.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:81:0) after 1m0s
[20:09:35.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:81:0)
[20:09:35.712] Timer tick, asking Buildbucket for the build status
[20:09:35.942] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:35.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:82:0) after 1m0s
[20:10:35.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:82:0)
[20:10:35.986] Timer tick, asking Buildbucket for the build status
[20:10:36.152] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:36.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:83:0) after 1m0s
[20:11:36.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:83:0)
[20:11:36.226] Timer tick, asking Buildbucket for the build status
[20:11:36.636] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:36.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:84:0) after 1m0s
[20:12:36.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:84:0)
[20:12:36.762] Timer tick, asking Buildbucket for the build status
[20:12:36.994] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:36.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:85:0) after 1m0s
[20:13:37.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:85:0)
[20:13:37.236] Timer tick, asking Buildbucket for the build status
[20:13:37.509] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:37.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:86:0) after 1m0s
[20:14:37.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:86:0)
[20:14:37.538] Timer tick, asking Buildbucket for the build status
[20:14:40.208] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:40.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:87:0) after 1m0s
[20:15:40.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:87:0)
[20:15:40.235] Timer tick, asking Buildbucket for the build status
[20:15:40.522] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:40.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:88:0) after 1m0s
[20:16:40.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:88:0)
[20:16:40.548] Timer tick, asking Buildbucket for the build status
[20:16:40.715] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:40.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:89:0) after 1m0s
[20:17:40.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:89:0)
[20:17:40.973] Timer tick, asking Buildbucket for the build status
[20:17:41.128] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:41.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:90:0) after 1m0s
[20:18:41.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:90:0)
[20:18:41.263] Timer tick, asking Buildbucket for the build status
[20:18:41.434] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:41.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:91:0) after 1m0s
[20:19:41.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:91:0)
[20:19:41.540] Timer tick, asking Buildbucket for the build status
[20:19:41.851] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:41.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:92:0) after 1m0s
[20:20:41.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:92:0)
[20:20:41.975] Timer tick, asking Buildbucket for the build status
[20:20:42.194] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:42.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:93:0) after 1m0s
[20:21:42.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:93:0)
[20:21:42.529] Timer tick, asking Buildbucket for the build status
[20:21:45.272] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:45.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:94:0) after 1m0s
[20:22:45.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:94:0)
[20:22:45.299] Timer tick, asking Buildbucket for the build status
[20:22:45.985] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:45.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:95:0) after 1m0s
[20:23:46.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:95:0)
[20:23:46.047] Timer tick, asking Buildbucket for the build status
[20:23:46.222] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:46.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:96:0) after 1m0s
[20:24:46.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:96:0)
[20:24:46.317] Timer tick, asking Buildbucket for the build status
[20:24:47.346] Build 8904762026396678608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:47.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9070192088614815360:97:0) after 1m0s
[20:25:47.326] Received PubSub notification, asking Buildbucket for the build status
[20:25:47.456] Build 8904762026396678608: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:25:47.456] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1566159945706986",
"created_by": "project:chromium",
"created_ts": "1566154183923332",
"failure_reason": "BUILD_FAILURE",
"id": "8904762026396678608",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"590f216336b89412bc3ea0927c50294eef755143\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**interactive_ui_tests** failed because of:\\n\\n- TabSpinnerTest.LoadTabsOneByOne\\n\\n**browser_tests** failed because of:\\n\\n- OSSettingsPersonalizationPageTest.AllJsTests\"}, \"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-132-n47e\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 13954, \"got_angle_revision\": \"265fdf0c5fd6b1e28a54c18ca40a8461c7f449a7\", \"got_dawn_revision\": \"ee3de1e1f3da2386197a2c586304deb263890a35\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"590f216336b89412bc3ea0927c50294eef755143\", \"got_revision_cp\": \"refs/heads/master@{#687971}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"7b861aca66ea8080a32eba6217f8833cdcc32a09\", \"got_v8_revision_cp\": \"refs/heads/7.8.113@{#1}\", \"got_webrtc_revision\": \"f5e5d250bc85616e74487f8330ed8d99cc9cf84f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28880}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"590f216336b89412bc3ea0927c50294eef755143\", \"swarm_hashes\": {\"accessibility_unittests\": \"87c0c6db8bf3820818b4a05e614070d270669fa2\", \"angle_unittests\": \"442511aeb28ee565091081342b00ea2d0b411860\", \"app_list_unittests\": \"2daac4521f4adb26a3c8ade9ed020fa9f2566a3e\", \"app_shell_unittests\": \"cc55244b065458ad5ad023f30fcdd23bd0abfdfd\", \"ash_unittests\": \"27056dac6059c5f160c0f4870c4f3a6fb73622df\", \"aura_unittests\": \"b249744744e719d40a38def3dd3bfb88eab794ae\", \"base_unittests\": \"cf7f44c1d9dbd2e28f4bfc8fd81880dd956e8f3d\", \"base_util_unittests\": \"15484f8c1cf6b8c84b6b04224e82b04f8931e14b\", \"blink_common_unittests\": \"9704e6835ca681fddd5791aed6f16dfb283816b1\", \"blink_fuzzer_unittests\": \"dec528a77e44c6784248c024b6bc9b6be8e2e212\", \"blink_heap_unittests\": \"533decd8fd4e770544a052a3ce74e3bdf10c4abd\", \"blink_platform_unittests\": \"bc7cfd818a5656dc520c6e74a0ebad0bfed9b4cc\", \"blink_unittests\": \"6998598fcfe1bb3429a00ff2753f3dd8c72a64b5\", \"boringssl_crypto_tests\": \"05ee9679f6330527fb0ce1f8bd08659c4876be60\", \"boringssl_ssl_tests\": \"0a28ba45b150eba5e78c847c14ddf9cdabe04423\", \"browser_tests\": \"b670d4b9cb3c502579d740c3713575172c09e7ab\", \"cacheinvalidation_unittests\": \"fcf7de9d335ccdcb36421ddf44b7321ee8757e55\", \"capture_unittests\": \"5adbc42e74e004e5705ddaadc6a86e237b29537b\", \"cast_unittests\": \"f19dcce243e9dc14e69a7f364a63632bd08ded13\", \"cc_unittests\": \"656f06dca7ee2d34ba432377e72612b711f43776\", \"chrome_app_unittests\": \"12d17e6b8051b1a3293baf54e16ec1b63efef648\", \"chromedriver_unittests\": \"9e55e8790cf6d7a3304a94811f61d9f08128e5da\", \"chromeos_components_unittests\": \"3a2896d4cda57301fd6e696bed215d1f610377d1\", \"chromeos_unittests\": \"b9a70346190a41aac9b6002266ddc58265085eca\", \"components_browsertests\": \"dbaa7835bb39d8be914522730a141130967a6779\", \"components_unittests\": \"7534e461f60b177290f631dd85a62149b99c1ffa\", \"compositor_unittests\": \"c65d12984ad0e6ce3b564197beb4fcb1b2827d4b\", \"content_browsertests\": \"0249f73cb7ae6c49c1e77399439d1fb7aa6be18a\", \"content_unittests\": \"e22f08060fdfc71b211b017f2aa537745939c742\", \"crypto_unittests\": \"ec960d7678bde7c85d7aa36387b87856dfea0e03\", \"dbus_unittests\": \"5b01c9d9f66362a3c3e6db530ab8f758a636ef87\", \"device_unittests\": \"55045e67fad40f3e9816d9eadd073a4fd3397c9c\", \"display_unittests\": \"0fc56dcec1238de42449a44f08049fd1e62b605e\", \"events_unittests\": \"489fe691d1295ab766d445222c61ee65b9649d99\", \"exo_unittests\": \"69fd5c47492f7ebe53948e7c573a6b5d8cc56c83\", \"extensions_browsertests\": \"bab68afb6ca59e4232f17af44d654b2e5dcdd7f8\", \"extensions_unittests\": \"4f04e7931aa8ffa39ed22edb33864318e47c8b1d\", \"filesystem_service_unittests\": \"58fe689faa256fdd97ff16446616e56130b2519b\", \"gcm_unit_tests\": \"6a71e3475f6488ff774f4c8cb1b4e8cf5d681ebb\", \"gfx_unittests\": \"3bdef001a047b24070cf75904791411d43594d7a\", \"gin_unittests\": \"56147fc7eec470711c8786f7030e2a5e5664c399\", \"gl_unittests_ozone\": \"bbb359a822dd207b174bd6a55c2faae9bc11bb68\", \"google_apis_unittests\": \"f607968aa8faee2712987b6d33e08ce031084232\", \"gpu_unittests\": \"d5e40514670b3bc0f0965d697670f16972e9aa38\", \"gwp_asan_unittests\": \"31eef8fe523f8b10eb7662cc7ae74b62ff4d2ded\", \"interactive_ui_tests\": \"07d37ce231f0c2055bd67a7d995de928597dd7a6\", \"ipc_tests\": \"9877b59b7aa4223dc759cbd2f256443607ab9650\", \"jingle_unittests\": \"a3a0b348e9b0cf3717050962fba5563babfc117f\", \"keyboard_unittests\": \"fdbaa212b73c5bc1c585fa37124eddb1c56202a5\", \"latency_unittests\": \"0ba2408f080beaa80a93b0fba72720635b3d1334\", \"leveldb_service_unittests\": \"829e38bfa17228d0f9ad19904323f9c033e060c3\", \"libjingle_xmpp_unittests\": \"122db59806bd22e243dc04ac774d18be567d6680\", \"media_blink_unittests\": \"4113dbbb54dab8c9729940b6eb9656be53867043\", \"media_service_unittests\": \"676be477f14444afcb150cd1818b2fe4323a609f\", \"media_unittests\": \"f9f7b5960d23556cabe220e86d5ca1f45817e225\", \"message_center_unittests\": \"829db5937e55b310325ed72334938551051cc4d9\", \"midi_unittests\": \"cf6e75c341f821bcc5da3500d5f8dce627caffaf\", \"mojo_core_unittests\": \"b85a9cefb1b472dcc124315a09643ef2d630187c\", \"mojo_unittests\": \"9926e069d8deabc669c1da713e3793279fd8ed9d\", \"nacl_helper_nonsfi_unittests\": \"a6c547f480e5375f370ac5222f563d19fc316c67\", \"nacl_loader_unittests\": \"70da7db10d55f7232a264b0afb9bdf177b5e8927\", \"native_theme_unittests\": \"987dd87391af767566cc15d5bfca0c00bd7d239b\", \"net_unittests\": \"e65973838a9a8cbfda3495007aa53b060b5cff5a\", \"ozone_gl_unittests\": \"704d58c682ea7b61e9ff49a6560049d6cc011751\", \"ozone_unittests\": \"3154f21923a7f24be595a1d5c84e75fcad9ca762\", \"ozone_x11_unittests\": \"525ca780e879f258d0c3cf56011e6f27feae8160\", \"pdf_unittests\": \"b23514b80ac48fa8d1a21ea140c7d244c62deeb2\", \"perfetto_unittests\": \"4b47f4d18b41f07c6ffc5293acb7b49aa901fc44\", \"ppapi_unittests\": \"3f4491b7924229e7bea1c58864c2c76caf22856e\", \"printing_unittests\": \"f40d58d648d0d3c3adfe2c0e4bec36b26a3db1d9\", \"remoting_unittests\": \"3b6a71d75f80332414de18d6a7f38cf208128f9c\", \"sandbox_linux_unittests\": \"0ccd8764101bcf5d4a58013a14844bf2825c8401\", \"service_manager_unittests\": \"6c617eb79fa45a571e21303b66fac4abd944e882\", \"services_unittests\": \"eb5bebb12b77f074cc20b60c3065dcf516d80f58\", \"shell_dialogs_unittests\": \"090a1f7cfadfc627e86565a2e020cb5a41b18dc8\", \"skia_unittests\": \"1f6beb28112ebc9f8147aeb636b35816b68b789b\", \"snapshot_unittests\": \"14fcd168d7dcb672782729403a5eeeef316e2a5b\", \"sql_unittests\": \"36f5bb5003ae9cc5e9c1121df2798747f38c700e\", \"storage_unittests\": \"834d099c3165ad8a477374aef138d38201d470f1\", \"sync_integration_tests\": \"1a171342895fbb60d94bccd388b82ccfe3e55c8d\", \"traffic_annotation_auditor_unittests\": \"20f291ca0462b0dca0540d6323ca778b6fe6f2a8\", \"ui_base_unittests\": \"972ab0a0245fde33654a6c1fbd0ecd1fab0e91c1\", \"ui_chromeos_unittests\": \"00146a865c5c3066323d6af9a7c5e9f5af8f09e7\", \"ui_touch_selection_unittests\": \"67f30be38895d81d33c56eccc2a790e5e4e9470a\", \"unit_tests\": \"3ce6259739699877d2144fd113f1ab75c883a30c\", \"url_unittests\": \"9c8028dab40f9eff1c05c3cdd7f888e5e32e49dd\", \"usage_time_limit_unittests\": \"6a71895c9ed3d06198eb39353a693d9063dce5fb\", \"views_unittests\": \"d981a2d0ea850bc4d0cef2adf601ea969adaa16a\", \"viz_unittests\": \"348da1f64b7f5954c50cc43c35c7a5c3d1b19e32\", \"wm_unittests\": \"5f9e6a2f227d6a708c9a00b576d49184a710d639\", \"wtf_unittests\": \"822d7180b435674d660bd1df13e160132d12bcec\"}, \"swarm_hashes_refs/heads/master(at){#687971}_without_patch\": {\"accessibility_unittests\": \"87c0c6db8bf3820818b4a05e614070d270669fa2\", \"angle_unittests\": \"442511aeb28ee565091081342b00ea2d0b411860\", \"app_list_unittests\": \"2daac4521f4adb26a3c8ade9ed020fa9f2566a3e\", \"app_shell_unittests\": \"cc55244b065458ad5ad023f30fcdd23bd0abfdfd\", \"ash_unittests\": \"27056dac6059c5f160c0f4870c4f3a6fb73622df\", \"aura_unittests\": \"b249744744e719d40a38def3dd3bfb88eab794ae\", \"base_unittests\": \"cf7f44c1d9dbd2e28f4bfc8fd81880dd956e8f3d\", \"base_util_unittests\": \"15484f8c1cf6b8c84b6b04224e82b04f8931e14b\", \"blink_common_unittests\": \"9704e6835ca681fddd5791aed6f16dfb283816b1\", \"blink_fuzzer_unittests\": \"dec528a77e44c6784248c024b6bc9b6be8e2e212\", \"blink_heap_unittests\": \"533decd8fd4e770544a052a3ce74e3bdf10c4abd\", \"blink_platform_unittests\": \"bc7cfd818a5656dc520c6e74a0ebad0bfed9b4cc\", \"blink_unittests\": \"6998598fcfe1bb3429a00ff2753f3dd8c72a64b5\", \"boringssl_crypto_tests\": \"05ee9679f6330527fb0ce1f8bd08659c4876be60\", \"boringssl_ssl_tests\": \"0a28ba45b150eba5e78c847c14ddf9cdabe04423\", \"browser_tests\": \"b670d4b9cb3c502579d740c3713575172c09e7ab\", \"cacheinvalidation_unittests\": \"fcf7de9d335ccdcb36421ddf44b7321ee8757e55\", \"capture_unittests\": \"5adbc42e74e004e5705ddaadc6a86e237b29537b\", \"cast_unittests\": \"f19dcce243e9dc14e69a7f364a63632bd08ded13\", \"cc_unittests\": \"656f06dca7ee2d34ba432377e72612b711f43776\", \"chrome_app_unittests\": \"12d17e6b8051b1a3293baf54e16ec1b63efef648\", \"chromedriver_unittests\": \"9e55e8790cf6d7a3304a94811f61d9f08128e5da\", \"chromeos_components_unittests\": \"3a2896d4cda57301fd6e696bed215d1f610377d1\", \"chromeos_unittests\": \"b9a70346190a41aac9b6002266ddc58265085eca\", \"components_browsertests\": \"dbaa7835bb39d8be914522730a141130967a6779\", \"components_unittests\": \"7534e461f60b177290f631dd85a62149b99c1ffa\", \"compositor_unittests\": \"c65d12984ad0e6ce3b564197beb4fcb1b2827d4b\", \"content_browsertests\": \"0249f73cb7ae6c49c1e77399439d1fb7aa6be18a\", \"content_unittests\": \"e22f08060fdfc71b211b017f2aa537745939c742\", \"crypto_unittests\": \"ec960d7678bde7c85d7aa36387b87856dfea0e03\", \"dbus_unittests\": \"5b01c9d9f66362a3c3e6db530ab8f758a636ef87\", \"device_unittests\": \"55045e67fad40f3e9816d9eadd073a4fd3397c9c\", \"display_unittests\": \"0fc56dcec1238de42449a44f08049fd1e62b605e\", \"events_unittests\": \"489fe691d1295ab766d445222c61ee65b9649d99\", \"exo_unittests\": \"69fd5c47492f7ebe53948e7c573a6b5d8cc56c83\", \"extensions_browsertests\": \"bab68afb6ca59e4232f17af44d654b2e5dcdd7f8\", \"extensions_unittests\": \"4f04e7931aa8ffa39ed22edb33864318e47c8b1d\", \"filesystem_service_unittests\": \"58fe689faa256fdd97ff16446616e56130b2519b\", \"gcm_unit_tests\": \"6a71e3475f6488ff774f4c8cb1b4e8cf5d681ebb\", \"gfx_unittests\": \"3bdef001a047b24070cf75904791411d43594d7a\", \"gin_unittests\": \"56147fc7eec470711c8786f7030e2a5e5664c399\", \"gl_unittests_ozone\": \"bbb359a822dd207b174bd6a55c2faae9bc11bb68\", \"google_apis_unittests\": \"f607968aa8faee2712987b6d33e08ce031084232\", \"gpu_unittests\": \"d5e40514670b3bc0f0965d697670f16972e9aa38\", \"gwp_asan_unittests\": \"31eef8fe523f8b10eb7662cc7ae74b62ff4d2ded\", \"interactive_ui_tests\": \"07d37ce231f0c2055bd67a7d995de928597dd7a6\", \"ipc_tests\": \"9877b59b7aa4223dc759cbd2f256443607ab9650\", \"jingle_unittests\": \"a3a0b348e9b0cf3717050962fba5563babfc117f\", \"keyboard_unittests\": \"fdbaa212b73c5bc1c585fa37124eddb1c56202a5\", \"latency_unittests\": \"0ba2408f080beaa80a93b0fba72720635b3d1334\", \"leveldb_service_unittests\": \"829e38bfa17228d0f9ad19904323f9c033e060c3\", \"libjingle_xmpp_unittests\": \"122db59806bd22e243dc04ac774d18be567d6680\", \"media_blink_unittests\": \"4113dbbb54dab8c9729940b6eb9656be53867043\", \"media_service_unittests\": \"676be477f14444afcb150cd1818b2fe4323a609f\", \"media_unittests\": \"f9f7b5960d23556cabe220e86d5ca1f45817e225\", \"message_center_unittests\": \"829db5937e55b310325ed72334938551051cc4d9\", \"midi_unittests\": \"cf6e75c341f821bcc5da3500d5f8dce627caffaf\", \"mojo_core_unittests\": \"b85a9cefb1b472dcc124315a09643ef2d630187c\", \"mojo_unittests\": \"9926e069d8deabc669c1da713e3793279fd8ed9d\", \"nacl_helper_nonsfi_unittests\": \"a6c547f480e5375f370ac5222f563d19fc316c67\", \"nacl_loader_unittests\": \"70da7db10d55f7232a264b0afb9bdf177b5e8927\", \"native_theme_unittests\": \"987dd87391af767566cc15d5bfca0c00bd7d239b\", \"net_unittests\": \"e65973838a9a8cbfda3495007aa53b060b5cff5a\", \"ozone_gl_unittests\": \"704d58c682ea7b61e9ff49a6560049d6cc011751\", \"ozone_unittests\": \"3154f21923a7f24be595a1d5c84e75fcad9ca762\", \"ozone_x11_unittests\": \"525ca780e879f258d0c3cf56011e6f27feae8160\", \"pdf_unittests\": \"b23514b80ac48fa8d1a21ea140c7d244c62deeb2\", \"perfetto_unittests\": \"4b47f4d18b41f07c6ffc5293acb7b49aa901fc44\", \"ppapi_unittests\": \"3f4491b7924229e7bea1c58864c2c76caf22856e\", \"printing_unittests\": \"f40d58d648d0d3c3adfe2c0e4bec36b26a3db1d9\", \"remoting_unittests\": \"3b6a71d75f80332414de18d6a7f38cf208128f9c\", \"sandbox_linux_unittests\": \"0ccd8764101bcf5d4a58013a14844bf2825c8401\", \"service_manager_unittests\": \"6c617eb79fa45a571e21303b66fac4abd944e882\", \"services_unittests\": \"eb5bebb12b77f074cc20b60c3065dcf516d80f58\", \"shell_dialogs_unittests\": \"090a1f7cfadfc627e86565a2e020cb5a41b18dc8\", \"skia_unittests\": \"1f6beb28112ebc9f8147aeb636b35816b68b789b\", \"snapshot_unittests\": \"14fcd168d7dcb672782729403a5eeeef316e2a5b\", \"sql_unittests\": \"36f5bb5003ae9cc5e9c1121df2798747f38c700e\", \"storage_unittests\": \"834d099c3165ad8a477374aef138d38201d470f1\", \"sync_integration_tests\": \"1a171342895fbb60d94bccd388b82ccfe3e55c8d\", \"traffic_annotation_auditor_unittests\": \"20f291ca0462b0dca0540d6323ca778b6fe6f2a8\", \"ui_base_unittests\": \"972ab0a0245fde33654a6c1fbd0ecd1fab0e91c1\", \"ui_chromeos_unittests\": \"00146a865c5c3066323d6af9a7c5e9f5af8f09e7\", \"ui_touch_selection_unittests\": \"67f30be38895d81d33c56eccc2a790e5e4e9470a\", \"unit_tests\": \"3ce6259739699877d2144fd113f1ab75c883a30c\", \"url_unittests\": \"9c8028dab40f9eff1c05c3cdd7f888e5e32e49dd\", \"usage_time_limit_unittests\": \"6a71895c9ed3d06198eb39353a693d9063dce5fb\", \"views_unittests\": \"d981a2d0ea850bc4d0cef2adf601ea969adaa16a\", \"viz_unittests\": \"348da1f64b7f5954c50cc43c35c7a5c3d1b19e32\", \"wm_unittests\": \"5f9e6a2f227d6a708c9a00b576d49184a710d639\", \"wtf_unittests\": \"822d7180b435674d660bd1df13e160132d12bcec\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_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-132-n47e\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"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\": [\"4397-8786906\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**interactive_ui_tests** failed because of:\\n\\n- TabSpinnerTest.LoadTabsOneByOne\\n\\n**browser_tests** failed because of:\\n\\n- OSSettingsPersonalizationPageTest.AllJsTests\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1566154264448318",
"status": "COMPLETED",
"status_changed_ts": "1566154267871463",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/13954",
"builder:linux-chromeos-dbg",
"buildset:commit/git/590f216336b89412bc3ea0927c50294eef755143",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/590f216336b89412bc3ea0927c50294eef755143",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070192088614815360",
"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/8904762026396678608/+/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:46bee1e0e931fc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1566159946883217",
"url": "https://ci.chromium.org/b/8904762026396678608",
"utcnow_ts": "1566159947447510"
}
}
[20:25:47.456] Invocation finished in 1h36m5.03185937s with status FAILED