[09:42:25.035] New invocation is queued and will start shortly
[09:42:26.163] Starting the invocation (attempt 1)
[09:42:26.210] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:42:26.210] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:42:26.211] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9034984301202459264",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7468139bc616f32504adbd887104aca8de85ea4b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9034984301202459264",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/7468139bc616f32504adbd887104aca8de85ea4b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7468139bc616f32504adbd887104aca8de85ea4b",
"gitiles_ref:refs/heads/master"
]
}
[09:42:27.334] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1599730946307222",
"id": "8869554239203462016",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7468139bc616f32504adbd887104aca8de85ea4b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1599730946818193",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/23835",
"builder:Linux Viz",
"buildset:commit/git/7468139bc616f32504adbd887104aca8de85ea4b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7468139bc616f32504adbd887104aca8de85ea4b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034984301202459264",
"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/8869554239203462016/+/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": "1599730946818374",
"url": "https://ci.chromium.org/b/8869554239203462016",
"utcnow_ts": "1599730947306085"
}
}
[09:42:27.334] Task URL: https://ci.chromium.org/b/8869554239203462016
[09:42:27.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:2:0) after 1m0s
[09:43:18.292] Received PubSub notification, asking Buildbucket for the build status
[09:43:18.441] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:27.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:2:0)
[09:43:27.432] Timer tick, asking Buildbucket for the build status
[09:43:27.517] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:27.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:4:0) after 1m0s
[09:44:27.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:4:0)
[09:44:27.571] Timer tick, asking Buildbucket for the build status
[09:44:27.783] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:27.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:5:0) after 1m0s
[09:45:27.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:5:0)
[09:45:27.814] Timer tick, asking Buildbucket for the build status
[09:45:27.926] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:27.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:6:0) after 1m0s
[09:46:27.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:6:0)
[09:46:27.981] Timer tick, asking Buildbucket for the build status
[09:46:28.213] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:28.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:7:0) after 1m0s
[09:47:28.343] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:7:0)
[09:47:28.343] Timer tick, asking Buildbucket for the build status
[09:47:28.695] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:28.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:8:0) after 1m0s
[09:48:28.720] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:8:0)
[09:48:28.720] Timer tick, asking Buildbucket for the build status
[09:48:28.821] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:28.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:9:0) after 1m0s
[09:49:28.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:9:0)
[09:49:28.835] Timer tick, asking Buildbucket for the build status
[09:49:28.912] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:28.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:10:0) after 1m0s
[09:50:28.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:10:0)
[09:50:28.924] Timer tick, asking Buildbucket for the build status
[09:50:29.887] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:29.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:11:0) after 1m0s
[09:51:29.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:11:0)
[09:51:29.958] Timer tick, asking Buildbucket for the build status
[09:51:30.426] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:30.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:12:0) after 1m0s
[09:52:30.486] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:12:0)
[09:52:30.486] Timer tick, asking Buildbucket for the build status
[09:52:30.663] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:30.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:13:0) after 1m0s
[09:53:30.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:13:0)
[09:53:30.751] Timer tick, asking Buildbucket for the build status
[09:53:30.821] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:30.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:14:0) after 1m0s
[09:54:30.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:14:0)
[09:54:30.948] Timer tick, asking Buildbucket for the build status
[09:54:31.468] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:31.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:15:0) after 1m0s
[09:55:31.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:15:0)
[09:55:31.559] Timer tick, asking Buildbucket for the build status
[09:55:31.756] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:31.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:16:0) after 1m0s
[09:56:32.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:16:0)
[09:56:32.035] Timer tick, asking Buildbucket for the build status
[09:56:32.129] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:32.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:17:0) after 1m0s
[09:57:32.416] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:17:0)
[09:57:32.416] Timer tick, asking Buildbucket for the build status
[09:57:33.367] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:33.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:18:0) after 1m0s
[09:58:34.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:18:0)
[09:58:34.283] Timer tick, asking Buildbucket for the build status
[09:58:34.367] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:34.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:19:0) after 1m0s
[09:59:34.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:19:0)
[09:59:34.644] Timer tick, asking Buildbucket for the build status
[09:59:34.717] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:34.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:20:0) after 1m0s
[10:00:35.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:20:0)
[10:00:35.018] Timer tick, asking Buildbucket for the build status
[10:00:35.087] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:35.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:21:0) after 1m0s
[10:01:35.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:21:0)
[10:01:35.242] Timer tick, asking Buildbucket for the build status
[10:01:38.437] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:38.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:22:0) after 1m0s
[10:02:38.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:22:0)
[10:02:38.600] Timer tick, asking Buildbucket for the build status
[10:02:38.896] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:38.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:23:0) after 1m0s
[10:03:39.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:23:0)
[10:03:39.067] Timer tick, asking Buildbucket for the build status
[10:03:39.223] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:39.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:24:0) after 1m0s
[10:04:39.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:24:0)
[10:04:39.296] Timer tick, asking Buildbucket for the build status
[10:04:39.466] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:39.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:25:0) after 1m0s
[10:05:39.499] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:25:0)
[10:05:39.499] Timer tick, asking Buildbucket for the build status
[10:05:39.701] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:39.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:26:0) after 1m0s
[10:06:39.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:26:0)
[10:06:39.874] Timer tick, asking Buildbucket for the build status
[10:06:39.991] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:39.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:27:0) after 1m0s
[10:07:40.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:27:0)
[10:07:40.100] Timer tick, asking Buildbucket for the build status
[10:07:40.334] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:40.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:28:0) after 1m0s
[10:08:41.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:28:0)
[10:08:41.125] Timer tick, asking Buildbucket for the build status
[10:08:41.311] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:41.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:29:0) after 1m0s
[10:09:41.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:29:0)
[10:09:41.350] Timer tick, asking Buildbucket for the build status
[10:09:41.431] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:41.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:30:0) after 1m0s
[10:10:41.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:30:0)
[10:10:41.417] Timer tick, asking Buildbucket for the build status
[10:10:41.734] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:41.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:31:0) after 1m0s
[10:11:41.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:31:0)
[10:11:41.713] Timer tick, asking Buildbucket for the build status
[10:11:41.803] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:41.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:32:0) after 1m0s
[10:12:41.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:32:0)
[10:12:41.893] Timer tick, asking Buildbucket for the build status
[10:12:42.092] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:42.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:33:0) after 1m0s
[10:13:42.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:33:0)
[10:13:42.203] Timer tick, asking Buildbucket for the build status
[10:13:42.306] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:42.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:34:0) after 1m0s
[10:14:42.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:34:0)
[10:14:42.450] Timer tick, asking Buildbucket for the build status
[10:14:42.593] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:42.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:35:0) after 1m0s
[10:15:42.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:35:0)
[10:15:42.748] Timer tick, asking Buildbucket for the build status
[10:15:42.855] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:42.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:36:0) after 1m0s
[10:16:43.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:36:0)
[10:16:43.117] Timer tick, asking Buildbucket for the build status
[10:16:43.329] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:43.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:37:0) after 1m0s
[10:17:43.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:37:0)
[10:17:43.546] Timer tick, asking Buildbucket for the build status
[10:17:43.699] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:43.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:38:0) after 1m0s
[10:18:43.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:38:0)
[10:18:43.873] Timer tick, asking Buildbucket for the build status
[10:18:44.237] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:44.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:39:0) after 1m0s
[10:19:44.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:39:0)
[10:19:44.334] Timer tick, asking Buildbucket for the build status
[10:19:44.400] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:44.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:40:0) after 1m0s
[10:20:44.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:40:0)
[10:20:44.561] Timer tick, asking Buildbucket for the build status
[10:20:44.845] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:44.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:41:0) after 1m0s
[10:21:45.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:41:0)
[10:21:45.003] Timer tick, asking Buildbucket for the build status
[10:21:45.438] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:45.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:42:0) after 1m0s
[10:22:45.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:42:0)
[10:22:45.496] Timer tick, asking Buildbucket for the build status
[10:22:45.826] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:45.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:43:0) after 1m0s
[10:23:45.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:43:0)
[10:23:45.870] Timer tick, asking Buildbucket for the build status
[10:23:46.060] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:46.060] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:44:0) after 1m0s
[10:24:46.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:44:0)
[10:24:46.158] Timer tick, asking Buildbucket for the build status
[10:24:46.589] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:46.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:45:0) after 1m0s
[10:25:46.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:45:0)
[10:25:46.651] Timer tick, asking Buildbucket for the build status
[10:25:46.713] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:46.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:46:0) after 1m0s
[10:26:46.996] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:46:0)
[10:26:46.996] Timer tick, asking Buildbucket for the build status
[10:26:47.068] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:47.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:47:0) after 1m0s
[10:27:47.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:47:0)
[10:27:47.337] Timer tick, asking Buildbucket for the build status
[10:27:47.541] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:47.541] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:48:0) after 1m0s
[10:28:47.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:48:0)
[10:28:47.600] Timer tick, asking Buildbucket for the build status
[10:28:47.690] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:47.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:49:0) after 1m0s
[10:29:47.882] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:49:0)
[10:29:47.882] Timer tick, asking Buildbucket for the build status
[10:29:47.952] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:47.952] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:50:0) after 1m0s
[10:30:49.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:50:0)
[10:30:49.064] Timer tick, asking Buildbucket for the build status
[10:30:49.179] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:49.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:51:0) after 1m0s
[10:31:49.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:51:0)
[10:31:49.316] Timer tick, asking Buildbucket for the build status
[10:31:49.624] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:49.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:52:0) after 1m0s
[10:32:49.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:52:0)
[10:32:49.860] Timer tick, asking Buildbucket for the build status
[10:32:50.018] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:50.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:53:0) after 1m0s
[10:33:50.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:53:0)
[10:33:50.159] Timer tick, asking Buildbucket for the build status
[10:33:50.221] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:50.221] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:54:0) after 1m0s
[10:34:50.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:54:0)
[10:34:50.423] Timer tick, asking Buildbucket for the build status
[10:34:50.482] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:50.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:55:0) after 1m0s
[10:35:50.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:55:0)
[10:35:50.591] Timer tick, asking Buildbucket for the build status
[10:35:50.668] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:50.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:56:0) after 1m0s
[10:36:50.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:56:0)
[10:36:50.933] Timer tick, asking Buildbucket for the build status
[10:36:51.048] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:51.048] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:57:0) after 1m0s
[10:37:51.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:57:0)
[10:37:51.256] Timer tick, asking Buildbucket for the build status
[10:37:51.423] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:51.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:58:0) after 1m0s
[10:38:51.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:58:0)
[10:38:51.575] Timer tick, asking Buildbucket for the build status
[10:38:51.662] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:51.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:59:0) after 1m0s
[10:39:51.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:59:0)
[10:39:51.837] Timer tick, asking Buildbucket for the build status
[10:39:52.377] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:52.377] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:60:0) after 1m0s
[10:40:52.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:60:0)
[10:40:52.464] Timer tick, asking Buildbucket for the build status
[10:40:52.624] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:52.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:61:0) after 1m0s
[10:41:52.715] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:61:0)
[10:41:52.715] Timer tick, asking Buildbucket for the build status
[10:41:52.828] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:52.828] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:62:0) after 1m0s
[10:42:52.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:62:0)
[10:42:52.919] Timer tick, asking Buildbucket for the build status
[10:42:53.224] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:53.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:63:0) after 1m0s
[10:43:53.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:63:0)
[10:43:53.304] Timer tick, asking Buildbucket for the build status
[10:43:53.763] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:53.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:64:0) after 1m0s
[10:44:53.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:64:0)
[10:44:53.799] Timer tick, asking Buildbucket for the build status
[10:44:53.866] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:53.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:65:0) after 1m0s
[10:45:53.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:65:0)
[10:45:53.910] Timer tick, asking Buildbucket for the build status
[10:45:54.035] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:54.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:66:0) after 1m0s
[10:46:54.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:66:0)
[10:46:54.094] Timer tick, asking Buildbucket for the build status
[10:46:54.206] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:54.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:67:0) after 1m0s
[10:47:54.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:67:0)
[10:47:54.292] Timer tick, asking Buildbucket for the build status
[10:47:54.415] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:54.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:68:0) after 1m0s
[10:48:54.543] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:68:0)
[10:48:54.543] Timer tick, asking Buildbucket for the build status
[10:48:54.613] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:54.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:69:0) after 1m0s
[10:49:54.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:69:0)
[10:49:54.680] Timer tick, asking Buildbucket for the build status
[10:49:54.835] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:54.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:70:0) after 1m0s
[10:50:54.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:70:0)
[10:50:54.981] Timer tick, asking Buildbucket for the build status
[10:50:55.068] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:55.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:71:0) after 1m0s
[10:51:55.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:71:0)
[10:51:55.520] Timer tick, asking Buildbucket for the build status
[10:51:55.893] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:55.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:72:0) after 1m0s
[10:52:56.086] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:72:0)
[10:52:56.086] Timer tick, asking Buildbucket for the build status
[10:52:56.294] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:56.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:73:0) after 1m0s
[10:53:56.340] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:73:0)
[10:53:56.340] Timer tick, asking Buildbucket for the build status
[10:53:56.486] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:56.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:74:0) after 1m0s
[10:54:56.633] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:74:0)
[10:54:56.633] Timer tick, asking Buildbucket for the build status
[10:54:56.704] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:56.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:75:0) after 1m0s
[10:55:56.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:75:0)
[10:55:56.836] Timer tick, asking Buildbucket for the build status
[10:55:56.940] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:56.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:76:0) after 1m0s
[10:56:57.022] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:76:0)
[10:56:57.022] Timer tick, asking Buildbucket for the build status
[10:56:57.121] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:57.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:77:0) after 1m0s
[10:57:57.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:77:0)
[10:57:57.352] Timer tick, asking Buildbucket for the build status
[10:57:57.546] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:57.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:78:0) after 1m0s
[10:58:57.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:78:0)
[10:58:57.709] Timer tick, asking Buildbucket for the build status
[10:58:57.808] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:57.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:79:0) after 1m0s
[10:59:57.943] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:79:0)
[10:59:57.943] Timer tick, asking Buildbucket for the build status
[10:59:58.211] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:58.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:80:0) after 1m0s
[11:00:58.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:80:0)
[11:00:58.346] Timer tick, asking Buildbucket for the build status
[11:00:58.436] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:58.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:81:0) after 1m0s
[11:01:58.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:81:0)
[11:01:58.428] Timer tick, asking Buildbucket for the build status
[11:01:58.598] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:58.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:82:0) after 1m0s
[11:02:58.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:82:0)
[11:02:58.749] Timer tick, asking Buildbucket for the build status
[11:02:59.096] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:59.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:83:0) after 1m0s
[11:03:59.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:83:0)
[11:03:59.244] Timer tick, asking Buildbucket for the build status
[11:03:59.337] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:59.337] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:84:0) after 1m0s
[11:04:59.363] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:84:0)
[11:04:59.363] Timer tick, asking Buildbucket for the build status
[11:04:59.647] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:59.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:85:0) after 1m0s
[11:05:59.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:85:0)
[11:05:59.769] Timer tick, asking Buildbucket for the build status
[11:05:59.848] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:59.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:86:0) after 1m0s
[11:06:59.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:86:0)
[11:06:59.937] Timer tick, asking Buildbucket for the build status
[11:07:00.111] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:00.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:87:0) after 1m0s
[11:08:00.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:87:0)
[11:08:00.173] Timer tick, asking Buildbucket for the build status
[11:08:00.432] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:00.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:88:0) after 1m0s
[11:09:00.469] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:88:0)
[11:09:00.469] Timer tick, asking Buildbucket for the build status
[11:09:00.578] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:00.578] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:89:0) after 1m0s
[11:10:00.665] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:89:0)
[11:10:00.665] Timer tick, asking Buildbucket for the build status
[11:10:01.057] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:01.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:90:0) after 1m0s
[11:11:01.358] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:90:0)
[11:11:01.358] Timer tick, asking Buildbucket for the build status
[11:11:01.630] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:01.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:91:0) after 1m0s
[11:12:01.678] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:91:0)
[11:12:01.678] Timer tick, asking Buildbucket for the build status
[11:12:01.757] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:01.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:92:0) after 1m0s
[11:13:01.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:92:0)
[11:13:01.994] Timer tick, asking Buildbucket for the build status
[11:13:02.489] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:02.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:93:0) after 1m0s
[11:14:02.539] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:93:0)
[11:14:02.539] Timer tick, asking Buildbucket for the build status
[11:14:02.680] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:02.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:94:0) after 1m0s
[11:15:02.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:94:0)
[11:15:02.893] Timer tick, asking Buildbucket for the build status
[11:15:03.301] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:03.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:95:0) after 1m0s
[11:16:03.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:95:0)
[11:16:03.327] Timer tick, asking Buildbucket for the build status
[11:16:03.603] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:03.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:96:0) after 1m0s
[11:17:03.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:96:0)
[11:17:03.599] Timer tick, asking Buildbucket for the build status
[11:17:05.146] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:05.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:97:0) after 1m0s
[11:18:05.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:97:0)
[11:18:05.276] Timer tick, asking Buildbucket for the build status
[11:18:05.681] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:05.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:98:0) after 1m0s
[11:19:05.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:98:0)
[11:19:05.701] Timer tick, asking Buildbucket for the build status
[11:19:05.767] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:05.767] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:99:0) after 1m0s
[11:20:05.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:99:0)
[11:20:05.814] Timer tick, asking Buildbucket for the build status
[11:20:05.922] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:05.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:100:0) after 1m0s
[11:21:05.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:100:0)
[11:21:05.970] Timer tick, asking Buildbucket for the build status
[11:21:06.067] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:06.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:101:0) after 1m0s
[11:22:06.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:101:0)
[11:22:06.101] Timer tick, asking Buildbucket for the build status
[11:22:06.196] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:06.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:102:0) after 1m0s
[11:23:06.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:102:0)
[11:23:06.339] Timer tick, asking Buildbucket for the build status
[11:23:06.531] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:06.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:103:0) after 1m0s
[11:24:06.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:103:0)
[11:24:06.635] Timer tick, asking Buildbucket for the build status
[11:24:06.893] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:06.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:104:0) after 1m0s
[11:25:06.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:104:0)
[11:25:06.908] Timer tick, asking Buildbucket for the build status
[11:25:06.986] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:06.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:105:0) after 1m0s
[11:26:07.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:105:0)
[11:26:07.034] Timer tick, asking Buildbucket for the build status
[11:26:07.312] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:07.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:106:0) after 1m0s
[11:27:07.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:106:0)
[11:27:07.298] Timer tick, asking Buildbucket for the build status
[11:27:07.504] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:07.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:107:0) after 1m0s
[11:28:07.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:107:0)
[11:28:07.576] Timer tick, asking Buildbucket for the build status
[11:28:07.710] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:07.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:108:0) after 1m0s
[11:29:07.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:108:0)
[11:29:07.810] Timer tick, asking Buildbucket for the build status
[11:29:07.913] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:07.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:109:0) after 1m0s
[11:30:07.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:109:0)
[11:30:07.942] Timer tick, asking Buildbucket for the build status
[11:30:08.041] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:08.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:110:0) after 1m0s
[11:31:08.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:110:0)
[11:31:08.094] Timer tick, asking Buildbucket for the build status
[11:31:08.196] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:08.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:111:0) after 1m0s
[11:32:08.243] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:111:0)
[11:32:08.243] Timer tick, asking Buildbucket for the build status
[11:32:08.496] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:08.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:112:0) after 1m0s
[11:33:08.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:112:0)
[11:33:08.526] Timer tick, asking Buildbucket for the build status
[11:33:08.993] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:08.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:113:0) after 1m0s
[11:34:09.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:113:0)
[11:34:09.085] Timer tick, asking Buildbucket for the build status
[11:34:09.246] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:09.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:114:0) after 1m0s
[11:35:09.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:114:0)
[11:35:09.338] Timer tick, asking Buildbucket for the build status
[11:35:09.482] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:09.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:115:0) after 1m0s
[11:36:09.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:115:0)
[11:36:09.467] Timer tick, asking Buildbucket for the build status
[11:36:09.552] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:09.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:116:0) after 1m0s
[11:37:09.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:116:0)
[11:37:09.598] Timer tick, asking Buildbucket for the build status
[11:37:09.782] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:09.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:117:0) after 1m0s
[11:38:09.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:117:0)
[11:38:09.818] Timer tick, asking Buildbucket for the build status
[11:38:09.955] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:09.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:118:0) after 1m0s
[11:39:09.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:118:0)
[11:39:09.981] Timer tick, asking Buildbucket for the build status
[11:39:10.111] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:10.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:119:0) after 1m0s
[11:40:10.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:119:0)
[11:40:10.185] Timer tick, asking Buildbucket for the build status
[11:40:10.298] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:10.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:120:0) after 1m0s
[11:41:10.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:120:0)
[11:41:10.373] Timer tick, asking Buildbucket for the build status
[11:41:10.505] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:10.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:121:0) after 1m0s
[11:42:10.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:121:0)
[11:42:10.691] Timer tick, asking Buildbucket for the build status
[11:42:10.761] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:10.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:122:0) after 1m0s
[11:43:10.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:122:0)
[11:43:10.790] Timer tick, asking Buildbucket for the build status
[11:43:10.967] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:10.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:123:0) after 1m0s
[11:44:11.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:123:0)
[11:44:11.029] Timer tick, asking Buildbucket for the build status
[11:44:11.235] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:11.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:124:0) after 1m0s
[11:45:11.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:124:0)
[11:45:11.287] Timer tick, asking Buildbucket for the build status
[11:45:11.516] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:11.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:125:0) after 1m0s
[11:46:11.543] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:125:0)
[11:46:11.543] Timer tick, asking Buildbucket for the build status
[11:46:13.126] Build 8869554239203462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:13.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034984301202459264:126:0) after 1m0s
[11:46:37.201] Received PubSub notification, asking Buildbucket for the build status
[11:46:37.355] Build 8869554239203462016: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[11:46:37.355] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1599738396305227",
"created_by": "project:chromium",
"created_ts": "1599730946307222",
"failure_reason": "BUILD_FAILURE",
"id": "8869554239203462016",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7468139bc616f32504adbd887104aca8de85ea4b\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"5 Test Suite(s) failed.\\n\\n**non_skia_renderer_browser_tests** failed.\\n\\n**skia_renderer_content_browsertests** failed.\\n\\n**vulkan_swiftshader_blink_web_tests** failed.\\n\\n**vulkan_swiftshader_content_browsertests** failed.\\n\\n**non_skia_renderer_swiftshader_blink_web_tests** 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\": \"7468139bc616f32504adbd887104aca8de85ea4b\", \"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-7-jke1\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Linux Viz\", \"buildnumber\": 23835, \"got_angle_revision\": \"29b1f07f4ab23475ca2ece790cd85affd6d774db\", \"got_dawn_revision\": \"87f25134a8c1756064113d8301448966290e8243\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"7468139bc616f32504adbd887104aca8de85ea4b\", \"got_revision_cp\": \"refs/heads/master@{#805676}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"b24900a1aa39721dc53824c01d4169c1d1a4a6e1\", \"got_v8_revision\": \"bb4817544d7ce327fc432a8229efa213952ca979\", \"got_v8_revision_cp\": \"refs/heads/8.7.76@{#1}\", \"got_webrtc_revision\": \"9e9c8b7155d49c2f38b82fe9c9707181c57073c9\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32051}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7468139bc616f32504adbd887104aca8de85ea4b\", \"swarm_hashes\": {\"blink_web_tests\": \"4d81a6609aab22d03e1cd37e9e8b62ab80e4b8c3\", \"browser_tests\": \"35d68dc49ffd7cd5a99ddbc471d34115370214f1\", \"content_browsertests\": \"f59fdbd5ae3d2dd1ad0738b1361fcfbbbff9ff0a\"}, \"swarm_hashes_refs/heads/master(at){#805676}_without_patch\": {\"blink_web_tests\": \"4d81a6609aab22d03e1cd37e9e8b62ab80e4b8c3\", \"browser_tests\": \"35d68dc49ffd7cd5a99ddbc471d34115370214f1\", \"content_browsertests\": \"f59fdbd5ae3d2dd1ad0738b1361fcfbbbff9ff0a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5e40e9df3c25d6ec04b042625e64587de25b7cc9257c9b922c4342550ccccbb8_v2\", \"builder_953e900270162ec95f568ea264af47d43b9a29a15e01ede040ffa4d15b188919_v2\", \"builder_e7fd4b7a9e211f8d968af60263c508e13e49814167aff980c2bf239c05ea48ef_v2\", \"builder_eae3a4dc277b4e2282e9fce002ae6861b5ee5509389502cf3acc9366ec79a2d3_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-7-jke1\"], \"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\": [\"5513-ee65082\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"5 Test Suite(s) failed.\\n\\n**non_skia_renderer_browser_tests** failed.\\n\\n**skia_renderer_content_browsertests** failed.\\n\\n**vulkan_swiftshader_blink_web_tests** failed.\\n\\n**vulkan_swiftshader_content_browsertests** failed.\\n\\n**non_skia_renderer_swiftshader_blink_web_tests** failed.\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1599730997410674",
"status": "COMPLETED",
"status_changed_ts": "1599730997796872",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/23835",
"builder:Linux Viz",
"buildset:commit/git/7468139bc616f32504adbd887104aca8de85ea4b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7468139bc616f32504adbd887104aca8de85ea4b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034984301202459264",
"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/8869554239203462016/+/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:4e9036a0bb08b810",
"user_agent:luci-scheduler"
],
"updated_ts": "1599738396620884",
"url": "https://ci.chromium.org/b/8869554239203462016",
"utcnow_ts": "1599738397309158"
}
}
[11:46:37.355] Invocation finished in 2h4m12.337962878s with status FAILED