[16:06:18.285] New invocation is queued and will start shortly
[16:06:19.362] Starting the invocation (attempt 1)
[16:06:19.404] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:06:19.404] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:06:19.404] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9034507164261506352",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7f6955321792ce372e935f49cd4420b5b6ecb15f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9034507164261506352",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/7f6955321792ce372e935f49cd4420b5b6ecb15f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f6955321792ce372e935f49cd4420b5b6ecb15f",
"gitiles_ref:refs/heads/master"
]
}
[16:06:20.327] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1600185979495553",
"id": "8869077102323552592",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f6955321792ce372e935f49cd4420b5b6ecb15f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1600185980077856",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/23906",
"builder:Linux Viz",
"buildset:commit/git/7f6955321792ce372e935f49cd4420b5b6ecb15f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f6955321792ce372e935f49cd4420b5b6ecb15f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034507164261506352",
"scheduler_job_id:chromium/Linux Viz",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8869077102323552592/+/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": "1600185980077995",
"url": "https://ci.chromium.org/b/8869077102323552592",
"utcnow_ts": "1600185980298976"
}
}
[16:06:20.327] Task URL: https://ci.chromium.org/b/8869077102323552592
[16:06:20.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:2:0) after 1m0s
[16:06:25.733] Received PubSub notification, asking Buildbucket for the build status
[16:06:25.934] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:20.466] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:2:0)
[16:07:20.466] Timer tick, asking Buildbucket for the build status
[16:07:20.767] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:20.767] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:4:0) after 1m0s
[16:08:20.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:4:0)
[16:08:20.863] Timer tick, asking Buildbucket for the build status
[16:08:21.094] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:21.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:5:0) after 1m0s
[16:09:21.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:5:0)
[16:09:21.177] Timer tick, asking Buildbucket for the build status
[16:09:21.317] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:21.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:6:0) after 1m0s
[16:10:21.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:6:0)
[16:10:21.353] Timer tick, asking Buildbucket for the build status
[16:10:21.684] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:21.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:7:0) after 1m0s
[16:11:21.736] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:7:0)
[16:11:21.736] Timer tick, asking Buildbucket for the build status
[16:11:21.903] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:21.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:8:0) after 1m0s
[16:12:22.007] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:8:0)
[16:12:22.007] Timer tick, asking Buildbucket for the build status
[16:12:22.143] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:22.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:9:0) after 1m0s
[16:13:22.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:9:0)
[16:13:22.226] Timer tick, asking Buildbucket for the build status
[16:13:22.742] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:22.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:10:0) after 1m0s
[16:14:22.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:10:0)
[16:14:22.797] Timer tick, asking Buildbucket for the build status
[16:14:23.264] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:23.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:11:0) after 1m0s
[16:15:23.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:11:0)
[16:15:23.298] Timer tick, asking Buildbucket for the build status
[16:15:23.394] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:23.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:12:0) after 1m0s
[16:16:23.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:12:0)
[16:16:23.463] Timer tick, asking Buildbucket for the build status
[16:16:23.606] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:23.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:13:0) after 1m0s
[16:17:23.646] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:13:0)
[16:17:23.646] Timer tick, asking Buildbucket for the build status
[16:17:23.886] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:23.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:14:0) after 1m0s
[16:18:23.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:14:0)
[16:18:23.929] Timer tick, asking Buildbucket for the build status
[16:18:24.005] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:24.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:15:0) after 1m0s
[16:19:24.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:15:0)
[16:19:24.066] Timer tick, asking Buildbucket for the build status
[16:19:24.699] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:24.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:16:0) after 1m0s
[16:20:24.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:16:0)
[16:20:24.801] Timer tick, asking Buildbucket for the build status
[16:20:24.862] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:24.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:17:0) after 1m0s
[16:21:24.907] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:17:0)
[16:21:24.907] Timer tick, asking Buildbucket for the build status
[16:21:25.086] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:25.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:18:0) after 1m0s
[16:22:25.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:18:0)
[16:22:25.115] Timer tick, asking Buildbucket for the build status
[16:22:25.274] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:25.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:19:0) after 1m0s
[16:23:25.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:19:0)
[16:23:25.535] Timer tick, asking Buildbucket for the build status
[16:23:25.619] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:25.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:20:0) after 1m0s
[16:24:25.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:20:0)
[16:24:25.649] Timer tick, asking Buildbucket for the build status
[16:24:25.904] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:25.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:21:0) after 1m0s
[16:25:25.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:21:0)
[16:25:25.959] Timer tick, asking Buildbucket for the build status
[16:25:26.136] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:26.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:22:0) after 1m0s
[16:26:26.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:22:0)
[16:26:26.127] Timer tick, asking Buildbucket for the build status
[16:26:26.297] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:26.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:23:0) after 1m0s
[16:27:26.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:23:0)
[16:27:26.402] Timer tick, asking Buildbucket for the build status
[16:27:27.009] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:27.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:24:0) after 1m0s
[16:28:27.119] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:24:0)
[16:28:27.119] Timer tick, asking Buildbucket for the build status
[16:28:27.185] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:27.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:25:0) after 1m0s
[16:29:27.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:25:0)
[16:29:27.407] Timer tick, asking Buildbucket for the build status
[16:29:27.522] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:27.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:26:0) after 1m0s
[16:30:27.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:26:0)
[16:30:27.705] Timer tick, asking Buildbucket for the build status
[16:30:27.801] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:27.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:27:0) after 1m0s
[16:31:27.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:27:0)
[16:31:27.870] Timer tick, asking Buildbucket for the build status
[16:31:28.119] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:28.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:28:0) after 1m0s
[16:32:28.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:28:0)
[16:32:28.278] Timer tick, asking Buildbucket for the build status
[16:32:28.367] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:28.368] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:29:0) after 1m0s
[16:33:28.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:29:0)
[16:33:28.524] Timer tick, asking Buildbucket for the build status
[16:33:28.753] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:28.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:30:0) after 1m0s
[16:34:28.840] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:30:0)
[16:34:28.840] Timer tick, asking Buildbucket for the build status
[16:34:29.003] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:29.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:31:0) after 1m0s
[16:35:29.030] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:31:0)
[16:35:29.030] Timer tick, asking Buildbucket for the build status
[16:35:29.109] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:29.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:32:0) after 1m0s
[16:36:29.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:32:0)
[16:36:29.187] Timer tick, asking Buildbucket for the build status
[16:36:29.337] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:29.337] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:33:0) after 1m0s
[16:37:29.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:33:0)
[16:37:29.383] Timer tick, asking Buildbucket for the build status
[16:37:29.707] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:29.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:34:0) after 1m0s
[16:38:29.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:34:0)
[16:38:29.784] Timer tick, asking Buildbucket for the build status
[16:38:29.873] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:29.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:35:0) after 1m0s
[16:39:29.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:35:0)
[16:39:29.895] Timer tick, asking Buildbucket for the build status
[16:39:29.988] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:29.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:36:0) after 1m0s
[16:40:30.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:36:0)
[16:40:30.048] Timer tick, asking Buildbucket for the build status
[16:40:30.120] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:30.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:37:0) after 1m0s
[16:41:30.349] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:37:0)
[16:41:30.349] Timer tick, asking Buildbucket for the build status
[16:41:33.222] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:33.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:38:0) after 1m0s
[16:42:33.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:38:0)
[16:42:33.281] Timer tick, asking Buildbucket for the build status
[16:42:34.372] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:34.373] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:39:0) after 1m0s
[16:43:34.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:39:0)
[16:43:34.418] Timer tick, asking Buildbucket for the build status
[16:43:34.498] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:34.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:40:0) after 1m0s
[16:44:34.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:40:0)
[16:44:34.558] Timer tick, asking Buildbucket for the build status
[16:44:34.618] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:34.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:41:0) after 1m0s
[16:45:34.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:41:0)
[16:45:34.683] Timer tick, asking Buildbucket for the build status
[16:45:34.858] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:34.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:42:0) after 1m0s
[16:46:34.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:42:0)
[16:46:34.990] Timer tick, asking Buildbucket for the build status
[16:46:35.165] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:35.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:43:0) after 1m0s
[16:47:35.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:43:0)
[16:47:35.187] Timer tick, asking Buildbucket for the build status
[16:47:35.254] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:35.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:44:0) after 1m0s
[16:48:35.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:44:0)
[16:48:35.302] Timer tick, asking Buildbucket for the build status
[16:48:35.383] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:35.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:45:0) after 1m0s
[16:49:35.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:45:0)
[16:49:35.558] Timer tick, asking Buildbucket for the build status
[16:49:35.641] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:35.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:46:0) after 1m0s
[16:50:35.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:46:0)
[16:50:35.697] Timer tick, asking Buildbucket for the build status
[16:50:35.780] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:35.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:47:0) after 1m0s
[16:51:35.858] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:47:0)
[16:51:35.858] Timer tick, asking Buildbucket for the build status
[16:51:36.036] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:36.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:48:0) after 1m0s
[16:52:36.080] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:48:0)
[16:52:36.080] Timer tick, asking Buildbucket for the build status
[16:52:36.205] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:36.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:49:0) after 1m0s
[16:53:36.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:49:0)
[16:53:36.333] Timer tick, asking Buildbucket for the build status
[16:53:36.416] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:36.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:50:0) after 1m0s
[16:54:36.540] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:50:0)
[16:54:36.540] Timer tick, asking Buildbucket for the build status
[16:54:36.602] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:36.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:51:0) after 1m0s
[16:55:36.665] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:51:0)
[16:55:36.665] Timer tick, asking Buildbucket for the build status
[16:55:36.729] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:36.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:52:0) after 1m0s
[16:56:36.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:52:0)
[16:56:36.958] Timer tick, asking Buildbucket for the build status
[16:56:37.223] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:37.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:53:0) after 1m0s
[16:57:37.306] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:53:0)
[16:57:37.306] Timer tick, asking Buildbucket for the build status
[16:57:37.412] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:37.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:54:0) after 1m0s
[16:58:37.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:54:0)
[16:58:37.480] Timer tick, asking Buildbucket for the build status
[16:58:37.565] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:37.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:55:0) after 1m0s
[16:59:37.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:55:0)
[16:59:37.627] Timer tick, asking Buildbucket for the build status
[16:59:37.699] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:37.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:56:0) after 1m0s
[17:00:37.841] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:56:0)
[17:00:37.841] Timer tick, asking Buildbucket for the build status
[17:00:38.211] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:38.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:57:0) after 1m0s
[17:01:38.240] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:57:0)
[17:01:38.240] Timer tick, asking Buildbucket for the build status
[17:01:38.398] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:38.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:58:0) after 1m0s
[17:02:38.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:58:0)
[17:02:38.426] Timer tick, asking Buildbucket for the build status
[17:02:38.628] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:38.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:59:0) after 1m0s
[17:03:38.741] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:59:0)
[17:03:38.741] Timer tick, asking Buildbucket for the build status
[17:03:38.825] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:38.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:60:0) after 1m0s
[17:04:38.892] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:60:0)
[17:04:38.892] Timer tick, asking Buildbucket for the build status
[17:04:39.032] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:39.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:61:0) after 1m0s
[17:05:39.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:61:0)
[17:05:39.113] Timer tick, asking Buildbucket for the build status
[17:05:39.575] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:39.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:62:0) after 1m0s
[17:06:39.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:62:0)
[17:06:39.622] Timer tick, asking Buildbucket for the build status
[17:06:39.899] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:39.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:63:0) after 1m0s
[17:07:40.019] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:63:0)
[17:07:40.019] Timer tick, asking Buildbucket for the build status
[17:07:40.102] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:40.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:64:0) after 1m0s
[17:08:40.148] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:64:0)
[17:08:40.148] Timer tick, asking Buildbucket for the build status
[17:08:40.219] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:40.219] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:65:0) after 1m0s
[17:09:40.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:65:0)
[17:09:40.361] Timer tick, asking Buildbucket for the build status
[17:09:40.429] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:40.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:66:0) after 1m0s
[17:10:40.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:66:0)
[17:10:40.403] Timer tick, asking Buildbucket for the build status
[17:10:40.791] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:40.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:67:0) after 1m0s
[17:11:40.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:67:0)
[17:11:40.809] Timer tick, asking Buildbucket for the build status
[17:11:41.221] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:41.221] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:68:0) after 1m0s
[17:12:41.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:68:0)
[17:12:41.262] Timer tick, asking Buildbucket for the build status
[17:12:41.328] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:41.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:69:0) after 1m0s
[17:13:41.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:69:0)
[17:13:41.344] Timer tick, asking Buildbucket for the build status
[17:13:41.589] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:41.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:70:0) after 1m0s
[17:14:41.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:70:0)
[17:14:41.666] Timer tick, asking Buildbucket for the build status
[17:14:41.785] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:41.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:71:0) after 1m0s
[17:15:41.902] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:71:0)
[17:15:41.902] Timer tick, asking Buildbucket for the build status
[17:15:42.086] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:42.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:72:0) after 1m0s
[17:16:42.146] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:72:0)
[17:16:42.146] Timer tick, asking Buildbucket for the build status
[17:16:42.521] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:42.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:73:0) after 1m0s
[17:17:42.540] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:73:0)
[17:17:42.540] Timer tick, asking Buildbucket for the build status
[17:17:42.626] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:42.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:74:0) after 1m0s
[17:18:42.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:74:0)
[17:18:42.650] Timer tick, asking Buildbucket for the build status
[17:18:42.719] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:42.719] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:75:0) after 1m0s
[17:19:42.840] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:75:0)
[17:19:42.840] Timer tick, asking Buildbucket for the build status
[17:19:43.032] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:43.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:76:0) after 1m0s
[17:20:44.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:76:0)
[17:20:44.578] Timer tick, asking Buildbucket for the build status
[17:20:44.714] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:44.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:77:0) after 1m0s
[17:21:44.993] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:77:0)
[17:21:44.993] Timer tick, asking Buildbucket for the build status
[17:21:45.205] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:45.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:78:0) after 1m0s
[17:22:45.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:78:0)
[17:22:45.558] Timer tick, asking Buildbucket for the build status
[17:22:45.967] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:45.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:79:0) after 1m0s
[17:23:46.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:79:0)
[17:23:46.099] Timer tick, asking Buildbucket for the build status
[17:23:46.311] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:46.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:80:0) after 1m0s
[17:24:46.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:80:0)
[17:24:46.346] Timer tick, asking Buildbucket for the build status
[17:24:46.456] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:46.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:81:0) after 1m0s
[17:25:46.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:81:0)
[17:25:46.487] Timer tick, asking Buildbucket for the build status
[17:25:47.202] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:47.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:82:0) after 1m0s
[17:26:47.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:82:0)
[17:26:47.213] Timer tick, asking Buildbucket for the build status
[17:26:47.314] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:47.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:83:0) after 1m0s
[17:27:47.340] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:83:0)
[17:27:47.340] Timer tick, asking Buildbucket for the build status
[17:27:47.434] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:47.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:84:0) after 1m0s
[17:28:47.466] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:84:0)
[17:28:47.466] Timer tick, asking Buildbucket for the build status
[17:28:47.713] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:47.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:85:0) after 1m0s
[17:29:47.761] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:85:0)
[17:29:47.761] Timer tick, asking Buildbucket for the build status
[17:29:47.879] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:47.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:86:0) after 1m0s
[17:30:47.914] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:86:0)
[17:30:47.914] Timer tick, asking Buildbucket for the build status
[17:30:47.973] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:47.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:87:0) after 1m0s
[17:31:48.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:87:0)
[17:31:48.052] Timer tick, asking Buildbucket for the build status
[17:31:48.292] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:48.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:88:0) after 1m0s
[17:32:48.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:88:0)
[17:32:48.339] Timer tick, asking Buildbucket for the build status
[17:32:48.403] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:48.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:89:0) after 1m0s
[17:33:48.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:89:0)
[17:33:48.455] Timer tick, asking Buildbucket for the build status
[17:33:48.811] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:48.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:90:0) after 1m0s
[17:34:48.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:90:0)
[17:34:48.839] Timer tick, asking Buildbucket for the build status
[17:34:49.024] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:49.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:91:0) after 1m0s
[17:35:49.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:91:0)
[17:35:49.056] Timer tick, asking Buildbucket for the build status
[17:35:49.743] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:49.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:92:0) after 1m0s
[17:36:49.736] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:92:0)
[17:36:49.736] Timer tick, asking Buildbucket for the build status
[17:36:49.913] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:49.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:93:0) after 1m0s
[17:37:49.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:93:0)
[17:37:49.913] Timer tick, asking Buildbucket for the build status
[17:37:50.000] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:50.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:94:0) after 1m0s
[17:38:50.057] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:94:0)
[17:38:50.057] Timer tick, asking Buildbucket for the build status
[17:38:50.188] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:50.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:95:0) after 1m0s
[17:39:50.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:95:0)
[17:39:50.237] Timer tick, asking Buildbucket for the build status
[17:39:50.433] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:50.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:96:0) after 1m0s
[17:40:50.419] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:96:0)
[17:40:50.419] Timer tick, asking Buildbucket for the build status
[17:40:50.481] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:50.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:97:0) after 1m0s
[17:41:50.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:97:0)
[17:41:50.553] Timer tick, asking Buildbucket for the build status
[17:41:50.725] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:50.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:98:0) after 1m0s
[17:42:50.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:98:0)
[17:42:50.750] Timer tick, asking Buildbucket for the build status
[17:42:50.830] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:50.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:99:0) after 1m0s
[17:43:50.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:99:0)
[17:43:50.903] Timer tick, asking Buildbucket for the build status
[17:43:51.099] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:51.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:100:0) after 1m0s
[17:44:51.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:100:0)
[17:44:51.155] Timer tick, asking Buildbucket for the build status
[17:44:51.527] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:51.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:101:0) after 1m0s
[17:45:51.556] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:101:0)
[17:45:51.556] Timer tick, asking Buildbucket for the build status
[17:45:51.643] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:51.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:102:0) after 1m0s
[17:46:51.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:102:0)
[17:46:51.666] Timer tick, asking Buildbucket for the build status
[17:46:51.877] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:51.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:103:0) after 1m0s
[17:47:51.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:103:0)
[17:47:51.945] Timer tick, asking Buildbucket for the build status
[17:47:52.129] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:52.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:104:0) after 1m0s
[17:48:52.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:104:0)
[17:48:52.154] Timer tick, asking Buildbucket for the build status
[17:48:52.697] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:52.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:105:0) after 1m0s
[17:49:52.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:105:0)
[17:49:52.723] Timer tick, asking Buildbucket for the build status
[17:49:53.558] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:53.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:106:0) after 1m0s
[17:50:53.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:106:0)
[17:50:53.541] Timer tick, asking Buildbucket for the build status
[17:50:53.637] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:53.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:107:0) after 1m0s
[17:51:53.653] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:107:0)
[17:51:53.653] Timer tick, asking Buildbucket for the build status
[17:51:53.810] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:53.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:108:0) after 1m0s
[17:52:53.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:108:0)
[17:52:53.869] Timer tick, asking Buildbucket for the build status
[17:52:53.955] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:53.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:109:0) after 1m0s
[17:53:54.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:109:0)
[17:53:54.023] Timer tick, asking Buildbucket for the build status
[17:53:55.336] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:55.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:110:0) after 1m0s
[17:54:55.370] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:110:0)
[17:54:55.370] Timer tick, asking Buildbucket for the build status
[17:54:55.488] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:55.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:111:0) after 1m0s
[17:55:55.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:111:0)
[17:55:55.472] Timer tick, asking Buildbucket for the build status
[17:55:55.563] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:55.563] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:112:0) after 1m0s
[17:56:55.661] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:112:0)
[17:56:55.661] Timer tick, asking Buildbucket for the build status
[17:56:55.786] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:55.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:113:0) after 1m0s
[17:57:55.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:113:0)
[17:57:55.826] Timer tick, asking Buildbucket for the build status
[17:57:55.904] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:55.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:114:0) after 1m0s
[17:58:55.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:114:0)
[17:58:55.944] Timer tick, asking Buildbucket for the build status
[17:58:56.014] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:56.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:115:0) after 1m0s
[17:59:56.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:115:0)
[17:59:56.061] Timer tick, asking Buildbucket for the build status
[17:59:56.169] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:56.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:116:0) after 1m0s
[18:00:56.236] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:116:0)
[18:00:56.236] Timer tick, asking Buildbucket for the build status
[18:00:56.385] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:56.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:117:0) after 1m0s
[18:01:56.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:117:0)
[18:01:56.415] Timer tick, asking Buildbucket for the build status
[18:01:56.649] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:56.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:118:0) after 1m0s
[18:02:56.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:118:0)
[18:02:56.683] Timer tick, asking Buildbucket for the build status
[18:02:57.290] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:57.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:119:0) after 1m0s
[18:03:57.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:119:0)
[18:03:57.316] Timer tick, asking Buildbucket for the build status
[18:03:57.385] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:57.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:120:0) after 1m0s
[18:04:57.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:120:0)
[18:04:57.401] Timer tick, asking Buildbucket for the build status
[18:04:57.477] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:57.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:121:0) after 1m0s
[18:05:57.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:121:0)
[18:05:57.534] Timer tick, asking Buildbucket for the build status
[18:05:57.653] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:57.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:122:0) after 1m0s
[18:06:57.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:122:0)
[18:06:57.677] Timer tick, asking Buildbucket for the build status
[18:06:57.851] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:57.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:123:0) after 1m0s
[18:07:57.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:123:0)
[18:07:57.876] Timer tick, asking Buildbucket for the build status
[18:07:58.270] Build 8869077102323552592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:58.270] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034507164261506352:124:0) after 1m0s
[18:08:33.423] Received PubSub notification, asking Buildbucket for the build status
[18:08:33.499] Build 8869077102323552592: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[18:08:33.499] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1600193312769793",
"created_by": "project:chromium",
"created_ts": "1600185979495553",
"failure_reason": "BUILD_FAILURE",
"id": "8869077102323552592",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f6955321792ce372e935f49cd4420b5b6ecb15f\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"5 Test Suite(s) failed.\\n\\n**non_skia_renderer_swiftshader_blink_web_tests** failed.\\n\\n**non_skia_renderer_browser_tests** failed.\\n\\n**vulkan_swiftshader_blink_web_tests** failed.\\n\\n**vulkan_swiftshader_content_browsertests** failed.\\n\\n**skia_renderer_content_browsertests** failed.\"}, \"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\": \"7f6955321792ce372e935f49cd4420b5b6ecb15f\", \"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-east1-d-8-116-gb76\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Linux Viz\", \"buildnumber\": 23906, \"got_angle_revision\": \"06b4fb92c569f8e26eeab003e2f71851c60aa429\", \"got_dawn_revision\": \"dbd34449af20f2d026b1e7f959073e254066ec83\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"7f6955321792ce372e935f49cd4420b5b6ecb15f\", \"got_revision_cp\": \"refs/heads/master@{#807050}\", \"got_swarming_client_revision\": \"44c13d73156581ea09b9389001e58c23a4b8d70a\", \"got_swiftshader_revision\": \"0f14b7ab7a550971c97090a7cd4b9910084fe7ea\", \"got_v8_revision\": \"ff50ca34d46076a54b805f4f916cdd3e5805ccba\", \"got_v8_revision_cp\": \"refs/heads/8.7.88@{#1}\", \"got_webrtc_revision\": \"34f5ab82feaebb6ad66bc6f9fd3d4f91fa517636\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32102}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f6955321792ce372e935f49cd4420b5b6ecb15f\", \"swarm_hashes\": {\"blink_web_tests\": \"1ea653513bf31182ddde6db019bd412d64b7f747\", \"browser_tests\": \"9e403ab680ca352e924d72d3526b7ef200ffa1fa\", \"content_browsertests\": \"bb1b517c06f6414c7449271ac2652ca6fadf36bd\"}, \"swarm_hashes_refs/heads/master(at){#807050}_without_patch\": {\"blink_web_tests\": \"1ea653513bf31182ddde6db019bd412d64b7f747\", \"browser_tests\": \"9e403ab680ca352e924d72d3526b7ef200ffa1fa\", \"content_browsertests\": \"bb1b517c06f6414c7449271ac2652ca6fadf36bd\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5e40e9df3c25d6ec04b042625e64587de25b7cc9257c9b922c4342550ccccbb8_v2\", \"builder_a9924cd14a58b117dad8e399e061ac2c13857b9010bc500885f2e2912d9b3070_v2\", \"builder_d7a16d1002a90b006293eb3aaf9b6ed11d06403f3c58091e1c5077b5d2ff0b40_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-east1-d-8-116-gb76\"], \"image\": [\"chrome-xenial-20090600-f98a2a06cf8\"], \"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\": [\"5522-67570db\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"5 Test Suite(s) failed.\\n\\n**non_skia_renderer_swiftshader_blink_web_tests** failed.\\n\\n**non_skia_renderer_browser_tests** failed.\\n\\n**vulkan_swiftshader_blink_web_tests** failed.\\n\\n**vulkan_swiftshader_content_browsertests** failed.\\n\\n**skia_renderer_content_browsertests** failed.\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1600185985007110",
"status": "COMPLETED",
"status_changed_ts": "1600185985525040",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/23906",
"builder:Linux Viz",
"buildset:commit/git/7f6955321792ce372e935f49cd4420b5b6ecb15f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f6955321792ce372e935f49cd4420b5b6ecb15f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034507164261506352",
"scheduler_job_id:chromium/Linux Viz",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8869077102323552592/+/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:4eab55de87913610",
"user_agent:luci-scheduler"
],
"updated_ts": "1600193313017350",
"url": "https://ci.chromium.org/b/8869077102323552592",
"utcnow_ts": "1600193313489945"
}
}
[18:08:33.499] Invocation finished in 2h2m15.236358957s with status FAILED