[08:37:32.403] New invocation is queued and will start shortly
[08:37:33.559] Starting the invocation (attempt 1)
[08:37:33.594] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:37:33.594] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:37:33.595] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9033720025391241776",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"47bcc5fa40235e9230ead5f33778fea515fb5154\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9033720025391241776",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/47bcc5fa40235e9230ead5f33778fea515fb5154",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/47bcc5fa40235e9230ead5f33778fea515fb5154",
"gitiles_ref:refs/heads/master"
]
}
[08:37:34.488] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1600936653742867",
"id": "8868289963323688304",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"47bcc5fa40235e9230ead5f33778fea515fb5154\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1600936654284880",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/24026",
"builder:Linux Viz",
"buildset:commit/git/47bcc5fa40235e9230ead5f33778fea515fb5154",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/47bcc5fa40235e9230ead5f33778fea515fb5154",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9033720025391241776",
"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/8868289963323688304/+/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": "1600936654285027",
"url": "https://ci.chromium.org/b/8868289963323688304",
"utcnow_ts": "1600936654475034"
}
}
[08:37:34.488] Task URL: https://ci.chromium.org/b/8868289963323688304
[08:37:34.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:2:0) after 1m0s
[08:37:58.872] Received PubSub notification, asking Buildbucket for the build status
[08:37:59.514] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:34.554] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:2:0)
[08:38:34.554] Timer tick, asking Buildbucket for the build status
[08:38:34.713] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:34.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:4:0) after 1m0s
[08:39:34.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:4:0)
[08:39:34.711] Timer tick, asking Buildbucket for the build status
[08:39:35.211] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:35.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:5:0) after 1m0s
[08:40:35.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:5:0)
[08:40:35.300] Timer tick, asking Buildbucket for the build status
[08:40:35.371] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:35.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:6:0) after 1m0s
[08:41:35.605] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:6:0)
[08:41:35.605] Timer tick, asking Buildbucket for the build status
[08:41:35.680] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:35.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:7:0) after 1m0s
[08:42:36.046] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:7:0)
[08:42:36.046] Timer tick, asking Buildbucket for the build status
[08:42:36.193] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:36.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:8:0) after 1m0s
[08:43:36.218] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:8:0)
[08:43:36.218] Timer tick, asking Buildbucket for the build status
[08:43:36.364] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:36.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:9:0) after 1m0s
[08:44:36.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:9:0)
[08:44:36.495] Timer tick, asking Buildbucket for the build status
[08:44:36.927] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:36.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:10:0) after 1m0s
[08:45:36.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:10:0)
[08:45:36.979] Timer tick, asking Buildbucket for the build status
[08:45:37.315] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:37.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:11:0) after 1m0s
[08:46:37.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:11:0)
[08:46:37.326] Timer tick, asking Buildbucket for the build status
[08:46:37.423] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:37.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:12:0) after 1m0s
[08:47:37.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:12:0)
[08:47:37.441] Timer tick, asking Buildbucket for the build status
[08:47:37.589] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:37.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:13:0) after 1m0s
[08:48:37.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:13:0)
[08:48:37.644] Timer tick, asking Buildbucket for the build status
[08:48:37.716] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:37.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:14:0) after 1m0s
[08:49:37.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:14:0)
[08:49:37.801] Timer tick, asking Buildbucket for the build status
[08:49:37.908] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:37.908] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:15:0) after 1m0s
[08:50:37.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:15:0)
[08:50:37.933] Timer tick, asking Buildbucket for the build status
[08:50:38.302] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:38.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:16:0) after 1m0s
[08:51:39.820] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:16:0)
[08:51:39.820] Timer tick, asking Buildbucket for the build status
[08:51:40.133] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:40.133] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:17:0) after 1m0s
[08:52:42.495] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:17:0)
[08:52:42.495] Timer tick, asking Buildbucket for the build status
[08:52:42.660] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:42.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:18:0) after 1m0s
[08:53:42.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:18:0)
[08:53:42.711] Timer tick, asking Buildbucket for the build status
[08:53:42.884] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:42.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:19:0) after 1m0s
[08:54:42.932] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:19:0)
[08:54:42.932] Timer tick, asking Buildbucket for the build status
[08:54:43.082] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:43.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:20:0) after 1m0s
[08:55:43.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:20:0)
[08:55:43.103] Timer tick, asking Buildbucket for the build status
[08:55:43.317] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:43.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:21:0) after 1m0s
[08:56:43.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:21:0)
[08:56:43.374] Timer tick, asking Buildbucket for the build status
[08:56:43.537] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:43.537] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:22:0) after 1m0s
[08:57:43.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:22:0)
[08:57:43.570] Timer tick, asking Buildbucket for the build status
[08:57:43.725] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:43.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:23:0) after 1m0s
[08:58:43.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:23:0)
[08:58:43.766] Timer tick, asking Buildbucket for the build status
[08:58:43.863] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:43.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:24:0) after 1m0s
[08:59:43.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:24:0)
[08:59:43.874] Timer tick, asking Buildbucket for the build status
[08:59:44.118] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:44.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:25:0) after 1m0s
[09:00:44.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:25:0)
[09:00:44.353] Timer tick, asking Buildbucket for the build status
[09:00:44.449] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:44.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:26:0) after 1m0s
[09:01:44.572] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:26:0)
[09:01:44.572] Timer tick, asking Buildbucket for the build status
[09:01:44.693] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:44.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:27:0) after 1m0s
[09:02:44.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:27:0)
[09:02:44.815] Timer tick, asking Buildbucket for the build status
[09:02:45.285] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:45.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:28:0) after 1m0s
[09:03:45.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:28:0)
[09:03:45.658] Timer tick, asking Buildbucket for the build status
[09:03:45.827] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:45.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:29:0) after 1m0s
[09:04:45.861] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:29:0)
[09:04:45.861] Timer tick, asking Buildbucket for the build status
[09:04:45.930] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:45.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:30:0) after 1m0s
[09:05:46.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:30:0)
[09:05:46.025] Timer tick, asking Buildbucket for the build status
[09:05:46.125] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:46.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:31:0) after 1m0s
[09:06:47.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:31:0)
[09:06:47.128] Timer tick, asking Buildbucket for the build status
[09:06:47.238] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:47.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:32:0) after 1m0s
[09:07:47.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:32:0)
[09:07:47.318] Timer tick, asking Buildbucket for the build status
[09:07:47.902] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:47.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:33:0) after 1m0s
[09:08:47.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:33:0)
[09:08:47.965] Timer tick, asking Buildbucket for the build status
[09:08:48.238] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:48.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:34:0) after 1m0s
[09:09:48.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:34:0)
[09:09:48.407] Timer tick, asking Buildbucket for the build status
[09:09:48.505] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:48.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:35:0) after 1m0s
[09:10:48.583] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:35:0)
[09:10:48.583] Timer tick, asking Buildbucket for the build status
[09:10:48.877] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:48.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:36:0) after 1m0s
[09:11:48.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:36:0)
[09:11:48.927] Timer tick, asking Buildbucket for the build status
[09:11:49.213] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:49.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:37:0) after 1m0s
[09:12:49.254] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:37:0)
[09:12:49.254] Timer tick, asking Buildbucket for the build status
[09:12:49.444] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:49.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:38:0) after 1m0s
[09:13:49.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:38:0)
[09:13:49.552] Timer tick, asking Buildbucket for the build status
[09:13:50.017] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:50.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:39:0) after 1m0s
[09:14:50.063] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:39:0)
[09:14:50.063] Timer tick, asking Buildbucket for the build status
[09:14:50.187] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:50.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:40:0) after 1m0s
[09:15:50.225] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:40:0)
[09:15:50.225] Timer tick, asking Buildbucket for the build status
[09:15:50.347] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:50.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:41:0) after 1m0s
[09:16:50.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:41:0)
[09:16:50.351] Timer tick, asking Buildbucket for the build status
[09:16:50.645] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:50.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:42:0) after 1m0s
[09:17:50.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:42:0)
[09:17:50.851] Timer tick, asking Buildbucket for the build status
[09:17:51.126] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:51.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:43:0) after 1m0s
[09:18:51.191] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:43:0)
[09:18:51.191] Timer tick, asking Buildbucket for the build status
[09:18:51.330] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:51.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:44:0) after 1m0s
[09:19:51.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:44:0)
[09:19:51.364] Timer tick, asking Buildbucket for the build status
[09:19:51.679] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:51.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:45:0) after 1m0s
[09:20:51.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:45:0)
[09:20:51.721] Timer tick, asking Buildbucket for the build status
[09:20:51.796] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:51.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:46:0) after 1m0s
[09:21:51.849] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:46:0)
[09:21:51.849] Timer tick, asking Buildbucket for the build status
[09:21:51.921] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:51.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:47:0) after 1m0s
[09:22:51.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:47:0)
[09:22:51.983] Timer tick, asking Buildbucket for the build status
[09:22:52.153] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:52.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:48:0) after 1m0s
[09:23:52.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:48:0)
[09:23:52.177] Timer tick, asking Buildbucket for the build status
[09:23:52.323] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:52.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:49:0) after 1m0s
[09:24:52.335] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:49:0)
[09:24:52.335] Timer tick, asking Buildbucket for the build status
[09:24:52.405] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:52.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:50:0) after 1m0s
[09:25:52.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:50:0)
[09:25:52.460] Timer tick, asking Buildbucket for the build status
[09:25:52.706] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:52.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:51:0) after 1m0s
[09:26:52.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:51:0)
[09:26:52.750] Timer tick, asking Buildbucket for the build status
[09:26:52.844] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:52.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:52:0) after 1m0s
[09:27:52.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:52:0)
[09:27:52.915] Timer tick, asking Buildbucket for the build status
[09:27:53.149] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:53.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:53:0) after 1m0s
[09:28:53.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:53:0)
[09:28:53.256] Timer tick, asking Buildbucket for the build status
[09:28:53.355] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:53.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:54:0) after 1m0s
[09:29:53.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:54:0)
[09:29:53.399] Timer tick, asking Buildbucket for the build status
[09:29:53.556] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:53.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:55:0) after 1m0s
[09:30:53.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:55:0)
[09:30:53.628] Timer tick, asking Buildbucket for the build status
[09:30:53.897] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:53.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:56:0) after 1m0s
[09:31:53.926] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:56:0)
[09:31:53.926] Timer tick, asking Buildbucket for the build status
[09:31:54.023] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:54.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:57:0) after 1m0s
[09:32:54.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:57:0)
[09:32:54.266] Timer tick, asking Buildbucket for the build status
[09:32:54.394] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:54.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:58:0) after 1m0s
[09:33:54.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:58:0)
[09:33:54.538] Timer tick, asking Buildbucket for the build status
[09:33:54.668] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:54.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:59:0) after 1m0s
[09:34:54.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:59:0)
[09:34:54.775] Timer tick, asking Buildbucket for the build status
[09:34:54.857] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:54.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:60:0) after 1m0s
[09:35:54.943] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:60:0)
[09:35:54.943] Timer tick, asking Buildbucket for the build status
[09:35:55.214] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:55.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:61:0) after 1m0s
[09:36:55.306] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:61:0)
[09:36:55.306] Timer tick, asking Buildbucket for the build status
[09:36:55.391] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:55.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:62:0) after 1m0s
[09:37:55.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:62:0)
[09:37:55.432] Timer tick, asking Buildbucket for the build status
[09:37:55.839] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:55.839] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:63:0) after 1m0s
[09:38:55.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:63:0)
[09:38:55.944] Timer tick, asking Buildbucket for the build status
[09:38:56.017] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:56.017] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:64:0) after 1m0s
[09:39:56.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:64:0)
[09:39:56.073] Timer tick, asking Buildbucket for the build status
[09:39:56.246] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:56.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:65:0) after 1m0s
[09:40:56.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:65:0)
[09:40:56.291] Timer tick, asking Buildbucket for the build status
[09:40:58.126] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:58.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:66:0) after 1m0s
[09:41:58.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:66:0)
[09:41:58.224] Timer tick, asking Buildbucket for the build status
[09:41:58.329] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:58.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:67:0) after 1m0s
[09:42:58.540] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:67:0)
[09:42:58.540] Timer tick, asking Buildbucket for the build status
[09:42:58.684] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:58.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:68:0) after 1m0s
[09:43:58.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:68:0)
[09:43:58.745] Timer tick, asking Buildbucket for the build status
[09:43:58.915] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:58.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:69:0) after 1m0s
[09:44:58.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:69:0)
[09:44:58.954] Timer tick, asking Buildbucket for the build status
[09:44:59.292] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:59.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:70:0) after 1m0s
[09:45:59.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:70:0)
[09:45:59.758] Timer tick, asking Buildbucket for the build status
[09:46:01.848] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:01.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:71:0) after 1m0s
[09:47:03.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:71:0)
[09:47:03.532] Timer tick, asking Buildbucket for the build status
[09:47:03.611] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:03.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:72:0) after 1m0s
[09:48:03.735] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:72:0)
[09:48:03.735] Timer tick, asking Buildbucket for the build status
[09:48:03.845] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:03.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:73:0) after 1m0s
[09:49:04.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:73:0)
[09:49:04.085] Timer tick, asking Buildbucket for the build status
[09:49:04.211] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:04.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:74:0) after 1m0s
[09:50:04.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:74:0)
[09:50:04.357] Timer tick, asking Buildbucket for the build status
[09:50:04.544] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:04.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:75:0) after 1m0s
[09:51:04.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:75:0)
[09:51:04.652] Timer tick, asking Buildbucket for the build status
[09:51:05.881] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:05.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:76:0) after 1m0s
[09:52:06.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:76:0)
[09:52:06.036] Timer tick, asking Buildbucket for the build status
[09:52:06.182] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:06.183] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:77:0) after 1m0s
[09:53:06.248] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:77:0)
[09:53:06.248] Timer tick, asking Buildbucket for the build status
[09:53:06.699] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:06.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:78:0) after 1m0s
[09:54:06.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:78:0)
[09:54:06.746] Timer tick, asking Buildbucket for the build status
[09:54:06.843] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:06.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:79:0) after 1m0s
[09:55:06.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:79:0)
[09:55:06.991] Timer tick, asking Buildbucket for the build status
[09:55:07.112] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:07.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:80:0) after 1m0s
[09:56:07.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:80:0)
[09:56:07.204] Timer tick, asking Buildbucket for the build status
[09:56:07.277] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:07.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:81:0) after 1m0s
[09:57:07.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:81:0)
[09:57:07.383] Timer tick, asking Buildbucket for the build status
[09:57:07.526] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:07.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:82:0) after 1m0s
[09:58:07.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:82:0)
[09:58:07.526] Timer tick, asking Buildbucket for the build status
[09:58:07.667] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:07.667] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:83:0) after 1m0s
[09:59:07.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:83:0)
[09:59:07.699] Timer tick, asking Buildbucket for the build status
[09:59:07.932] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:07.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:84:0) after 1m0s
[10:00:07.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:84:0)
[10:00:07.956] Timer tick, asking Buildbucket for the build status
[10:00:08.144] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:08.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:85:0) after 1m0s
[10:01:08.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:85:0)
[10:01:08.806] Timer tick, asking Buildbucket for the build status
[10:01:08.894] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:08.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:86:0) after 1m0s
[10:02:08.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:86:0)
[10:02:08.929] Timer tick, asking Buildbucket for the build status
[10:02:09.095] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:09.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:87:0) after 1m0s
[10:03:09.235] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:87:0)
[10:03:09.236] Timer tick, asking Buildbucket for the build status
[10:03:09.426] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:09.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:88:0) after 1m0s
[10:04:09.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:88:0)
[10:04:09.479] Timer tick, asking Buildbucket for the build status
[10:04:09.604] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:09.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:89:0) after 1m0s
[10:05:09.788] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:89:0)
[10:05:09.788] Timer tick, asking Buildbucket for the build status
[10:05:10.104] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:10.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:90:0) after 1m0s
[10:06:10.175] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:90:0)
[10:06:10.175] Timer tick, asking Buildbucket for the build status
[10:06:10.424] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:10.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:91:0) after 1m0s
[10:07:10.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:91:0)
[10:07:10.489] Timer tick, asking Buildbucket for the build status
[10:07:10.562] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:10.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:92:0) after 1m0s
[10:08:10.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:92:0)
[10:08:10.629] Timer tick, asking Buildbucket for the build status
[10:08:10.872] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:10.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:93:0) after 1m0s
[10:09:10.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:93:0)
[10:09:10.931] Timer tick, asking Buildbucket for the build status
[10:09:11.043] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:11.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:94:0) after 1m0s
[10:10:11.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:94:0)
[10:10:11.121] Timer tick, asking Buildbucket for the build status
[10:10:11.788] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:11.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:95:0) after 1m0s
[10:11:11.820] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:95:0)
[10:11:11.820] Timer tick, asking Buildbucket for the build status
[10:11:12.069] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:12.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:96:0) after 1m0s
[10:12:12.145] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:96:0)
[10:12:12.145] Timer tick, asking Buildbucket for the build status
[10:12:12.457] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:12.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:97:0) after 1m0s
[10:13:12.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:97:0)
[10:13:12.553] Timer tick, asking Buildbucket for the build status
[10:13:12.808] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:12.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:98:0) after 1m0s
[10:14:12.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:98:0)
[10:14:12.893] Timer tick, asking Buildbucket for the build status
[10:14:12.979] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:12.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:99:0) after 1m0s
[10:15:13.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:99:0)
[10:15:13.204] Timer tick, asking Buildbucket for the build status
[10:15:13.523] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:13.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:100:0) after 1m0s
[10:16:13.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:100:0)
[10:16:13.730] Timer tick, asking Buildbucket for the build status
[10:16:13.842] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:13.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:101:0) after 1m0s
[10:17:13.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:101:0)
[10:17:13.946] Timer tick, asking Buildbucket for the build status
[10:17:14.073] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:14.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:102:0) after 1m0s
[10:18:14.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:102:0)
[10:18:14.222] Timer tick, asking Buildbucket for the build status
[10:18:14.599] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:14.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:103:0) after 1m0s
[10:19:14.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:103:0)
[10:19:14.822] Timer tick, asking Buildbucket for the build status
[10:19:15.018] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:15.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:104:0) after 1m0s
[10:20:15.150] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:104:0)
[10:20:15.150] Timer tick, asking Buildbucket for the build status
[10:20:15.335] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:15.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:105:0) after 1m0s
[10:21:15.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:105:0)
[10:21:15.608] Timer tick, asking Buildbucket for the build status
[10:21:15.717] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:15.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:106:0) after 1m0s
[10:22:15.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:106:0)
[10:22:15.814] Timer tick, asking Buildbucket for the build status
[10:22:15.905] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:15.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:107:0) after 1m0s
[10:23:16.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:107:0)
[10:23:16.005] Timer tick, asking Buildbucket for the build status
[10:23:16.145] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:16.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:108:0) after 1m0s
[10:24:16.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:108:0)
[10:24:16.312] Timer tick, asking Buildbucket for the build status
[10:24:16.404] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:16.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:109:0) after 1m0s
[10:25:16.494] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:109:0)
[10:25:16.494] Timer tick, asking Buildbucket for the build status
[10:25:16.735] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:16.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:110:0) after 1m0s
[10:26:16.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:110:0)
[10:26:16.766] Timer tick, asking Buildbucket for the build status
[10:26:16.940] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:16.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:111:0) after 1m0s
[10:27:17.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:111:0)
[10:27:17.099] Timer tick, asking Buildbucket for the build status
[10:27:17.534] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:17.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:112:0) after 1m0s
[10:28:17.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:112:0)
[10:28:17.806] Timer tick, asking Buildbucket for the build status
[10:28:17.978] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:17.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:113:0) after 1m0s
[10:29:17.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:113:0)
[10:29:17.994] Timer tick, asking Buildbucket for the build status
[10:29:18.062] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:18.062] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:114:0) after 1m0s
[10:30:18.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:114:0)
[10:30:18.087] Timer tick, asking Buildbucket for the build status
[10:30:18.165] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:18.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:115:0) after 1m0s
[10:31:18.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:115:0)
[10:31:18.255] Timer tick, asking Buildbucket for the build status
[10:31:18.353] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:18.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:116:0) after 1m0s
[10:32:18.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:116:0)
[10:32:18.467] Timer tick, asking Buildbucket for the build status
[10:32:18.565] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:18.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:117:0) after 1m0s
[10:33:18.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:117:0)
[10:33:18.599] Timer tick, asking Buildbucket for the build status
[10:33:18.733] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:18.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:118:0) after 1m0s
[10:34:18.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:118:0)
[10:34:18.844] Timer tick, asking Buildbucket for the build status
[10:34:18.945] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:18.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:119:0) after 1m0s
[10:35:19.148] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:119:0)
[10:35:19.148] Timer tick, asking Buildbucket for the build status
[10:35:19.405] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:19.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:120:0) after 1m0s
[10:36:19.922] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:120:0)
[10:36:19.922] Timer tick, asking Buildbucket for the build status
[10:36:20.134] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:20.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:121:0) after 1m0s
[10:37:20.330] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:121:0)
[10:37:20.330] Timer tick, asking Buildbucket for the build status
[10:37:20.686] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:20.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:122:0) after 1m0s
[10:38:20.896] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:122:0)
[10:38:20.896] Timer tick, asking Buildbucket for the build status
[10:38:21.125] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:21.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:123:0) after 1m0s
[10:39:21.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:123:0)
[10:39:21.450] Timer tick, asking Buildbucket for the build status
[10:39:21.554] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:21.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:124:0) after 1m0s
[10:40:22.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:124:0)
[10:40:22.027] Timer tick, asking Buildbucket for the build status
[10:40:22.290] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:22.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:125:0) after 1m0s
[10:41:22.320] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:125:0)
[10:41:22.320] Timer tick, asking Buildbucket for the build status
[10:41:22.382] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:22.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:126:0) after 1m0s
[10:42:22.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:126:0)
[10:42:22.476] Timer tick, asking Buildbucket for the build status
[10:42:22.637] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:22.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:127:0) after 1m0s
[10:43:22.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:127:0)
[10:43:22.875] Timer tick, asking Buildbucket for the build status
[10:43:23.028] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:23.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:128:0) after 1m0s
[10:44:23.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:128:0)
[10:44:23.138] Timer tick, asking Buildbucket for the build status
[10:44:23.300] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:23.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:129:0) after 1m0s
[10:45:23.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:129:0)
[10:45:23.347] Timer tick, asking Buildbucket for the build status
[10:45:23.701] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:23.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:130:0) after 1m0s
[10:46:23.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:130:0)
[10:46:23.727] Timer tick, asking Buildbucket for the build status
[10:46:23.810] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:23.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:131:0) after 1m0s
[10:47:23.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:131:0)
[10:47:23.997] Timer tick, asking Buildbucket for the build status
[10:47:24.066] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:24.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:132:0) after 1m0s
[10:48:24.831] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:132:0)
[10:48:24.831] Timer tick, asking Buildbucket for the build status
[10:48:24.975] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:24.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:133:0) after 1m0s
[10:49:24.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:133:0)
[10:49:24.999] Timer tick, asking Buildbucket for the build status
[10:49:25.067] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:25.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:134:0) after 1m0s
[10:50:25.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:134:0)
[10:50:25.441] Timer tick, asking Buildbucket for the build status
[10:50:25.599] Build 8868289963323688304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:25.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9033720025391241776:135:0) after 1m0s
[10:50:35.315] Received PubSub notification, asking Buildbucket for the build status
[10:50:35.539] Build 8868289963323688304: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[10:50:35.539] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1600944634884382",
"created_by": "project:chromium",
"created_ts": "1600936653742867",
"failure_reason": "BUILD_FAILURE",
"id": "8868289963323688304",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"47bcc5fa40235e9230ead5f33778fea515fb5154\"}}",
"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**skia_renderer_content_browsertests** failed.\\n\\n**non_skia_renderer_browser_tests** failed.\\n\\n**vulkan_swiftshader_blink_web_tests** failed.\\n\\n**vulkan_swiftshader_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\": \"47bcc5fa40235e9230ead5f33778fea515fb5154\", \"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-107-b88p\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Linux Viz\", \"buildnumber\": 24026, \"got_angle_revision\": \"6c3942200a20a6609f212e9833b2bc81bdb14f59\", \"got_dawn_revision\": \"75e5ed6161fcb3a79cbf584c273ff7eac84956a9\", \"got_nacl_revision\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"got_revision\": \"47bcc5fa40235e9230ead5f33778fea515fb5154\", \"got_revision_cp\": \"refs/heads/master@{#810107}\", \"got_swarming_client_revision\": \"44c13d73156581ea09b9389001e58c23a4b8d70a\", \"got_swiftshader_revision\": \"6aadd31a5f988b254046addce6aadaa650f098e9\", \"got_v8_revision\": \"4ee4324d55d9038d34bcf3e70d7951ab5720b700\", \"got_v8_revision_cp\": \"refs/heads/8.7.176@{#1}\", \"got_webrtc_revision\": \"5e85c8bc3139cff623f7b7724bb56529ce11d3ec\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32179}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"47bcc5fa40235e9230ead5f33778fea515fb5154\", \"swarm_hashes\": {\"blink_web_tests\": \"44d1b469d291b7e8eefe5b151397e280208dd4e7\", \"browser_tests\": \"d747d93b142d596152350e8eb7c2cd0217ac3c09\", \"content_browsertests\": \"2b48ceb0dadd29a7e4bb8945d7a92d4fb3b7a911\"}, \"swarm_hashes_refs/heads/master(at){#810107}_without_patch\": {\"blink_web_tests\": \"44d1b469d291b7e8eefe5b151397e280208dd4e7\", \"browser_tests\": \"d747d93b142d596152350e8eb7c2cd0217ac3c09\", \"content_browsertests\": \"2b48ceb0dadd29a7e4bb8945d7a92d4fb3b7a911\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5e40e9df3c25d6ec04b042625e64587de25b7cc9257c9b922c4342550ccccbb8_v2\", \"builder_6c0923f365f8f1db63992c0d8bb8e67eddd170bcdde4d3ceb5262cc4867716ce_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-107-b88p\"], \"image\": [\"chrome-xenial-20091600-9ddf7e422ac\"], \"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\": [\"5531-8ab19d9\"], \"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**skia_renderer_content_browsertests** failed.\\n\\n**non_skia_renderer_browser_tests** failed.\\n\\n**vulkan_swiftshader_blink_web_tests** failed.\\n\\n**vulkan_swiftshader_content_browsertests** failed.\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1600936677858216",
"status": "COMPLETED",
"status_changed_ts": "1600936678435795",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/24026",
"builder:Linux Viz",
"buildset:commit/git/47bcc5fa40235e9230ead5f33778fea515fb5154",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/47bcc5fa40235e9230ead5f33778fea515fb5154",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9033720025391241776",
"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/8868289963323688304/+/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:4ed8143f82b7b310",
"user_agent:luci-scheduler"
],
"updated_ts": "1600944634968162",
"url": "https://ci.chromium.org/b/8868289963323688304",
"utcnow_ts": "1600944635516057"
}
}
[10:50:35.539] Invocation finished in 2h13m3.152490345s with status FAILED