[03:15:30.175] New invocation is queued and will start shortly
[03:15:31.338] Starting the invocation (attempt 1)
[03:15:31.378] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:15:31.378] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:15:31.378] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018519995858746912",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6ba01af36cd3c4c1b0d7ee65d621d237fdc89404\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9018519995858746912",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/6ba01af36cd3c4c1b0d7ee65d621d237fdc89404",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6ba01af36cd3c4c1b0d7ee65d621d237fdc89404",
"gitiles_ref:refs/heads/master"
]
}
[03:15:33.222] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615432531542858",
"id": "8853089933764436528",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6ba01af36cd3c4c1b0d7ee65d621d237fdc89404\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615432532037990",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/26746",
"builder:Linux Viz",
"buildset:commit/git/6ba01af36cd3c4c1b0d7ee65d621d237fdc89404",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6ba01af36cd3c4c1b0d7ee65d621d237fdc89404",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018519995858746912",
"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/8853089933764436528/+/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": "1615432532038104",
"url": "https://ci.chromium.org/b/8853089933764436528",
"utcnow_ts": "1615432533215372"
}
}
[03:15:33.222] Task URL: https://ci.chromium.org/b/8853089933764436528
[03:15:33.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:2:0) after 1m0s
[03:16:33.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:2:0)
[03:16:33.199] Timer tick, asking Buildbucket for the build status
[03:16:33.267] Build 8853089933764436528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:16:33.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:3:0) after 1m0s
[03:17:33.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:3:0)
[03:17:33.312] Timer tick, asking Buildbucket for the build status
[03:17:33.386] Build 8853089933764436528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:17:33.386] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:4:0) after 1m0s
[03:18:33.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:4:0)
[03:18:33.402] Timer tick, asking Buildbucket for the build status
[03:18:33.662] Build 8853089933764436528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:18:33.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:5:0) after 1m0s
[03:19:33.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:5:0)
[03:19:33.684] Timer tick, asking Buildbucket for the build status
[03:19:33.755] Build 8853089933764436528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:19:33.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:6:0) after 1m0s
[03:20:15.605] Received PubSub notification, asking Buildbucket for the build status
[03:20:15.852] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:33.783] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:6:0)
[03:20:33.783] Timer tick, asking Buildbucket for the build status
[03:20:33.850] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:33.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:8:0) after 1m0s
[03:21:33.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:8:0)
[03:21:33.859] Timer tick, asking Buildbucket for the build status
[03:21:33.988] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:33.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:9:0) after 1m0s
[03:22:34.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:9:0)
[03:22:34.113] Timer tick, asking Buildbucket for the build status
[03:22:34.608] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:34.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:10:0) after 1m0s
[03:23:34.653] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:10:0)
[03:23:34.653] Timer tick, asking Buildbucket for the build status
[03:23:34.731] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:34.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:11:0) after 1m0s
[03:24:34.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:11:0)
[03:24:34.753] Timer tick, asking Buildbucket for the build status
[03:24:34.937] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:34.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:12:0) after 1m0s
[03:25:35.301] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:12:0)
[03:25:35.301] Timer tick, asking Buildbucket for the build status
[03:25:35.526] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:35.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:13:0) after 1m0s
[03:26:35.636] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:13:0)
[03:26:35.636] Timer tick, asking Buildbucket for the build status
[03:26:35.943] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:35.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:14:0) after 1m0s
[03:27:36.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:14:0)
[03:27:36.018] Timer tick, asking Buildbucket for the build status
[03:27:36.142] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:36.142] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:15:0) after 1m0s
[03:28:36.206] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:15:0)
[03:28:36.206] Timer tick, asking Buildbucket for the build status
[03:28:36.500] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:36.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:16:0) after 1m0s
[03:29:36.611] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:16:0)
[03:29:36.611] Timer tick, asking Buildbucket for the build status
[03:29:36.752] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:36.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:17:0) after 1m0s
[03:30:36.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:17:0)
[03:30:36.824] Timer tick, asking Buildbucket for the build status
[03:30:36.932] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:36.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:18:0) after 1m0s
[03:31:37.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:18:0)
[03:31:37.011] Timer tick, asking Buildbucket for the build status
[03:31:37.097] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:37.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:19:0) after 1m0s
[03:32:37.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:19:0)
[03:32:37.138] Timer tick, asking Buildbucket for the build status
[03:32:37.218] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:37.218] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:20:0) after 1m0s
[03:33:37.290] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:20:0)
[03:33:37.290] Timer tick, asking Buildbucket for the build status
[03:33:37.451] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:37.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:21:0) after 1m0s
[03:34:37.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:21:0)
[03:34:37.575] Timer tick, asking Buildbucket for the build status
[03:34:37.643] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:37.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:22:0) after 1m0s
[03:35:37.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:22:0)
[03:35:37.929] Timer tick, asking Buildbucket for the build status
[03:35:38.018] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:38.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:23:0) after 1m0s
[03:36:38.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:23:0)
[03:36:38.068] Timer tick, asking Buildbucket for the build status
[03:36:38.150] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:38.150] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:24:0) after 1m0s
[03:37:38.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:24:0)
[03:37:38.212] Timer tick, asking Buildbucket for the build status
[03:37:38.611] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:38.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:25:0) after 1m0s
[03:38:38.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:25:0)
[03:38:38.627] Timer tick, asking Buildbucket for the build status
[03:38:38.766] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:38.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:26:0) after 1m0s
[03:39:38.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:26:0)
[03:39:38.843] Timer tick, asking Buildbucket for the build status
[03:39:39.901] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:39.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:27:0) after 1m0s
[03:40:40.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:27:0)
[03:40:40.015] Timer tick, asking Buildbucket for the build status
[03:40:40.233] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:40.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:28:0) after 1m0s
[03:41:40.282] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:28:0)
[03:41:40.282] Timer tick, asking Buildbucket for the build status
[03:41:40.633] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:40.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:29:0) after 1m0s
[03:42:41.817] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:29:0)
[03:42:41.817] Timer tick, asking Buildbucket for the build status
[03:42:42.055] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:42.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:30:0) after 1m0s
[03:43:42.191] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:30:0)
[03:43:42.191] Timer tick, asking Buildbucket for the build status
[03:43:42.254] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:42.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:31:0) after 1m0s
[03:44:42.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:31:0)
[03:44:42.294] Timer tick, asking Buildbucket for the build status
[03:44:42.357] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:42.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:32:0) after 1m0s
[03:45:42.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:32:0)
[03:45:42.395] Timer tick, asking Buildbucket for the build status
[03:45:42.555] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:42.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:33:0) after 1m0s
[03:46:42.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:33:0)
[03:46:42.622] Timer tick, asking Buildbucket for the build status
[03:46:42.739] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:42.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:34:0) after 1m0s
[03:47:42.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:34:0)
[03:47:42.775] Timer tick, asking Buildbucket for the build status
[03:47:42.838] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:42.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:35:0) after 1m0s
[03:48:43.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:35:0)
[03:48:43.064] Timer tick, asking Buildbucket for the build status
[03:48:43.324] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:43.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:36:0) after 1m0s
[03:49:43.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:36:0)
[03:49:43.424] Timer tick, asking Buildbucket for the build status
[03:49:43.510] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:43.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:37:0) after 1m0s
[03:50:43.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:37:0)
[03:50:43.606] Timer tick, asking Buildbucket for the build status
[03:50:43.843] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:43.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:38:0) after 1m0s
[03:51:43.936] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:38:0)
[03:51:43.936] Timer tick, asking Buildbucket for the build status
[03:51:44.018] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:44.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:39:0) after 1m0s
[03:52:44.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:39:0)
[03:52:44.001] Timer tick, asking Buildbucket for the build status
[03:52:44.117] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:44.117] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:40:0) after 1m0s
[03:53:44.156] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:40:0)
[03:53:44.156] Timer tick, asking Buildbucket for the build status
[03:53:44.268] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:44.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:41:0) after 1m0s
[03:54:44.360] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:41:0)
[03:54:44.360] Timer tick, asking Buildbucket for the build status
[03:54:44.541] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:44.541] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:42:0) after 1m0s
[03:55:44.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:42:0)
[03:55:44.529] Timer tick, asking Buildbucket for the build status
[03:55:44.693] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:44.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:43:0) after 1m0s
[03:56:44.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:43:0)
[03:56:44.727] Timer tick, asking Buildbucket for the build status
[03:56:44.837] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:44.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:44:0) after 1m0s
[03:57:44.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:44:0)
[03:57:44.940] Timer tick, asking Buildbucket for the build status
[03:57:45.011] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:45.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:45:0) after 1m0s
[03:58:45.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:45:0)
[03:58:45.028] Timer tick, asking Buildbucket for the build status
[03:58:45.101] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:45.101] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:46:0) after 1m0s
[03:59:45.119] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:46:0)
[03:59:45.119] Timer tick, asking Buildbucket for the build status
[03:59:45.442] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:45.442] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:47:0) after 1m0s
[04:00:45.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:47:0)
[04:00:45.511] Timer tick, asking Buildbucket for the build status
[04:00:45.659] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:45.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:48:0) after 1m0s
[04:01:45.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:48:0)
[04:01:45.716] Timer tick, asking Buildbucket for the build status
[04:01:45.895] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:45.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:49:0) after 1m0s
[04:02:45.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:49:0)
[04:02:45.990] Timer tick, asking Buildbucket for the build status
[04:02:46.057] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:46.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:50:0) after 1m0s
[04:03:46.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:50:0)
[04:03:46.154] Timer tick, asking Buildbucket for the build status
[04:03:46.224] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:46.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:51:0) after 1m0s
[04:04:46.297] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:51:0)
[04:04:46.297] Timer tick, asking Buildbucket for the build status
[04:04:46.363] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:46.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:52:0) after 1m0s
[04:05:46.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:52:0)
[04:05:46.400] Timer tick, asking Buildbucket for the build status
[04:05:46.579] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:46.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:53:0) after 1m0s
[04:06:46.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:53:0)
[04:06:46.629] Timer tick, asking Buildbucket for the build status
[04:06:46.835] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:46.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:54:0) after 1m0s
[04:07:46.858] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:54:0)
[04:07:46.858] Timer tick, asking Buildbucket for the build status
[04:07:46.937] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:46.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:55:0) after 1m0s
[04:08:46.988] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:55:0)
[04:08:46.988] Timer tick, asking Buildbucket for the build status
[04:08:47.308] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:47.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:56:0) after 1m0s
[04:09:47.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:56:0)
[04:09:47.333] Timer tick, asking Buildbucket for the build status
[04:09:47.401] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:47.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:57:0) after 1m0s
[04:10:47.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:57:0)
[04:10:47.458] Timer tick, asking Buildbucket for the build status
[04:10:47.567] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:47.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:58:0) after 1m0s
[04:11:47.605] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:58:0)
[04:11:47.605] Timer tick, asking Buildbucket for the build status
[04:11:47.675] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:47.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:59:0) after 1m0s
[04:12:47.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:59:0)
[04:12:47.694] Timer tick, asking Buildbucket for the build status
[04:12:47.764] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:47.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:60:0) after 1m0s
[04:13:47.812] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:60:0)
[04:13:47.812] Timer tick, asking Buildbucket for the build status
[04:13:47.892] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:47.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:61:0) after 1m0s
[04:14:47.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:61:0)
[04:14:47.962] Timer tick, asking Buildbucket for the build status
[04:14:48.223] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:48.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:62:0) after 1m0s
[04:15:48.544] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:62:0)
[04:15:48.544] Timer tick, asking Buildbucket for the build status
[04:15:48.722] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:48.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:63:0) after 1m0s
[04:16:48.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:63:0)
[04:16:48.799] Timer tick, asking Buildbucket for the build status
[04:16:48.865] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:48.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:64:0) after 1m0s
[04:17:48.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:64:0)
[04:17:48.847] Timer tick, asking Buildbucket for the build status
[04:17:49.237] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:49.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:65:0) after 1m0s
[04:18:49.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:65:0)
[04:18:49.261] Timer tick, asking Buildbucket for the build status
[04:18:49.360] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:49.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:66:0) after 1m0s
[04:19:49.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:66:0)
[04:19:49.461] Timer tick, asking Buildbucket for the build status
[04:19:49.704] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:49.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:67:0) after 1m0s
[04:20:49.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:67:0)
[04:20:49.790] Timer tick, asking Buildbucket for the build status
[04:20:49.865] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:49.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:68:0) after 1m0s
[04:21:50.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:68:0)
[04:21:50.724] Timer tick, asking Buildbucket for the build status
[04:21:50.804] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:50.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:69:0) after 1m0s
[04:22:51.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:69:0)
[04:22:51.136] Timer tick, asking Buildbucket for the build status
[04:22:51.249] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:51.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:70:0) after 1m0s
[04:23:51.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:70:0)
[04:23:51.428] Timer tick, asking Buildbucket for the build status
[04:23:51.487] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:51.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:71:0) after 1m0s
[04:24:51.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:71:0)
[04:24:51.776] Timer tick, asking Buildbucket for the build status
[04:24:52.134] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:52.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:72:0) after 1m0s
[04:25:52.240] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:72:0)
[04:25:52.240] Timer tick, asking Buildbucket for the build status
[04:25:52.336] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:52.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:73:0) after 1m0s
[04:26:52.419] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:73:0)
[04:26:52.419] Timer tick, asking Buildbucket for the build status
[04:26:52.496] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:52.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:74:0) after 1m0s
[04:27:52.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:74:0)
[04:27:52.483] Timer tick, asking Buildbucket for the build status
[04:27:52.822] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:52.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:75:0) after 1m0s
[04:28:52.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:75:0)
[04:28:52.912] Timer tick, asking Buildbucket for the build status
[04:28:53.002] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:53.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:76:0) after 1m0s
[04:29:53.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:76:0)
[04:29:53.039] Timer tick, asking Buildbucket for the build status
[04:29:53.154] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:53.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:77:0) after 1m0s
[04:30:53.175] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:77:0)
[04:30:53.175] Timer tick, asking Buildbucket for the build status
[04:30:53.263] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:53.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:78:0) after 1m0s
[04:31:54.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:78:0)
[04:31:54.161] Timer tick, asking Buildbucket for the build status
[04:31:54.225] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:54.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:79:0) after 1m0s
[04:32:54.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:79:0)
[04:32:54.374] Timer tick, asking Buildbucket for the build status
[04:32:54.449] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:54.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:80:0) after 1m0s
[04:33:54.567] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:80:0)
[04:33:54.567] Timer tick, asking Buildbucket for the build status
[04:33:54.730] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:54.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:81:0) after 1m0s
[04:34:54.891] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:81:0)
[04:34:54.891] Timer tick, asking Buildbucket for the build status
[04:34:54.956] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:54.956] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:82:0) after 1m0s
[04:35:55.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:82:0)
[04:35:55.006] Timer tick, asking Buildbucket for the build status
[04:35:55.089] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:55.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:83:0) after 1m0s
[04:36:55.218] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:83:0)
[04:36:55.218] Timer tick, asking Buildbucket for the build status
[04:36:55.282] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:55.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:84:0) after 1m0s
[04:37:55.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:84:0)
[04:37:55.307] Timer tick, asking Buildbucket for the build status
[04:37:55.391] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:55.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:85:0) after 1m0s
[04:38:55.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:85:0)
[04:38:55.474] Timer tick, asking Buildbucket for the build status
[04:38:55.573] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:55.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:86:0) after 1m0s
[04:39:55.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:86:0)
[04:39:55.684] Timer tick, asking Buildbucket for the build status
[04:39:56.018] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:56.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:87:0) after 1m0s
[04:40:56.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:87:0)
[04:40:56.129] Timer tick, asking Buildbucket for the build status
[04:40:56.567] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:56.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:88:0) after 1m0s
[04:41:56.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:88:0)
[04:41:56.624] Timer tick, asking Buildbucket for the build status
[04:41:56.725] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:56.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:89:0) after 1m0s
[04:42:56.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:89:0)
[04:42:56.756] Timer tick, asking Buildbucket for the build status
[04:42:56.846] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:56.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:90:0) after 1m0s
[04:43:56.862] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:90:0)
[04:43:56.862] Timer tick, asking Buildbucket for the build status
[04:43:56.927] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:56.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:91:0) after 1m0s
[04:44:56.957] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:91:0)
[04:44:56.957] Timer tick, asking Buildbucket for the build status
[04:44:57.208] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:57.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:92:0) after 1m0s
[04:45:57.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:92:0)
[04:45:57.205] Timer tick, asking Buildbucket for the build status
[04:45:57.303] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:57.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:93:0) after 1m0s
[04:46:57.358] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:93:0)
[04:46:57.358] Timer tick, asking Buildbucket for the build status
[04:46:57.439] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:57.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:94:0) after 1m0s
[04:47:57.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:94:0)
[04:47:57.463] Timer tick, asking Buildbucket for the build status
[04:47:57.640] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:57.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:95:0) after 1m0s
[04:48:57.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:95:0)
[04:48:57.628] Timer tick, asking Buildbucket for the build status
[04:48:57.682] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:57.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:96:0) after 1m0s
[04:49:57.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:96:0)
[04:49:57.760] Timer tick, asking Buildbucket for the build status
[04:49:58.031] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:58.031] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:97:0) after 1m0s
[04:50:58.140] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:97:0)
[04:50:58.140] Timer tick, asking Buildbucket for the build status
[04:50:58.273] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:58.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:98:0) after 1m0s
[04:51:58.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:98:0)
[04:51:58.352] Timer tick, asking Buildbucket for the build status
[04:51:58.431] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:58.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:99:0) after 1m0s
[04:52:58.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:99:0)
[04:52:58.514] Timer tick, asking Buildbucket for the build status
[04:52:58.655] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:58.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:100:0) after 1m0s
[04:53:58.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:100:0)
[04:53:58.732] Timer tick, asking Buildbucket for the build status
[04:53:58.845] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:58.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:101:0) after 1m0s
[04:54:58.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:101:0)
[04:54:58.924] Timer tick, asking Buildbucket for the build status
[04:54:59.009] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:59.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:102:0) after 1m0s
[04:55:59.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:102:0)
[04:55:59.166] Timer tick, asking Buildbucket for the build status
[04:55:59.329] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:59.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:103:0) after 1m0s
[04:56:59.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:103:0)
[04:56:59.368] Timer tick, asking Buildbucket for the build status
[04:56:59.429] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:59.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:104:0) after 1m0s
[04:57:59.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:104:0)
[04:57:59.450] Timer tick, asking Buildbucket for the build status
[04:57:59.556] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:59.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:105:0) after 1m0s
[04:58:59.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:105:0)
[04:58:59.630] Timer tick, asking Buildbucket for the build status
[04:58:59.703] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:59.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:106:0) after 1m0s
[04:59:59.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:106:0)
[04:59:59.717] Timer tick, asking Buildbucket for the build status
[05:00:00.126] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:00.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:107:0) after 1m0s
[05:01:00.200] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:107:0)
[05:01:00.200] Timer tick, asking Buildbucket for the build status
[05:01:00.361] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:00.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:108:0) after 1m0s
[05:02:00.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:108:0)
[05:02:00.498] Timer tick, asking Buildbucket for the build status
[05:02:00.582] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:00.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:109:0) after 1m0s
[05:03:00.605] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:109:0)
[05:03:00.605] Timer tick, asking Buildbucket for the build status
[05:03:00.808] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:00.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:110:0) after 1m0s
[05:04:00.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:110:0)
[05:04:00.881] Timer tick, asking Buildbucket for the build status
[05:04:01.130] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:01.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:111:0) after 1m0s
[05:05:01.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:111:0)
[05:05:01.142] Timer tick, asking Buildbucket for the build status
[05:05:01.219] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:01.219] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:112:0) after 1m0s
[05:06:01.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:112:0)
[05:06:01.267] Timer tick, asking Buildbucket for the build status
[05:06:01.731] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:01.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:113:0) after 1m0s
[05:07:01.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:113:0)
[05:07:01.837] Timer tick, asking Buildbucket for the build status
[05:07:02.152] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:02.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:114:0) after 1m0s
[05:08:02.190] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:114:0)
[05:08:02.190] Timer tick, asking Buildbucket for the build status
[05:08:02.252] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:02.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:115:0) after 1m0s
[05:09:02.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:115:0)
[05:09:02.276] Timer tick, asking Buildbucket for the build status
[05:09:02.406] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:02.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:116:0) after 1m0s
[05:10:02.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:116:0)
[05:10:02.437] Timer tick, asking Buildbucket for the build status
[05:10:02.508] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:02.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:117:0) after 1m0s
[05:11:02.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:117:0)
[05:11:02.549] Timer tick, asking Buildbucket for the build status
[05:11:02.820] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:02.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:118:0) after 1m0s
[05:12:02.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:118:0)
[05:12:02.839] Timer tick, asking Buildbucket for the build status
[05:12:02.938] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:02.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:119:0) after 1m0s
[05:13:02.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:119:0)
[05:13:02.963] Timer tick, asking Buildbucket for the build status
[05:13:03.046] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:03.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:120:0) after 1m0s
[05:14:03.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:120:0)
[05:14:03.078] Timer tick, asking Buildbucket for the build status
[05:14:03.168] Build 8853089933764436528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:03.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9018519995858746912:121:0) after 1m0s
[05:14:41.288] Received PubSub notification, asking Buildbucket for the build status
[05:14:41.388] Build 8853089933764436528: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:14:41.388] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615439680898902",
"created_by": "project:chromium",
"created_ts": "1615432531542858",
"failure_reason": "BUILD_FAILURE",
"id": "8853089933764436528",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6ba01af36cd3c4c1b0d7ee65d621d237fdc89404\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**vulkan_swiftshader_blink_web_tests** failed because of:\\n\\n- images/huge-image-viewport-scale.html\"}, \"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\": \"6ba01af36cd3c4c1b0d7ee65d621d237fdc89404\", \"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-123-p6f6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Linux Viz\", \"buildnumber\": 26746, \"got_angle_revision\": \"44b9579cf7b8d35cac13f9e2d70c57791ddfd0e2\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"6ba01af36cd3c4c1b0d7ee65d621d237fdc89404\", \"got_revision_cp\": \"refs/heads/master@{#861828}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a2fe8e1b2111e69d8846991f9d9bcc5c49505d1c\", \"got_v8_revision\": \"51b8f6321255d70ddd5cf15fba0429ec537c39ec\", \"got_v8_revision_cp\": \"refs/heads/9.1.97@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": false, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-viz-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6ba01af36cd3c4c1b0d7ee65d621d237fdc89404\", \"swarm_hashes_refs/heads/master(at){#861828}_without_patch\": {\"blink_web_tests\": \"97e3662b1e28fb5af945886eaf56abcd5a15a176\", \"browser_tests\": \"c47de0683d4207873e46cd6b7984882cfd18ef68\", \"content_browsertests\": \"6243da01cdfa23660f93268fa04bc3af869478cb\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_158d0f10fa5d87b7b90de0551ce233e88e46559602c021beec49ce89728c3318_v2\", \"builder_4051ab4278f6ca75915d3c38e2bb35c4a0543f27c6cfbc0a6a6d184f05d219d0_v2\", \"builder_4a782824ba39c0c6a32b2128ebb0687e83cb58dc0cbed64e2911b02f7893cfe6_v2\", \"builder_5f931a5519f78feef046af549827aa56dc2e9b17853b60b3d0ae8ebd533780ee_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_v2\", \"builder_abe2adbd32ad911c3e8d1f384e915329cf1f65e427edb6b91a9fbb61a55ed743_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_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-123-p6f6\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**vulkan_swiftshader_blink_web_tests** failed because of:\\n\\n- images/huge-image-viewport-scale.html\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615432814717538",
"status": "COMPLETED",
"status_changed_ts": "1615432815213552",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/26746",
"builder:Linux Viz",
"buildset:commit/git/6ba01af36cd3c4c1b0d7ee65d621d237fdc89404",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6ba01af36cd3c4c1b0d7ee65d621d237fdc89404",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018519995858746912",
"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/8853089933764436528/+/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:523819db4271f910",
"user_agent:luci-scheduler"
],
"updated_ts": "1615439680899249",
"url": "https://ci.chromium.org/b/8853089933764436528",
"utcnow_ts": "1615439681351944"
}
}
[05:14:41.388] Invocation finished in 1h59m11.227334533s with status FAILED