[12:04:59.685] New invocation is queued and will start shortly
[12:05:00.768] Starting the invocation (attempt 1)
[12:05:00.801] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:05:00.801] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:05:00.801] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9078914859702932416",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"1d03f9e3abcb8e2f7a222edb975622eeaa9a2c6e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9078914859702932416",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/1d03f9e3abcb8e2f7a222edb975622eeaa9a2c6e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d03f9e3abcb8e2f7a222edb975622eeaa9a2c6e",
"gitiles_ref:refs/heads/master"
]
}
[12:05:02.716] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1557835501439990",
"id": "8913484797201752560",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1d03f9e3abcb8e2f7a222edb975622eeaa9a2c6e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1557835502372280",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12382",
"builder:linux-chromeos-dbg",
"buildset:commit/git/1d03f9e3abcb8e2f7a222edb975622eeaa9a2c6e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d03f9e3abcb8e2f7a222edb975622eeaa9a2c6e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078914859702932416",
"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/8913484797201752560/+/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": "1557835502372424",
"url": "https://ci.chromium.org/b/8913484797201752560",
"utcnow_ts": "1557835502696452"
}
}
[12:05:02.716] Task URL: https://ci.chromium.org/b/8913484797201752560
[12:05:02.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:2:0) after 1m0s
[12:06:02.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:2:0)
[12:06:02.736] Timer tick, asking Buildbucket for the build status
[12:06:04.703] Build 8913484797201752560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:06:04.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:3:0) after 1m0s
[12:07:04.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:3:0)
[12:07:04.737] Timer tick, asking Buildbucket for the build status
[12:07:04.858] Build 8913484797201752560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:07:04.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:4:0) after 1m0s
[12:08:00.113] Received PubSub notification, asking Buildbucket for the build status
[12:08:00.412] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:04.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:4:0)
[12:08:04.899] Timer tick, asking Buildbucket for the build status
[12:08:06.311] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:06.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:6:0) after 1m0s
[12:09:06.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:6:0)
[12:09:06.330] Timer tick, asking Buildbucket for the build status
[12:09:07.150] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:07.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:7:0) after 1m0s
[12:10:07.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:7:0)
[12:10:07.172] Timer tick, asking Buildbucket for the build status
[12:10:09.604] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:09.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:8:0) after 1m0s
[12:11:09.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:8:0)
[12:11:09.612] Timer tick, asking Buildbucket for the build status
[12:11:11.045] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:11.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:9:0) after 1m0s
[12:12:11.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:9:0)
[12:12:11.096] Timer tick, asking Buildbucket for the build status
[12:12:14.310] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:14.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:10:0) after 1m0s
[12:13:14.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:10:0)
[12:13:14.289] Timer tick, asking Buildbucket for the build status
[12:13:15.789] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:15.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:11:0) after 1m0s
[12:14:15.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:11:0)
[12:14:15.810] Timer tick, asking Buildbucket for the build status
[12:14:17.954] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:17.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:12:0) after 1m0s
[12:15:17.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:12:0)
[12:15:17.974] Timer tick, asking Buildbucket for the build status
[12:15:18.133] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:18.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:13:0) after 1m0s
[12:16:18.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:13:0)
[12:16:18.172] Timer tick, asking Buildbucket for the build status
[12:16:18.378] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:18.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:14:0) after 1m0s
[12:17:18.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:14:0)
[12:17:18.356] Timer tick, asking Buildbucket for the build status
[12:17:18.635] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:18.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:15:0) after 1m0s
[12:18:18.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:15:0)
[12:18:18.655] Timer tick, asking Buildbucket for the build status
[12:18:20.062] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:20.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:16:0) after 1m0s
[12:19:20.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:16:0)
[12:19:20.076] Timer tick, asking Buildbucket for the build status
[12:19:20.700] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:20.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:17:0) after 1m0s
[12:20:20.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:17:0)
[12:20:20.734] Timer tick, asking Buildbucket for the build status
[12:20:20.987] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:20.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:18:0) after 1m0s
[12:21:21.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:18:0)
[12:21:21.018] Timer tick, asking Buildbucket for the build status
[12:21:21.151] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:21.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:19:0) after 1m0s
[12:22:21.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:19:0)
[12:22:21.155] Timer tick, asking Buildbucket for the build status
[12:22:21.264] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:21.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:20:0) after 1m0s
[12:23:21.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:20:0)
[12:23:21.288] Timer tick, asking Buildbucket for the build status
[12:23:21.480] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:21.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:21:0) after 1m0s
[12:24:21.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:21:0)
[12:24:21.501] Timer tick, asking Buildbucket for the build status
[12:24:23.269] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:23.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:22:0) after 1m0s
[12:25:23.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:22:0)
[12:25:23.267] Timer tick, asking Buildbucket for the build status
[12:25:23.472] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:23.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:23:0) after 1m0s
[12:26:23.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:23:0)
[12:26:23.497] Timer tick, asking Buildbucket for the build status
[12:26:25.618] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:25.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:24:0) after 1m0s
[12:27:25.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:24:0)
[12:27:25.640] Timer tick, asking Buildbucket for the build status
[12:27:25.801] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:25.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:25:0) after 1m0s
[12:28:25.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:25:0)
[12:28:25.784] Timer tick, asking Buildbucket for the build status
[12:28:26.056] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:26.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:26:0) after 1m0s
[12:29:26.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:26:0)
[12:29:26.084] Timer tick, asking Buildbucket for the build status
[12:29:26.401] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:26.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:27:0) after 1m0s
[12:30:26.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:27:0)
[12:30:26.396] Timer tick, asking Buildbucket for the build status
[12:30:26.519] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:26.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:28:0) after 1m0s
[12:31:26.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:28:0)
[12:31:26.538] Timer tick, asking Buildbucket for the build status
[12:31:27.072] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:27.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:29:0) after 1m0s
[12:32:27.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:29:0)
[12:32:27.096] Timer tick, asking Buildbucket for the build status
[12:32:28.528] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:28.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:30:0) after 1m0s
[12:33:28.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:30:0)
[12:33:28.595] Timer tick, asking Buildbucket for the build status
[12:33:28.683] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:28.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:31:0) after 1m0s
[12:34:28.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:31:0)
[12:34:28.695] Timer tick, asking Buildbucket for the build status
[12:34:29.019] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:29.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:32:0) after 1m0s
[12:35:29.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:32:0)
[12:35:29.189] Timer tick, asking Buildbucket for the build status
[12:35:30.515] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:30.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:33:0) after 1m0s
[12:36:30.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:33:0)
[12:36:30.536] Timer tick, asking Buildbucket for the build status
[12:36:32.458] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:32.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:34:0) after 1m0s
[12:37:32.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:34:0)
[12:37:32.478] Timer tick, asking Buildbucket for the build status
[12:37:32.694] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:32.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:35:0) after 1m0s
[12:38:32.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:35:0)
[12:38:32.713] Timer tick, asking Buildbucket for the build status
[12:38:32.863] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:32.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:36:0) after 1m0s
[12:39:32.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:36:0)
[12:39:32.889] Timer tick, asking Buildbucket for the build status
[12:39:34.418] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:34.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:37:0) after 1m0s
[12:40:34.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:37:0)
[12:40:34.457] Timer tick, asking Buildbucket for the build status
[12:40:34.876] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:34.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:38:0) after 1m0s
[12:41:34.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:38:0)
[12:41:34.896] Timer tick, asking Buildbucket for the build status
[12:41:35.029] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:35.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:39:0) after 1m0s
[12:42:35.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:39:0)
[12:42:35.049] Timer tick, asking Buildbucket for the build status
[12:42:35.353] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:35.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:40:0) after 1m0s
[12:43:35.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:40:0)
[12:43:35.442] Timer tick, asking Buildbucket for the build status
[12:43:35.697] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:35.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:41:0) after 1m0s
[12:44:35.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:41:0)
[12:44:35.762] Timer tick, asking Buildbucket for the build status
[12:44:35.907] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:35.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:42:0) after 1m0s
[12:45:35.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:42:0)
[12:45:35.950] Timer tick, asking Buildbucket for the build status
[12:45:36.340] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:36.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:43:0) after 1m0s
[12:46:36.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:43:0)
[12:46:36.361] Timer tick, asking Buildbucket for the build status
[12:46:37.022] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:37.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:44:0) after 1m0s
[12:47:37.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:44:0)
[12:47:37.088] Timer tick, asking Buildbucket for the build status
[12:47:37.888] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:37.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:45:0) after 1m0s
[12:48:37.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:45:0)
[12:48:37.914] Timer tick, asking Buildbucket for the build status
[12:48:39.580] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:39.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:46:0) after 1m0s
[12:49:39.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:46:0)
[12:49:39.603] Timer tick, asking Buildbucket for the build status
[12:49:39.893] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:39.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:47:0) after 1m0s
[12:50:39.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:47:0)
[12:50:39.919] Timer tick, asking Buildbucket for the build status
[12:50:40.129] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:40.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:48:0) after 1m0s
[12:51:40.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:48:0)
[12:51:40.153] Timer tick, asking Buildbucket for the build status
[12:51:41.479] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:41.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:49:0) after 1m0s
[12:52:41.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:49:0)
[12:52:41.499] Timer tick, asking Buildbucket for the build status
[12:52:42.063] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:42.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:50:0) after 1m0s
[12:53:42.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:50:0)
[12:53:42.087] Timer tick, asking Buildbucket for the build status
[12:53:42.271] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:42.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:51:0) after 1m0s
[12:54:42.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:51:0)
[12:54:42.309] Timer tick, asking Buildbucket for the build status
[12:54:42.519] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:42.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:52:0) after 1m0s
[12:55:42.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:52:0)
[12:55:42.631] Timer tick, asking Buildbucket for the build status
[12:55:42.996] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:42.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:53:0) after 1m0s
[12:56:43.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:53:0)
[12:56:43.145] Timer tick, asking Buildbucket for the build status
[12:56:43.780] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:43.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:54:0) after 1m0s
[12:57:43.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:54:0)
[12:57:43.805] Timer tick, asking Buildbucket for the build status
[12:57:43.974] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:43.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:55:0) after 1m0s
[12:58:43.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:55:0)
[12:58:43.986] Timer tick, asking Buildbucket for the build status
[12:58:44.254] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:44.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:56:0) after 1m0s
[12:59:44.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:56:0)
[12:59:44.294] Timer tick, asking Buildbucket for the build status
[12:59:44.699] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:44.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:57:0) after 1m0s
[13:00:44.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:57:0)
[13:00:44.726] Timer tick, asking Buildbucket for the build status
[13:00:45.022] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:45.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:58:0) after 1m0s
[13:01:45.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:58:0)
[13:01:45.054] Timer tick, asking Buildbucket for the build status
[13:01:45.219] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:45.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:59:0) after 1m0s
[13:02:45.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:59:0)
[13:02:45.288] Timer tick, asking Buildbucket for the build status
[13:02:45.876] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:45.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:60:0) after 1m0s
[13:03:45.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:60:0)
[13:03:45.894] Timer tick, asking Buildbucket for the build status
[13:03:46.302] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:46.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:61:0) after 1m0s
[13:04:46.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:61:0)
[13:04:46.328] Timer tick, asking Buildbucket for the build status
[13:04:47.727] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:47.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:62:0) after 1m0s
[13:05:47.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:62:0)
[13:05:47.735] Timer tick, asking Buildbucket for the build status
[13:05:48.275] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:48.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:63:0) after 1m0s
[13:06:48.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:63:0)
[13:06:48.294] Timer tick, asking Buildbucket for the build status
[13:06:49.656] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:49.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:64:0) after 1m0s
[13:07:49.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:64:0)
[13:07:49.684] Timer tick, asking Buildbucket for the build status
[13:07:50.755] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:50.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:65:0) after 1m0s
[13:08:50.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:65:0)
[13:08:50.779] Timer tick, asking Buildbucket for the build status
[13:08:51.184] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:51.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:66:0) after 1m0s
[13:09:51.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:66:0)
[13:09:51.175] Timer tick, asking Buildbucket for the build status
[13:09:51.350] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:51.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:67:0) after 1m0s
[13:10:51.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:67:0)
[13:10:51.370] Timer tick, asking Buildbucket for the build status
[13:10:51.595] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:51.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:68:0) after 1m0s
[13:11:51.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:68:0)
[13:11:51.658] Timer tick, asking Buildbucket for the build status
[13:11:51.997] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:51.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:69:0) after 1m0s
[13:12:51.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:69:0)
[13:12:51.970] Timer tick, asking Buildbucket for the build status
[13:12:52.653] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:52.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:70:0) after 1m0s
[13:13:52.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:70:0)
[13:13:52.668] Timer tick, asking Buildbucket for the build status
[13:13:52.763] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:52.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:71:0) after 1m0s
[13:14:52.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:71:0)
[13:14:52.786] Timer tick, asking Buildbucket for the build status
[13:14:53.511] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:53.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:72:0) after 1m0s
[13:15:53.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:72:0)
[13:15:53.532] Timer tick, asking Buildbucket for the build status
[13:15:53.709] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:53.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:73:0) after 1m0s
[13:16:53.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:73:0)
[13:16:53.727] Timer tick, asking Buildbucket for the build status
[13:16:54.019] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:54.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:74:0) after 1m0s
[13:17:54.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:74:0)
[13:17:54.017] Timer tick, asking Buildbucket for the build status
[13:17:54.319] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:54.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:75:0) after 1m0s
[13:18:54.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:75:0)
[13:18:54.339] Timer tick, asking Buildbucket for the build status
[13:18:55.055] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:55.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:76:0) after 1m0s
[13:19:55.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:76:0)
[13:19:55.076] Timer tick, asking Buildbucket for the build status
[13:19:55.483] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:55.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:77:0) after 1m0s
[13:20:55.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:77:0)
[13:20:55.538] Timer tick, asking Buildbucket for the build status
[13:20:57.340] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:57.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:78:0) after 1m0s
[13:21:57.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:78:0)
[13:21:57.388] Timer tick, asking Buildbucket for the build status
[13:21:57.571] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:57.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:79:0) after 1m0s
[13:22:57.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:79:0)
[13:22:57.569] Timer tick, asking Buildbucket for the build status
[13:22:59.237] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:59.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:80:0) after 1m0s
[13:23:59.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:80:0)
[13:23:59.273] Timer tick, asking Buildbucket for the build status
[13:24:00.620] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:00.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:81:0) after 1m0s
[13:25:00.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:81:0)
[13:25:00.617] Timer tick, asking Buildbucket for the build status
[13:25:01.770] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:01.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:82:0) after 1m0s
[13:26:01.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:82:0)
[13:26:01.774] Timer tick, asking Buildbucket for the build status
[13:26:01.976] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:01.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:83:0) after 1m0s
[13:27:02.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:83:0)
[13:27:02.022] Timer tick, asking Buildbucket for the build status
[13:27:02.709] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:02.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:84:0) after 1m0s
[13:28:02.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:84:0)
[13:28:02.733] Timer tick, asking Buildbucket for the build status
[13:28:04.334] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:04.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:85:0) after 1m0s
[13:29:04.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:85:0)
[13:29:04.357] Timer tick, asking Buildbucket for the build status
[13:29:04.506] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:04.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:86:0) after 1m0s
[13:30:04.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:86:0)
[13:30:04.532] Timer tick, asking Buildbucket for the build status
[13:30:05.708] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:05.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:87:0) after 1m0s
[13:31:05.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:87:0)
[13:31:05.730] Timer tick, asking Buildbucket for the build status
[13:31:06.068] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:06.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:88:0) after 1m0s
[13:32:06.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:88:0)
[13:32:06.054] Timer tick, asking Buildbucket for the build status
[13:32:06.381] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:06.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:89:0) after 1m0s
[13:33:06.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:89:0)
[13:33:06.404] Timer tick, asking Buildbucket for the build status
[13:33:06.817] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:06.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:90:0) after 1m0s
[13:34:06.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:90:0)
[13:34:06.839] Timer tick, asking Buildbucket for the build status
[13:34:09.928] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:09.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:91:0) after 1m0s
[13:35:09.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:91:0)
[13:35:09.951] Timer tick, asking Buildbucket for the build status
[13:35:10.330] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:10.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:92:0) after 1m0s
[13:36:10.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:92:0)
[13:36:10.354] Timer tick, asking Buildbucket for the build status
[13:36:10.750] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:10.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:93:0) after 1m0s
[13:37:10.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:93:0)
[13:37:10.858] Timer tick, asking Buildbucket for the build status
[13:37:11.294] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:11.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:94:0) after 1m0s
[13:38:11.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:94:0)
[13:38:11.346] Timer tick, asking Buildbucket for the build status
[13:38:11.447] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:11.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:95:0) after 1m0s
[13:39:11.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:95:0)
[13:39:11.467] Timer tick, asking Buildbucket for the build status
[13:39:12.494] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:12.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:96:0) after 1m0s
[13:40:12.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:96:0)
[13:40:12.506] Timer tick, asking Buildbucket for the build status
[13:40:12.965] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:12.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:97:0) after 1m0s
[13:41:13.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:97:0)
[13:41:13.610] Timer tick, asking Buildbucket for the build status
[13:41:14.525] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:14.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:98:0) after 1m0s
[13:42:14.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:98:0)
[13:42:14.548] Timer tick, asking Buildbucket for the build status
[13:42:14.853] Build 8913484797201752560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:14.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078914859702932416:99:0) after 1m0s
[13:42:35.064] Received PubSub notification, asking Buildbucket for the build status
[13:42:36.604] Build 8913484797201752560: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[13:42:36.604] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1557841354309920",
"created_by": "project:chromium",
"created_ts": "1557835501439990",
"failure_reason": "BUILD_FAILURE",
"id": "8913484797201752560",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1d03f9e3abcb8e2f7a222edb975622eeaa9a2c6e\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 tests failed: ['exo_unittests', 'ash_unittests', 'unit_tests']\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"swarm1567-c4\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 12382, \"got_angle_revision\": \"b783fbc799922b43c0988c8686854da85330e679\", \"got_dawn_revision\": \"2e56970932ec01ef2b030fe6b27f305c7733a47f\", \"got_nacl_revision\": \"ca374f5112fca6b36fc5d73e117a60b82f394993\", \"got_revision\": \"1d03f9e3abcb8e2f7a222edb975622eeaa9a2c6e\", \"got_revision_cp\": \"refs/heads/master@{#659456}\", \"got_swarming_client_revision\": \"1b65f4e862045f3ba430a4cbd0643f5b1b66c230\", \"got_v8_revision\": \"c27e7b4f22ec6902fa30797a535cca040aa78b0a\", \"got_v8_revision_cp\": \"refs/heads/7.6.172@{#1}\", \"got_webrtc_revision\": \"e62a08a87a6f21672b2ae8ba25632007f417a3f1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27934}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1d03f9e3abcb8e2f7a222edb975622eeaa9a2c6e\", \"swarm_hashes\": {\"accessibility_unittests\": \"ad5c4f5416772d3f79b567de4b83ea80f80fbcb4\", \"angle_unittests\": \"a619b969d32e036766da4c315757c18e087000a7\", \"app_list_unittests\": \"a2033212e0af86ceff8921f5ba13f94240d3e8fc\", \"app_shell_unittests\": \"fa6e086e3cc8639c3689e1d7732f6f6baac68696\", \"ash_unittests\": \"03b18ceb4c8006ee5155c31616c4ebb076bf86bb\", \"aura_unittests\": \"68cded38bd51dee7ec36b1c564dd52b67da3085c\", \"base_unittests\": \"a235f884a17d14e0970eb9f822624243ae2c6cb8\", \"base_util_unittests\": \"9726f71794a356e532684fb3ff01e2c6716cfb48\", \"blink_common_unittests\": \"93486333e15124a78a4ecd151f23ae6c5a69915a\", \"blink_fuzzer_unittests\": \"921473edf6bb3d604b13ef87f45a76ebcbc5545c\", \"blink_heap_unittests\": \"35575ca64a64bb7e3a306eb6edc6a892a0ee3213\", \"blink_platform_unittests\": \"ca3dae42d09cb9c328adfcb726c50cb9b77d8079\", \"blink_unittests\": \"4fe8f984bd89f3878420e36f639deb284e50659b\", \"boringssl_crypto_tests\": \"546fd40962cac2192bc7c53e49a25cfd5c26d910\", \"boringssl_ssl_tests\": \"c6ef206cecb1a79d6ca37367148d38a1e2f0aabf\", \"browser_tests\": \"4a49f2a8017fa2f22d0c683d99a196afe2b1e7d6\", \"cacheinvalidation_unittests\": \"4ed3b55112b02b4e0f3f1899939fee3ae3eaf800\", \"capture_unittests\": \"7ac971f5624ecbf57a511c1bbeeec8e4ffc1be55\", \"cast_unittests\": \"e9fed388039992dbdd794bfe8d431c312bb54c0a\", \"cc_unittests\": \"d7e6139fe4543ee105c4b9f76853874176e55982\", \"chrome_app_unittests\": \"95e32f99451b564d5c7d2bd4e9d39c8ea2cd9a37\", \"chromedriver_unittests\": \"e44f46732c182df8238daf056dea2437a436311a\", \"chromeos_components_unittests\": \"0661f66ed0ac4fd00043be9666478debe750956b\", \"chromeos_unittests\": \"4184f1a0850438aae13ddc8ac71f19fb2c797ae0\", \"components_browsertests\": \"9270baf9d67ec40e84c4e186a301142f0aa4d31f\", \"components_unittests\": \"10bcf6f4339b63c56d38010a81a4f7fc65178fa5\", \"compositor_unittests\": \"77f6702a7cf69421b326da3bfa39e0e892458d53\", \"content_browsertests\": \"a70369e6249acec66ad2d98186133d23f8e4ec40\", \"content_unittests\": \"01e2923a41bbcd31a72c68f8f71764197cfdf982\", \"crypto_unittests\": \"a5a7a68beee12e298580e0875a5de53769b12f68\", \"dbus_unittests\": \"64c99eee64124a8865fe071ff7cce984fc71024d\", \"device_unittests\": \"dd558591e9ec40e394a6a46130608b59cc350526\", \"display_unittests\": \"fb59ea867baba026e76ac472e844b819fe6eed7e\", \"events_unittests\": \"89b46c7118f7fcc5078a737739a3ae56bb18911c\", \"exo_unittests\": \"494adc0ab2dd5c00b374db5411a5177d54074e87\", \"extensions_browsertests\": \"ed11759a2b0fb263404c423b0ddd8d0f05042417\", \"extensions_unittests\": \"d3a85b201ee16d7fdb3f740fc3c6b0b611ba4ff4\", \"filesystem_service_unittests\": \"815985118065ef1ac57ae55a41ff082a65959d91\", \"gcm_unit_tests\": \"582e5f96ef35eb3f078983b9186ddff71dd434e0\", \"gfx_unittests\": \"ce444f2b688ee9ec55532db60161fe791d9b706c\", \"gin_unittests\": \"cc4931bc06b9d57b8f0700076f4aac8220a97eaf\", \"gl_unittests_ozone\": \"7e9eb2d290f48bde5b8d763ddce1e7fc78c059a0\", \"google_apis_unittests\": \"b829bc84c9c3df15c5633e9606cf38f6ec2c5249\", \"gpu_unittests\": \"1e6414f5a30cdf3fe8df91c3a661b0335e473778\", \"interactive_ui_tests\": \"10e5cb8d381518567c594769832b2dc12bac7bfc\", \"ipc_tests\": \"a1447d695a0197f82f9da15bd21c68c529d9bd00\", \"jingle_unittests\": \"393ceb66ef4b5d2bb04b5c1d7203b3f4c7578308\", \"keyboard_unittests\": \"5c830b76da10fe47026fa9e535c165107b5ed620\", \"latency_unittests\": \"1cafbfdccedeb43cd9d21d1311d9fecc29e3e6a8\", \"leveldb_service_unittests\": \"3f5c91c108b4cfe182418be5fc44d0e265bf3690\", \"libjingle_xmpp_unittests\": \"08259077e4f28c5ab5b0d04807b198ee26794bc4\", \"media_blink_unittests\": \"f6743e7de548d83955eb20536a7f4594d7658b89\", \"media_service_unittests\": \"b2a2324a4ce9f33e87711a6ca386d76c3bc82994\", \"media_unittests\": \"f56827211265c95130c20f927fe009402c9b102d\", \"message_center_unittests\": \"e8891e7a04cecc390aae30712aa27262e3e3df2d\", \"midi_unittests\": \"6020ed9f969094af853c18f49c6052af85bfcc28\", \"mojo_core_unittests\": \"deb8416f88b315ad3e1e460ed8a5884d791f6d54\", \"mojo_unittests\": \"9a430ff417227550be845dcc78db9b1cdd4e18a4\", \"nacl_helper_nonsfi_unittests\": \"e87211242c6b419de1270119eb2ee50ce07cd99b\", \"nacl_loader_unittests\": \"4221798fdddd9fa0d78940fd833900a310353fa8\", \"native_theme_unittests\": \"51c0c17da4e4b8bd1cc125b5496df3ae7ca56a4e\", \"net_unittests\": \"4788a37f74cdec6ca86916cd4d4029bb696df315\", \"ozone_gl_unittests\": \"8368283e173cb463640d7d7fae314a8b605f006f\", \"ozone_unittests\": \"17853019fcf889ee7c95a4bd9251939e75c90f91\", \"ozone_x11_unittests\": \"a4041f869cff0a4da8e89c4043d8f04070bcb8d5\", \"pdf_unittests\": \"164f84d527634e152daeb9081a6aa24c269fd823\", \"perfetto_unittests\": \"0f10badd95db2be3ceb0213460b301144fb44e12\", \"ppapi_unittests\": \"d15b80bee12ca51aa2ab25ff8d9395c0b254606c\", \"printing_unittests\": \"c5ee4c05764de6b645f262c55ed00d654a4d5659\", \"remoting_unittests\": \"059765739017afa9ab045e428fd2792d1eea4dd8\", \"sandbox_linux_unittests\": \"0965db779ae6f9b46ace9689e445dfcd11a6fa34\", \"service_manager_unittests\": \"31d707f1311689394f307a2870d73b3ffd3e670e\", \"services_unittests\": \"87a96e3258bd4ec46c18193f04e694f679c59766\", \"shell_dialogs_unittests\": \"6be17eb11bc2b7f769bba7bef4d92f177a256ada\", \"skia_unittests\": \"890e6dad54f74bdd5d6f654e8724f67081b3144f\", \"snapshot_unittests\": \"332d966fece6ddb3ffccfb95bc6640622a47fc73\", \"sql_unittests\": \"6a1a1b8087ed5bbc4998a8b39e9c4ca318660fc8\", \"storage_unittests\": \"6bd9d5ca62f194790a363784cbd281b02847b191\", \"sync_integration_tests\": \"51d7e87c178677455e2c251aa50b9ddbb666a2db\", \"traffic_annotation_auditor_unittests\": \"2848164ed678473beaf0befcfe034f61e63ea49d\", \"ui_base_unittests\": \"cde6a0f8e15fb9f1d8933b3869b16c15bcecb906\", \"ui_chromeos_unittests\": \"45190f7bc81d3d47917f50bb3013b9d17de4e696\", \"ui_touch_selection_unittests\": \"5286b95f113d6059b37da24d94de4d39b27cfa0c\", \"unit_tests\": \"c325f3d18fd7cd87bb817fc5d9228a36ae0424f8\", \"url_unittests\": \"9cd1951a24887659530a096b7720a8dba86a0d2c\", \"usage_time_limit_unittests\": \"303cf0988af63d80424bd98f14ec4bae1c35a9d2\", \"views_unittests\": \"3e63f469019c37b4fabe9e47c54228ca2afc8d1a\", \"viz_unittests\": \"a312e70993aa52c2a6f5627a39d81bd9a599e445\", \"wm_unittests\": \"cac98ff4fef96eda6acbdaa48c7e192a539950e7\", \"wtf_unittests\": \"464d780d1c09258ab981add9e7b0031a97b17cfa\"}, \"swarm_hashes_refs/heads/master(at){#659456}_without_patch\": {\"accessibility_unittests\": \"ad5c4f5416772d3f79b567de4b83ea80f80fbcb4\", \"angle_unittests\": \"a619b969d32e036766da4c315757c18e087000a7\", \"app_list_unittests\": \"a2033212e0af86ceff8921f5ba13f94240d3e8fc\", \"app_shell_unittests\": \"fa6e086e3cc8639c3689e1d7732f6f6baac68696\", \"ash_unittests\": \"03b18ceb4c8006ee5155c31616c4ebb076bf86bb\", \"aura_unittests\": \"68cded38bd51dee7ec36b1c564dd52b67da3085c\", \"base_unittests\": \"a235f884a17d14e0970eb9f822624243ae2c6cb8\", \"base_util_unittests\": \"9726f71794a356e532684fb3ff01e2c6716cfb48\", \"blink_common_unittests\": \"93486333e15124a78a4ecd151f23ae6c5a69915a\", \"blink_fuzzer_unittests\": \"921473edf6bb3d604b13ef87f45a76ebcbc5545c\", \"blink_heap_unittests\": \"35575ca64a64bb7e3a306eb6edc6a892a0ee3213\", \"blink_platform_unittests\": \"ca3dae42d09cb9c328adfcb726c50cb9b77d8079\", \"blink_unittests\": \"4fe8f984bd89f3878420e36f639deb284e50659b\", \"boringssl_crypto_tests\": \"546fd40962cac2192bc7c53e49a25cfd5c26d910\", \"boringssl_ssl_tests\": \"c6ef206cecb1a79d6ca37367148d38a1e2f0aabf\", \"browser_tests\": \"4a49f2a8017fa2f22d0c683d99a196afe2b1e7d6\", \"cacheinvalidation_unittests\": \"4ed3b55112b02b4e0f3f1899939fee3ae3eaf800\", \"capture_unittests\": \"7ac971f5624ecbf57a511c1bbeeec8e4ffc1be55\", \"cast_unittests\": \"e9fed388039992dbdd794bfe8d431c312bb54c0a\", \"cc_unittests\": \"d7e6139fe4543ee105c4b9f76853874176e55982\", \"chrome_app_unittests\": \"95e32f99451b564d5c7d2bd4e9d39c8ea2cd9a37\", \"chromedriver_unittests\": \"e44f46732c182df8238daf056dea2437a436311a\", \"chromeos_components_unittests\": \"0661f66ed0ac4fd00043be9666478debe750956b\", \"chromeos_unittests\": \"4184f1a0850438aae13ddc8ac71f19fb2c797ae0\", \"components_browsertests\": \"9270baf9d67ec40e84c4e186a301142f0aa4d31f\", \"components_unittests\": \"10bcf6f4339b63c56d38010a81a4f7fc65178fa5\", \"compositor_unittests\": \"77f6702a7cf69421b326da3bfa39e0e892458d53\", \"content_browsertests\": \"a70369e6249acec66ad2d98186133d23f8e4ec40\", \"content_unittests\": \"01e2923a41bbcd31a72c68f8f71764197cfdf982\", \"crypto_unittests\": \"a5a7a68beee12e298580e0875a5de53769b12f68\", \"dbus_unittests\": \"64c99eee64124a8865fe071ff7cce984fc71024d\", \"device_unittests\": \"dd558591e9ec40e394a6a46130608b59cc350526\", \"display_unittests\": \"fb59ea867baba026e76ac472e844b819fe6eed7e\", \"events_unittests\": \"89b46c7118f7fcc5078a737739a3ae56bb18911c\", \"exo_unittests\": \"494adc0ab2dd5c00b374db5411a5177d54074e87\", \"extensions_browsertests\": \"ed11759a2b0fb263404c423b0ddd8d0f05042417\", \"extensions_unittests\": \"d3a85b201ee16d7fdb3f740fc3c6b0b611ba4ff4\", \"filesystem_service_unittests\": \"815985118065ef1ac57ae55a41ff082a65959d91\", \"gcm_unit_tests\": \"582e5f96ef35eb3f078983b9186ddff71dd434e0\", \"gfx_unittests\": \"ce444f2b688ee9ec55532db60161fe791d9b706c\", \"gin_unittests\": \"cc4931bc06b9d57b8f0700076f4aac8220a97eaf\", \"gl_unittests_ozone\": \"7e9eb2d290f48bde5b8d763ddce1e7fc78c059a0\", \"google_apis_unittests\": \"b829bc84c9c3df15c5633e9606cf38f6ec2c5249\", \"gpu_unittests\": \"1e6414f5a30cdf3fe8df91c3a661b0335e473778\", \"interactive_ui_tests\": \"10e5cb8d381518567c594769832b2dc12bac7bfc\", \"ipc_tests\": \"a1447d695a0197f82f9da15bd21c68c529d9bd00\", \"jingle_unittests\": \"393ceb66ef4b5d2bb04b5c1d7203b3f4c7578308\", \"keyboard_unittests\": \"5c830b76da10fe47026fa9e535c165107b5ed620\", \"latency_unittests\": \"1cafbfdccedeb43cd9d21d1311d9fecc29e3e6a8\", \"leveldb_service_unittests\": \"3f5c91c108b4cfe182418be5fc44d0e265bf3690\", \"libjingle_xmpp_unittests\": \"08259077e4f28c5ab5b0d04807b198ee26794bc4\", \"media_blink_unittests\": \"f6743e7de548d83955eb20536a7f4594d7658b89\", \"media_service_unittests\": \"b2a2324a4ce9f33e87711a6ca386d76c3bc82994\", \"media_unittests\": \"f56827211265c95130c20f927fe009402c9b102d\", \"message_center_unittests\": \"e8891e7a04cecc390aae30712aa27262e3e3df2d\", \"midi_unittests\": \"6020ed9f969094af853c18f49c6052af85bfcc28\", \"mojo_core_unittests\": \"deb8416f88b315ad3e1e460ed8a5884d791f6d54\", \"mojo_unittests\": \"9a430ff417227550be845dcc78db9b1cdd4e18a4\", \"nacl_helper_nonsfi_unittests\": \"e87211242c6b419de1270119eb2ee50ce07cd99b\", \"nacl_loader_unittests\": \"4221798fdddd9fa0d78940fd833900a310353fa8\", \"native_theme_unittests\": \"51c0c17da4e4b8bd1cc125b5496df3ae7ca56a4e\", \"net_unittests\": \"4788a37f74cdec6ca86916cd4d4029bb696df315\", \"ozone_gl_unittests\": \"8368283e173cb463640d7d7fae314a8b605f006f\", \"ozone_unittests\": \"17853019fcf889ee7c95a4bd9251939e75c90f91\", \"ozone_x11_unittests\": \"a4041f869cff0a4da8e89c4043d8f04070bcb8d5\", \"pdf_unittests\": \"164f84d527634e152daeb9081a6aa24c269fd823\", \"perfetto_unittests\": \"0f10badd95db2be3ceb0213460b301144fb44e12\", \"ppapi_unittests\": \"d15b80bee12ca51aa2ab25ff8d9395c0b254606c\", \"printing_unittests\": \"c5ee4c05764de6b645f262c55ed00d654a4d5659\", \"remoting_unittests\": \"059765739017afa9ab045e428fd2792d1eea4dd8\", \"sandbox_linux_unittests\": \"0965db779ae6f9b46ace9689e445dfcd11a6fa34\", \"service_manager_unittests\": \"31d707f1311689394f307a2870d73b3ffd3e670e\", \"services_unittests\": \"87a96e3258bd4ec46c18193f04e694f679c59766\", \"shell_dialogs_unittests\": \"6be17eb11bc2b7f769bba7bef4d92f177a256ada\", \"skia_unittests\": \"890e6dad54f74bdd5d6f654e8724f67081b3144f\", \"snapshot_unittests\": \"332d966fece6ddb3ffccfb95bc6640622a47fc73\", \"sql_unittests\": \"6a1a1b8087ed5bbc4998a8b39e9c4ca318660fc8\", \"storage_unittests\": \"6bd9d5ca62f194790a363784cbd281b02847b191\", \"sync_integration_tests\": \"51d7e87c178677455e2c251aa50b9ddbb666a2db\", \"traffic_annotation_auditor_unittests\": \"2848164ed678473beaf0befcfe034f61e63ea49d\", \"ui_base_unittests\": \"cde6a0f8e15fb9f1d8933b3869b16c15bcecb906\", \"ui_chromeos_unittests\": \"45190f7bc81d3d47917f50bb3013b9d17de4e696\", \"ui_touch_selection_unittests\": \"5286b95f113d6059b37da24d94de4d39b27cfa0c\", \"unit_tests\": \"c325f3d18fd7cd87bb817fc5d9228a36ae0424f8\", \"url_unittests\": \"9cd1951a24887659530a096b7720a8dba86a0d2c\", \"usage_time_limit_unittests\": \"303cf0988af63d80424bd98f14ec4bae1c35a9d2\", \"views_unittests\": \"3e63f469019c37b4fabe9e47c54228ca2afc8d1a\", \"viz_unittests\": \"a312e70993aa52c2a6f5627a39d81bd9a599e445\", \"wm_unittests\": \"cac98ff4fef96eda6acbdaa48c7e192a539950e7\", \"wtf_unittests\": \"464d780d1c09258ab981add9e7b0031a97b17cfa\"}}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"linux-chromeos-dbg\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm1567-c4\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4293-d3520ea\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"3 tests failed: ['exo_unittests', 'ash_unittests', 'unit_tests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1557835678876184",
"status": "COMPLETED",
"status_changed_ts": "1557835679585778",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12382",
"builder:linux-chromeos-dbg",
"buildset:commit/git/1d03f9e3abcb8e2f7a222edb975622eeaa9a2c6e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d03f9e3abcb8e2f7a222edb975622eeaa9a2c6e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078914859702932416",
"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/8913484797201752560/+/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:44cf0cdd539f6d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1557841354560520",
"url": "https://ci.chromium.org/b/8913484797201752560",
"utcnow_ts": "1557841356585559"
}
}
[13:42:36.605] Invocation finished in 1h37m36.934865489s with status FAILED