[16:14:12.731] New invocation is queued and will start shortly
[16:14:13.820] Starting the invocation (attempt 1)
[16:14:13.865] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:14:13.865] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:14:13.865] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029886221479296480",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"70f2d45c60d2038f8f59fd4d78949de1376c8d4e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9029886221479296480",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/70f2d45c60d2038f8f59fd4d78949de1376c8d4e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/70f2d45c60d2038f8f59fd4d78949de1376c8d4e",
"gitiles_ref:refs/heads/master"
]
}
[16:14:14.728] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604592853967598",
"id": "8864456159516534304",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"70f2d45c60d2038f8f59fd4d78949de1376c8d4e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604592854493506",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21161",
"builder:linux-chromeos-dbg",
"buildset:commit/git/70f2d45c60d2038f8f59fd4d78949de1376c8d4e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/70f2d45c60d2038f8f59fd4d78949de1376c8d4e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029886221479296480",
"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/8864456159516534304/+/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": "1604592854493718",
"url": "https://ci.chromium.org/b/8864456159516534304",
"utcnow_ts": "1604592854675074"
}
}
[16:14:14.728] Task URL: https://ci.chromium.org/b/8864456159516534304
[16:14:14.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:2:0) after 1m0s
[16:14:18.307] Received PubSub notification, asking Buildbucket for the build status
[16:14:18.378] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:14.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:2:0)
[16:15:14.815] Timer tick, asking Buildbucket for the build status
[16:15:14.980] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:14.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:4:0) after 1m0s
[16:16:14.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:4:0)
[16:16:14.980] Timer tick, asking Buildbucket for the build status
[16:16:15.052] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:15.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:5:0) after 1m0s
[16:17:15.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:5:0)
[16:17:15.079] Timer tick, asking Buildbucket for the build status
[16:17:15.185] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:15.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:6:0) after 1m0s
[16:18:15.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:6:0)
[16:18:15.458] Timer tick, asking Buildbucket for the build status
[16:18:15.582] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:15.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:7:0) after 1m0s
[16:19:15.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:7:0)
[16:19:15.600] Timer tick, asking Buildbucket for the build status
[16:19:15.790] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:15.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:8:0) after 1m0s
[16:20:15.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:8:0)
[16:20:15.832] Timer tick, asking Buildbucket for the build status
[16:20:15.966] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:15.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:9:0) after 1m0s
[16:21:16.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:9:0)
[16:21:16.011] Timer tick, asking Buildbucket for the build status
[16:21:16.081] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:16.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:10:0) after 1m0s
[16:22:16.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:10:0)
[16:22:16.232] Timer tick, asking Buildbucket for the build status
[16:22:16.324] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:16.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:11:0) after 1m0s
[16:23:16.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:11:0)
[16:23:16.537] Timer tick, asking Buildbucket for the build status
[16:23:16.627] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:16.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:12:0) after 1m0s
[16:24:16.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:12:0)
[16:24:16.785] Timer tick, asking Buildbucket for the build status
[16:24:16.932] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:16.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:13:0) after 1m0s
[16:25:17.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:13:0)
[16:25:17.113] Timer tick, asking Buildbucket for the build status
[16:25:17.270] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:17.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:14:0) after 1m0s
[16:26:17.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:14:0)
[16:26:17.468] Timer tick, asking Buildbucket for the build status
[16:26:17.567] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:17.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:15:0) after 1m0s
[16:27:17.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:15:0)
[16:27:17.635] Timer tick, asking Buildbucket for the build status
[16:27:17.692] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:17.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:16:0) after 1m0s
[16:28:17.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:16:0)
[16:28:17.772] Timer tick, asking Buildbucket for the build status
[16:28:17.830] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:17.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:17:0) after 1m0s
[16:29:17.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:17:0)
[16:29:17.875] Timer tick, asking Buildbucket for the build status
[16:29:18.391] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:18.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:18:0) after 1m0s
[16:30:18.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:18:0)
[16:30:18.508] Timer tick, asking Buildbucket for the build status
[16:30:19.042] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:19.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:19:0) after 1m0s
[16:31:19.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:19:0)
[16:31:19.398] Timer tick, asking Buildbucket for the build status
[16:31:19.456] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:19.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:20:0) after 1m0s
[16:32:19.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:20:0)
[16:32:19.539] Timer tick, asking Buildbucket for the build status
[16:32:19.602] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:19.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:21:0) after 1m0s
[16:33:19.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:21:0)
[16:33:19.669] Timer tick, asking Buildbucket for the build status
[16:33:19.732] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:19.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:22:0) after 1m0s
[16:34:19.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:22:0)
[16:34:19.958] Timer tick, asking Buildbucket for the build status
[16:34:20.068] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:20.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:23:0) after 1m0s
[16:35:20.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:23:0)
[16:35:20.227] Timer tick, asking Buildbucket for the build status
[16:35:20.295] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:20.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:24:0) after 1m0s
[16:36:20.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:24:0)
[16:36:20.409] Timer tick, asking Buildbucket for the build status
[16:36:20.475] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:20.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:25:0) after 1m0s
[16:37:20.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:25:0)
[16:37:20.507] Timer tick, asking Buildbucket for the build status
[16:37:20.578] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:20.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:26:0) after 1m0s
[16:38:20.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:26:0)
[16:38:20.711] Timer tick, asking Buildbucket for the build status
[16:38:20.791] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:20.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:27:0) after 1m0s
[16:39:20.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:27:0)
[16:39:20.839] Timer tick, asking Buildbucket for the build status
[16:39:20.949] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:20.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:28:0) after 1m0s
[16:40:20.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:28:0)
[16:40:20.950] Timer tick, asking Buildbucket for the build status
[16:40:21.173] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:21.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:29:0) after 1m0s
[16:41:21.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:29:0)
[16:41:21.225] Timer tick, asking Buildbucket for the build status
[16:41:21.327] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:21.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:30:0) after 1m0s
[16:42:21.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:30:0)
[16:42:21.365] Timer tick, asking Buildbucket for the build status
[16:42:21.451] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:21.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:31:0) after 1m0s
[16:43:21.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:31:0)
[16:43:21.471] Timer tick, asking Buildbucket for the build status
[16:43:21.828] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:21.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:32:0) after 1m0s
[16:44:21.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:32:0)
[16:44:21.923] Timer tick, asking Buildbucket for the build status
[16:44:22.033] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:22.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:33:0) after 1m0s
[16:45:22.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:33:0)
[16:45:22.105] Timer tick, asking Buildbucket for the build status
[16:45:22.217] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:22.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:34:0) after 1m0s
[16:46:22.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:34:0)
[16:46:22.484] Timer tick, asking Buildbucket for the build status
[16:46:22.601] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:22.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:35:0) after 1m0s
[16:47:22.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:35:0)
[16:47:22.678] Timer tick, asking Buildbucket for the build status
[16:47:22.765] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:22.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:36:0) after 1m0s
[16:48:22.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:36:0)
[16:48:22.899] Timer tick, asking Buildbucket for the build status
[16:48:23.057] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:23.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:37:0) after 1m0s
[16:49:23.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:37:0)
[16:49:23.344] Timer tick, asking Buildbucket for the build status
[16:49:23.536] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:23.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:38:0) after 1m0s
[16:50:23.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:38:0)
[16:50:23.620] Timer tick, asking Buildbucket for the build status
[16:50:23.736] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:23.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:39:0) after 1m0s
[16:51:23.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:39:0)
[16:51:23.901] Timer tick, asking Buildbucket for the build status
[16:51:24.046] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:24.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:40:0) after 1m0s
[16:52:24.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:40:0)
[16:52:24.213] Timer tick, asking Buildbucket for the build status
[16:52:24.337] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:24.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:41:0) after 1m0s
[16:53:24.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:41:0)
[16:53:24.440] Timer tick, asking Buildbucket for the build status
[16:53:24.547] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:24.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:42:0) after 1m0s
[16:54:24.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:42:0)
[16:54:24.719] Timer tick, asking Buildbucket for the build status
[16:54:24.882] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:24.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:43:0) after 1m0s
[16:55:25.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:43:0)
[16:55:25.114] Timer tick, asking Buildbucket for the build status
[16:55:25.236] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:25.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:44:0) after 1m0s
[16:56:25.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:44:0)
[16:56:25.437] Timer tick, asking Buildbucket for the build status
[16:56:25.510] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:25.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:45:0) after 1m0s
[16:57:25.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:45:0)
[16:57:25.748] Timer tick, asking Buildbucket for the build status
[16:57:25.816] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:25.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:46:0) after 1m0s
[16:58:26.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:46:0)
[16:58:26.043] Timer tick, asking Buildbucket for the build status
[16:58:26.378] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:26.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:47:0) after 1m0s
[16:59:26.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:47:0)
[16:59:26.407] Timer tick, asking Buildbucket for the build status
[16:59:26.829] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:26.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:48:0) after 1m0s
[17:00:27.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:48:0)
[17:00:27.203] Timer tick, asking Buildbucket for the build status
[17:00:27.637] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:27.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:49:0) after 1m0s
[17:01:28.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:49:0)
[17:01:28.091] Timer tick, asking Buildbucket for the build status
[17:01:28.243] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:28.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:50:0) after 1m0s
[17:02:28.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:50:0)
[17:02:28.403] Timer tick, asking Buildbucket for the build status
[17:02:28.535] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:28.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:51:0) after 1m0s
[17:03:28.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:51:0)
[17:03:28.742] Timer tick, asking Buildbucket for the build status
[17:03:28.901] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:28.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:52:0) after 1m0s
[17:04:28.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:52:0)
[17:04:28.973] Timer tick, asking Buildbucket for the build status
[17:04:29.229] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:29.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:53:0) after 1m0s
[17:05:29.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:53:0)
[17:05:29.562] Timer tick, asking Buildbucket for the build status
[17:05:30.244] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:30.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:54:0) after 1m0s
[17:06:30.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:54:0)
[17:06:30.326] Timer tick, asking Buildbucket for the build status
[17:06:30.935] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:30.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:55:0) after 1m0s
[17:07:30.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:55:0)
[17:07:30.967] Timer tick, asking Buildbucket for the build status
[17:07:31.159] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:31.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:56:0) after 1m0s
[17:08:31.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:56:0)
[17:08:31.289] Timer tick, asking Buildbucket for the build status
[17:08:31.426] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:31.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:57:0) after 1m0s
[17:09:31.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:57:0)
[17:09:31.413] Timer tick, asking Buildbucket for the build status
[17:09:31.574] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:31.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:58:0) after 1m0s
[17:10:31.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:58:0)
[17:10:31.708] Timer tick, asking Buildbucket for the build status
[17:10:32.097] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:32.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:59:0) after 1m0s
[17:11:32.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:59:0)
[17:11:32.160] Timer tick, asking Buildbucket for the build status
[17:11:32.301] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:32.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:60:0) after 1m0s
[17:12:32.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:60:0)
[17:12:32.338] Timer tick, asking Buildbucket for the build status
[17:12:32.438] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:32.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:61:0) after 1m0s
[17:13:32.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:61:0)
[17:13:32.496] Timer tick, asking Buildbucket for the build status
[17:13:32.583] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:32.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:62:0) after 1m0s
[17:14:32.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:62:0)
[17:14:32.624] Timer tick, asking Buildbucket for the build status
[17:14:33.291] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:33.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:63:0) after 1m0s
[17:15:33.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:63:0)
[17:15:33.363] Timer tick, asking Buildbucket for the build status
[17:15:33.461] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:33.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:64:0) after 1m0s
[17:16:33.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:64:0)
[17:16:33.453] Timer tick, asking Buildbucket for the build status
[17:16:33.537] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:33.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:65:0) after 1m0s
[17:17:33.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:65:0)
[17:17:33.605] Timer tick, asking Buildbucket for the build status
[17:17:33.934] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:33.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:66:0) after 1m0s
[17:18:33.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:66:0)
[17:18:33.985] Timer tick, asking Buildbucket for the build status
[17:18:34.093] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:34.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:67:0) after 1m0s
[17:19:34.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:67:0)
[17:19:34.135] Timer tick, asking Buildbucket for the build status
[17:19:34.406] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:34.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:68:0) after 1m0s
[17:20:34.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:68:0)
[17:20:34.531] Timer tick, asking Buildbucket for the build status
[17:20:34.640] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:34.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:69:0) after 1m0s
[17:21:34.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:69:0)
[17:21:34.734] Timer tick, asking Buildbucket for the build status
[17:21:34.826] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:34.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:70:0) after 1m0s
[17:22:35.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:70:0)
[17:22:35.053] Timer tick, asking Buildbucket for the build status
[17:22:35.138] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:35.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:71:0) after 1m0s
[17:23:35.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:71:0)
[17:23:35.279] Timer tick, asking Buildbucket for the build status
[17:23:35.448] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:35.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:72:0) after 1m0s
[17:24:35.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:72:0)
[17:24:35.595] Timer tick, asking Buildbucket for the build status
[17:24:35.731] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:35.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:73:0) after 1m0s
[17:25:35.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:73:0)
[17:25:35.928] Timer tick, asking Buildbucket for the build status
[17:25:36.257] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:36.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:74:0) after 1m0s
[17:26:36.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:74:0)
[17:26:36.382] Timer tick, asking Buildbucket for the build status
[17:26:36.468] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:36.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:75:0) after 1m0s
[17:27:36.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:75:0)
[17:27:36.611] Timer tick, asking Buildbucket for the build status
[17:27:36.679] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:36.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:76:0) after 1m0s
[17:28:36.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:76:0)
[17:28:36.788] Timer tick, asking Buildbucket for the build status
[17:28:36.866] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:36.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:77:0) after 1m0s
[17:29:36.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:77:0)
[17:29:36.983] Timer tick, asking Buildbucket for the build status
[17:29:37.382] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:37.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:78:0) after 1m0s
[17:30:37.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:78:0)
[17:30:37.427] Timer tick, asking Buildbucket for the build status
[17:30:37.783] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:37.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:79:0) after 1m0s
[17:31:37.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:79:0)
[17:31:37.891] Timer tick, asking Buildbucket for the build status
[17:31:38.332] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:38.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:80:0) after 1m0s
[17:32:38.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:80:0)
[17:32:38.331] Timer tick, asking Buildbucket for the build status
[17:32:38.415] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:38.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:81:0) after 1m0s
[17:33:38.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:81:0)
[17:33:38.524] Timer tick, asking Buildbucket for the build status
[17:33:38.601] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:38.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:82:0) after 1m0s
[17:34:38.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:82:0)
[17:34:38.689] Timer tick, asking Buildbucket for the build status
[17:34:38.820] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:38.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:83:0) after 1m0s
[17:35:38.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:83:0)
[17:35:38.913] Timer tick, asking Buildbucket for the build status
[17:35:40.049] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:40.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:84:0) after 1m0s
[17:36:40.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:84:0)
[17:36:40.398] Timer tick, asking Buildbucket for the build status
[17:36:40.542] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:40.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:85:0) after 1m0s
[17:37:40.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:85:0)
[17:37:40.667] Timer tick, asking Buildbucket for the build status
[17:37:40.749] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:40.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:86:0) after 1m0s
[17:38:40.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:86:0)
[17:38:40.870] Timer tick, asking Buildbucket for the build status
[17:38:40.961] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:40.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:87:0) after 1m0s
[17:39:41.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:87:0)
[17:39:41.034] Timer tick, asking Buildbucket for the build status
[17:39:41.160] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:41.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:88:0) after 1m0s
[17:40:41.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:88:0)
[17:40:41.304] Timer tick, asking Buildbucket for the build status
[17:40:41.383] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:41.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:89:0) after 1m0s
[17:41:41.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:89:0)
[17:41:41.489] Timer tick, asking Buildbucket for the build status
[17:41:41.893] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:41.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:90:0) after 1m0s
[17:42:42.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:90:0)
[17:42:42.052] Timer tick, asking Buildbucket for the build status
[17:42:42.121] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:42.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:91:0) after 1m0s
[17:43:42.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:91:0)
[17:43:42.159] Timer tick, asking Buildbucket for the build status
[17:43:42.301] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:42.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:92:0) after 1m0s
[17:44:42.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:92:0)
[17:44:42.354] Timer tick, asking Buildbucket for the build status
[17:44:42.595] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:42.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:93:0) after 1m0s
[17:45:42.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:93:0)
[17:45:42.661] Timer tick, asking Buildbucket for the build status
[17:45:42.734] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:42.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:94:0) after 1m0s
[17:46:42.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:94:0)
[17:46:42.803] Timer tick, asking Buildbucket for the build status
[17:46:42.896] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:42.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:95:0) after 1m0s
[17:47:42.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:95:0)
[17:47:42.942] Timer tick, asking Buildbucket for the build status
[17:47:43.043] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:43.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:96:0) after 1m0s
[17:48:43.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:96:0)
[17:48:43.122] Timer tick, asking Buildbucket for the build status
[17:48:43.199] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:43.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:97:0) after 1m0s
[17:49:43.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:97:0)
[17:49:43.257] Timer tick, asking Buildbucket for the build status
[17:49:43.416] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:43.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:98:0) after 1m0s
[17:50:43.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:98:0)
[17:50:43.576] Timer tick, asking Buildbucket for the build status
[17:50:44.104] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:44.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:99:0) after 1m0s
[17:51:44.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:99:0)
[17:51:44.185] Timer tick, asking Buildbucket for the build status
[17:51:44.671] Build 8864456159516534304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:44.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029886221479296480:100:0) after 1m0s
[17:52:16.429] Received PubSub notification, asking Buildbucket for the build status
[17:52:16.510] Build 8864456159516534304: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[17:52:16.510] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604598735062262",
"created_by": "project:chromium",
"created_ts": "1604592853967598",
"failure_reason": "BUILD_FAILURE",
"id": "8864456159516534304",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"70f2d45c60d2038f8f59fd4d78949de1376c8d4e\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- SSLUITest.SHA1IsDefaultDisabled\\n\\n- SessionRestoreTest.StartupPagesWithOnlyNtp\\n\\n- CryptohomeKeyDelegateServiceProviderTest.SignatureErrorKeyRemoved\\n\\n- TelemetryExtensionUIWithAdapterPropertyChangedEventBrowserTest.UntrustedBluetoothAdapterPropertyChangedEventListener\\n\\n- ...552 more failure(s) (556 total)...\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"70f2d45c60d2038f8f59fd4d78949de1376c8d4e\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-203-bxm2\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21161, \"got_angle_revision\": \"3942e801a65b780296f526f10704c9668d499942\", \"got_dawn_revision\": \"e87a8c466fb1652aedc2bfea464ae0b99782a357\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"70f2d45c60d2038f8f59fd4d78949de1376c8d4e\", \"got_revision_cp\": \"refs/heads/master@{#824432}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"ad54c71632cc0f18584a7009f1e6fc44f5453bc7\", \"got_v8_revision\": \"937e42d5f246b3d04092869127d2888668de7acd\", \"got_v8_revision_cp\": \"refs/heads/8.8.239@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"70f2d45c60d2038f8f59fd4d78949de1376c8d4e\", \"swarm_hashes_refs/heads/master(at){#824432}_without_patch\": {\"absl_hardening_tests\": \"78f41bdae7f309936fe307a19909fb66056069b9\", \"accessibility_unittests\": \"db8e7946bfaea199ab6677eb2dcc8c448103bd37\", \"angle_unittests\": \"5aebfd94ded7dfc27267b8f3769c429c69a44ea0\", \"app_list_unittests\": \"236ed02fe139e67ae0f99c827f8e21a2c528ddfc\", \"app_shell_unittests\": \"7d46106a6eaab317f0a559601fe64689d0469119\", \"ash_unittests\": \"bb84e47217a1d0f63f7bb61fb00fda05742c2173\", \"aura_unittests\": \"abde263112793dd2d46a6d8ffc2a40db60fba331\", \"base_unittests\": \"dedc050a708cc356f9c17bf782e568a8a6e5fa4f\", \"base_util_unittests\": \"6dfa6a800751570d64ec66fde18c17733b751524\", \"blink_common_unittests\": \"094cdba02d8fe91646a20f52c1f8fc92d82177fa\", \"blink_fuzzer_unittests\": \"2abef63ca655a97e9b65ccda431856de2e98bf91\", \"blink_heap_unittests\": \"97aeb41a2b41c14d1f90e8ea7e62d451da211463\", \"blink_platform_unittests\": \"47faffa1b2642c4eb38cfcd41870f0d0f69b2dc4\", \"blink_unittests\": \"72964a1fd8d5cfa4e50e661be1417abd42bec95d\", \"boringssl_crypto_tests\": \"95ff6886f05217cce00376a667092179116495c9\", \"boringssl_ssl_tests\": \"49bf6a75e6baf1f485c20c6d0cc915890997a506\", \"browser_tests\": \"b1671f21138565290cf8827f3626bd2c52552b96\", \"capture_unittests\": \"efa9b4c1d6f317bc20d9c2ac22e87cda8d5fd82d\", \"cast_unittests\": \"60fa80bf24a5eed4146cb643b69070acf8163d00\", \"cc_unittests\": \"37b8aa76c78a7b3391172b2ec24c48b27ce6a43f\", \"chrome_app_unittests\": \"afa3cc01a82061b455724f9ac0ae7d1ad3da7039\", \"chromedriver_unittests\": \"7d689fbd4921a8cae4a0ac69b81e6671efbfacd4\", \"chromeos_components_unittests\": \"a180a7a640a1ac877890a420cf6416a64622f6c2\", \"chromeos_unittests\": \"28a60527ea6a8eef85d5600a941954bf4ded1eb8\", \"components_browsertests\": \"62a861d8cd28d0d08f20c63b6044463454602ba6\", \"components_unittests\": \"5b4a971666e320810ba388ff70090486cfd7958f\", \"compositor_unittests\": \"c90f846071e8a0824b4c0c44c8ccf35a34fb453a\", \"content_browsertests\": \"2e55a41ebca4a6df2c8455bbb65419b391da5dba\", \"content_unittests\": \"621860f42589f87ca5b5cf998b4aca5bd34c17f5\", \"crypto_unittests\": \"aa673bb2981288582cbd755b5c120c0e06b10723\", \"dbus_unittests\": \"48a44e77ee2e9fdaa63635e9dfa0c08862b28ad3\", \"device_unittests\": \"234b9bffd78c5f261ae989347784c9ac6be17a46\", \"display_unittests\": \"30f05923537b8a7a038ab9ef0e5640c875d7b7e9\", \"events_unittests\": \"7a2b7ffcc3ebb561401c578a74cd1a12fe47c87b\", \"exo_unittests\": \"e35d7cb49e37fdc09901b08cfa6bb3c6fb216c91\", \"extensions_browsertests\": \"74459c773e02fe7c1514cc7633393636b31e476a\", \"extensions_unittests\": \"5b6fec39cd8b09ad5bf5967e5ace4450d92c0851\", \"filesystem_service_unittests\": \"36c260f365049c33158008456b13fc6dedf8f97f\", \"gcm_unit_tests\": \"29b5b1d1c3d11148195d98f24a2cbfb0a7532e05\", \"gfx_unittests\": \"946c7832f1ebe799e986761af4fc63f32b009fba\", \"gin_unittests\": \"f0904f4c3e68981cb99bda2b943c61a0a68ef202\", \"gl_unittests_ozone\": \"e19541b56a8056db216b047f289de86db8e444b7\", \"google_apis_unittests\": \"067e3215e2533c23fa87af595def2627441763de\", \"gpu_unittests\": \"5b0e37aebad65324f32f067b4ef716ae8d305cf0\", \"gwp_asan_unittests\": \"f037a8992a58826b61ae71cfded7fb84946146f7\", \"interactive_ui_tests\": \"909ae1bf47d087802797f9fd7e83f6a5f3d62a28\", \"ipc_tests\": \"40110c2f45f31b42160b3e616b9fcc1dae30474c\", \"jingle_unittests\": \"8ce2c9cb70d4ed922a48ff38c663cebf77fbd175\", \"keyboard_unittests\": \"f2031c1e7419f9e462fb30f6ce57e5bf5719b71b\", \"latency_unittests\": \"c06847e6a3007c61f2c2578ca80a50c108e54e63\", \"libjingle_xmpp_unittests\": \"0cc29ea3b937628415a511a0a146be3deab613e0\", \"liburlpattern_unittests\": \"eacb5efb45520b7d69f9e6c5fdcabb28576d70a8\", \"media_blink_unittests\": \"075b427e785886a8ebe30c00b4b870c7341ecc7c\", \"media_unittests\": \"e23ea19d27c88b58f707b2eb48df6d863b06c542\", \"message_center_unittests\": \"afd25060bb6aab8c1e1520890b206de374f24a49\", \"midi_unittests\": \"b674fe4a8e9fc783cb995a80b4ace767a2303e4e\", \"mojo_core_unittests\": \"dbf2e57c3e2dcb327f442c9f4f5f6ac2e2631035\", \"mojo_unittests\": \"2ba96b2d9f1634aad452e877604fbcce93a44850\", \"nacl_helper_nonsfi_unittests\": \"2aa144f1bb46a104bb82b6613e40d6a8de873beb\", \"nacl_loader_unittests\": \"5a76a0ae454af4b23e41759534077632dd2d9f78\", \"native_theme_unittests\": \"44f92415ab98f9548969c7898353f351b05bff72\", \"net_unittests\": \"b11fa509239d6c7372bc4366ec33cabb30b1c2dc\", \"ozone_gl_unittests\": \"dcecd6e1e77137b0d28bce9b2ad19b8be5518cfe\", \"ozone_unittests\": \"3d998fcda9ca8fc15531300121ae379d65bec207\", \"ozone_x11_unittests\": \"e5c0b086c40210e7a977997d0275984c917c313f\", \"pdf_unittests\": \"e35cfb4f3e45b030c4d7d09124f73f19ad5cd572\", \"perfetto_unittests\": \"09e1793bd69d200fd21121a0f87973483292234b\", \"ppapi_unittests\": \"e1abd4c59844bd34c8d4e0da347e8c3c29bfef5e\", \"printing_unittests\": \"2c1103c874aecd2d14eb64664da3d665ae829d1f\", \"remoting_unittests\": \"3e11dd1708ffaea6281e9c043b642821a80ed163\", \"sandbox_linux_unittests\": \"5d959077bf3e649c19d2000aaf01e4ed2ace25fd\", \"service_manager_unittests\": \"3547cfe30d95e0401e1552e802b6e707221ba04c\", \"services_unittests\": \"c29ad15d36d43f3b9c4cd4cfa17a2c9a717ebd39\", \"shell_dialogs_unittests\": \"6c9ddf9439381b4e142c2aa392cd5817b0fcd117\", \"skia_unittests\": \"1c69e14bbec4e2c174dfa64cabc1308957a5317d\", \"snapshot_unittests\": \"290180c0b93cc78598000f5fd7a94b4e66aa2a37\", \"sql_unittests\": \"c7eff5b4a547b25b5d31e5cfd2021c0c6c7227bb\", \"storage_unittests\": \"9c658745fb85403b9736ce9ee8ce12255a32d13c\", \"sync_integration_tests\": \"a209d5e8ecbfde0c69ddd9de87bf6f1baa9e24cd\", \"traffic_annotation_auditor_unittests\": \"d803707bee9856ae540162d50ee88fd985a32fe8\", \"ui_base_unittests\": \"c69e4a8f9c8f924091585abbe1cd751aee918986\", \"ui_chromeos_unittests\": \"132a6d627105a4d3e87ae7d01860cf6975b0db0e\", \"ui_touch_selection_unittests\": \"32519759a318cb0db7bcdcde5d137d0b44f1dadb\", \"unit_tests\": \"3b8ea4c4eb1b8fd1757b9e508f77e4a74f94a79f\", \"url_unittests\": \"56b2c1908c3d760e8589ccfd800b43f8e11acdcd\", \"usage_time_limit_unittests\": \"b766c2a76c2a727a373649eb5ddc434e64c07562\", \"views_unittests\": \"f87631412437222c7408883da8e9ea256e45f52f\", \"viz_unittests\": \"a57c6a3fbc0e0b0ebbc84716b3e6105499a1a552\", \"wm_unittests\": \"b28db9ccb63609a4f7bce95ed571390f29ccc58e\", \"wtf_unittests\": \"e210ef496971acee9596d29f7226fab76727e671\", \"zlib_unittests\": \"3f39f86255fd9136489e280228edc2956bc67186\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_4f0964162888fb5bae249a111360c6881d9714a6e065febf968887beea0fb93f_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_84395cd86c4615c28c38755187d54d1bbe2dcea268d302d74191d04ce3a055d0_v2\", \"builder_8bff6729eb7a20b41fa723231755491227dfae6025a6d103df6a00cfb6cc22b8_v2\", \"builder_ebb06fb409ef3255b3561ad6bc0df7706a15849e85ba50b708bdfb917530d411_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-203-bxm2\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- SSLUITest.SHA1IsDefaultDisabled\\n\\n- SessionRestoreTest.StartupPagesWithOnlyNtp\\n\\n- CryptohomeKeyDelegateServiceProviderTest.SignatureErrorKeyRemoved\\n\\n- TelemetryExtensionUIWithAdapterPropertyChangedEventBrowserTest.UntrustedBluetoothAdapterPropertyChangedEventListener\\n\\n- ...552 more failure(s) (556 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604592857480852",
"status": "COMPLETED",
"status_changed_ts": "1604592858056010",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21161",
"builder:linux-chromeos-dbg",
"buildset:commit/git/70f2d45c60d2038f8f59fd4d78949de1376c8d4e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/70f2d45c60d2038f8f59fd4d78949de1376c8d4e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029886221479296480",
"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/8864456159516534304/+/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:4fb201707a2fe210",
"user_agent:luci-scheduler"
],
"updated_ts": "1604598736125905",
"url": "https://ci.chromium.org/b/8864456159516534304",
"utcnow_ts": "1604598736499111"
}
}
[17:52:16.510] Invocation finished in 1h38m3.79871806s with status FAILED