[05:49:07.595] New invocation is queued and will start shortly
[05:49:08.920] Starting the invocation (attempt 1)
[05:49:08.969] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:49:08.969] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:49:08.969] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9034727187686884128",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"29b1d668917eafc3c4f2f14081538457bf021edc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9034727187686884128",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/29b1d668917eafc3c4f2f14081538457bf021edc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29b1d668917eafc3c4f2f14081538457bf021edc",
"gitiles_ref:refs/heads/master"
]
}
[05:49:10.486] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1599976149075776",
"id": "8869297125466103104",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"29b1d668917eafc3c4f2f14081538457bf021edc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1599976150231369",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/23874",
"builder:Linux Viz",
"buildset:commit/git/29b1d668917eafc3c4f2f14081538457bf021edc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29b1d668917eafc3c4f2f14081538457bf021edc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034727187686884128",
"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/8869297125466103104/+/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": "1599976150231913",
"url": "https://ci.chromium.org/b/8869297125466103104",
"utcnow_ts": "1599976150469933"
}
}
[05:49:10.486] Task URL: https://ci.chromium.org/b/8869297125466103104
[05:49:10.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:2:0) after 1m0s
[05:50:10.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:2:0)
[05:50:10.570] Timer tick, asking Buildbucket for the build status
[05:50:10.900] Build 8869297125466103104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:50:10.900] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:3:0) after 1m0s
[05:51:11.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:3:0)
[05:51:11.025] Timer tick, asking Buildbucket for the build status
[05:51:11.213] Build 8869297125466103104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:51:11.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:4:0) after 1m0s
[05:52:11.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:4:0)
[05:52:11.287] Timer tick, asking Buildbucket for the build status
[05:52:11.357] Build 8869297125466103104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:11.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:5:0) after 1m0s
[05:53:11.385] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:5:0)
[05:53:11.385] Timer tick, asking Buildbucket for the build status
[05:53:11.455] Build 8869297125466103104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:11.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:6:0) after 1m0s
[05:54:11.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:6:0)
[05:54:11.509] Timer tick, asking Buildbucket for the build status
[05:54:11.592] Build 8869297125466103104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:11.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:7:0) after 1m0s
[05:54:54.792] Received PubSub notification, asking Buildbucket for the build status
[05:54:54.868] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:11.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:7:0)
[05:55:11.694] Timer tick, asking Buildbucket for the build status
[05:55:11.811] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:11.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:9:0) after 1m0s
[05:56:11.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:9:0)
[05:56:11.868] Timer tick, asking Buildbucket for the build status
[05:56:11.959] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:11.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:10:0) after 1m0s
[05:57:12.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:10:0)
[05:57:12.072] Timer tick, asking Buildbucket for the build status
[05:57:12.192] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:12.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:11:0) after 1m0s
[05:58:12.331] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:11:0)
[05:58:12.331] Timer tick, asking Buildbucket for the build status
[05:58:12.638] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:12.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:12:0) after 1m0s
[05:59:12.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:12:0)
[05:59:12.818] Timer tick, asking Buildbucket for the build status
[05:59:12.913] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:12.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:13:0) after 1m0s
[06:00:12.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:13:0)
[06:00:12.987] Timer tick, asking Buildbucket for the build status
[06:00:13.409] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:13.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:14:0) after 1m0s
[06:01:14.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:14:0)
[06:01:14.551] Timer tick, asking Buildbucket for the build status
[06:01:14.691] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:14.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:15:0) after 1m0s
[06:02:14.949] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:15:0)
[06:02:14.949] Timer tick, asking Buildbucket for the build status
[06:02:15.046] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:15.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:16:0) after 1m0s
[06:03:15.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:16:0)
[06:03:15.187] Timer tick, asking Buildbucket for the build status
[06:03:15.723] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:15.723] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:17:0) after 1m0s
[06:04:15.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:17:0)
[06:04:15.930] Timer tick, asking Buildbucket for the build status
[06:04:16.108] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:16.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:18:0) after 1m0s
[06:05:16.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:18:0)
[06:05:16.317] Timer tick, asking Buildbucket for the build status
[06:05:16.440] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:16.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:19:0) after 1m0s
[06:06:16.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:19:0)
[06:06:16.618] Timer tick, asking Buildbucket for the build status
[06:06:16.873] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:16.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:20:0) after 1m0s
[06:07:16.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:20:0)
[06:07:16.946] Timer tick, asking Buildbucket for the build status
[06:07:17.003] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:17.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:21:0) after 1m0s
[06:08:17.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:21:0)
[06:08:17.117] Timer tick, asking Buildbucket for the build status
[06:08:17.198] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:17.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:22:0) after 1m0s
[06:09:17.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:22:0)
[06:09:17.311] Timer tick, asking Buildbucket for the build status
[06:09:17.424] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:17.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:23:0) after 1m0s
[06:10:17.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:23:0)
[06:10:17.550] Timer tick, asking Buildbucket for the build status
[06:10:17.710] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:17.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:24:0) after 1m0s
[06:11:17.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:24:0)
[06:11:17.759] Timer tick, asking Buildbucket for the build status
[06:11:17.993] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:17.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:25:0) after 1m0s
[06:12:18.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:25:0)
[06:12:18.066] Timer tick, asking Buildbucket for the build status
[06:12:18.145] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:18.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:26:0) after 1m0s
[06:13:18.252] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:26:0)
[06:13:18.252] Timer tick, asking Buildbucket for the build status
[06:13:18.390] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:18.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:27:0) after 1m0s
[06:14:18.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:27:0)
[06:14:18.503] Timer tick, asking Buildbucket for the build status
[06:14:18.602] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:18.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:28:0) after 1m0s
[06:15:18.687] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:28:0)
[06:15:18.687] Timer tick, asking Buildbucket for the build status
[06:15:18.740] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:18.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:29:0) after 1m0s
[06:16:18.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:29:0)
[06:16:18.873] Timer tick, asking Buildbucket for the build status
[06:16:18.995] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:18.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:30:0) after 1m0s
[06:17:19.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:30:0)
[06:17:19.048] Timer tick, asking Buildbucket for the build status
[06:17:19.208] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:19.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:31:0) after 1m0s
[06:18:19.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:31:0)
[06:18:19.355] Timer tick, asking Buildbucket for the build status
[06:18:19.448] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:19.448] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:32:0) after 1m0s
[06:19:19.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:32:0)
[06:19:19.535] Timer tick, asking Buildbucket for the build status
[06:19:19.785] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:19.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:33:0) after 1m0s
[06:20:19.916] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:33:0)
[06:20:19.916] Timer tick, asking Buildbucket for the build status
[06:20:19.988] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:19.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:34:0) after 1m0s
[06:21:20.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:34:0)
[06:21:20.108] Timer tick, asking Buildbucket for the build status
[06:21:20.356] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:20.356] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:35:0) after 1m0s
[06:22:20.398] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:35:0)
[06:22:20.398] Timer tick, asking Buildbucket for the build status
[06:22:20.523] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:20.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:36:0) after 1m0s
[06:23:20.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:36:0)
[06:23:20.597] Timer tick, asking Buildbucket for the build status
[06:23:20.667] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:20.667] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:37:0) after 1m0s
[06:24:20.761] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:37:0)
[06:24:20.761] Timer tick, asking Buildbucket for the build status
[06:24:20.872] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:20.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:38:0) after 1m0s
[06:25:20.891] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:38:0)
[06:25:20.891] Timer tick, asking Buildbucket for the build status
[06:25:21.202] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:21.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:39:0) after 1m0s
[06:26:21.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:39:0)
[06:26:21.233] Timer tick, asking Buildbucket for the build status
[06:26:21.521] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:21.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:40:0) after 1m0s
[06:27:21.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:40:0)
[06:27:21.549] Timer tick, asking Buildbucket for the build status
[06:27:21.620] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:21.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:41:0) after 1m0s
[06:28:21.648] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:41:0)
[06:28:21.649] Timer tick, asking Buildbucket for the build status
[06:28:21.804] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:21.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:42:0) after 1m0s
[06:29:21.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:42:0)
[06:29:21.876] Timer tick, asking Buildbucket for the build status
[06:29:22.679] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:22.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:43:0) after 1m0s
[06:30:22.760] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:43:0)
[06:30:22.760] Timer tick, asking Buildbucket for the build status
[06:30:22.823] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:22.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:44:0) after 1m0s
[06:31:22.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:44:0)
[06:31:22.931] Timer tick, asking Buildbucket for the build status
[06:31:23.000] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:23.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:45:0) after 1m0s
[06:32:23.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:45:0)
[06:32:23.048] Timer tick, asking Buildbucket for the build status
[06:32:23.317] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:23.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:46:0) after 1m0s
[06:33:23.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:46:0)
[06:33:23.329] Timer tick, asking Buildbucket for the build status
[06:33:23.601] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:23.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:47:0) after 1m0s
[06:34:23.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:47:0)
[06:34:23.673] Timer tick, asking Buildbucket for the build status
[06:34:23.757] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:23.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:48:0) after 1m0s
[06:35:23.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:48:0)
[06:35:23.785] Timer tick, asking Buildbucket for the build status
[06:35:23.853] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:23.853] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:49:0) after 1m0s
[06:36:23.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:49:0)
[06:36:23.950] Timer tick, asking Buildbucket for the build status
[06:36:24.022] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:24.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:50:0) after 1m0s
[06:37:24.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:50:0)
[06:37:24.143] Timer tick, asking Buildbucket for the build status
[06:37:24.205] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:24.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:51:0) after 1m0s
[06:38:24.248] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:51:0)
[06:38:24.248] Timer tick, asking Buildbucket for the build status
[06:38:24.423] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:24.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:52:0) after 1m0s
[06:39:24.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:52:0)
[06:39:24.429] Timer tick, asking Buildbucket for the build status
[06:39:24.590] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:24.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:53:0) after 1m0s
[06:40:24.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:53:0)
[06:40:24.629] Timer tick, asking Buildbucket for the build status
[06:40:24.708] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:24.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:54:0) after 1m0s
[06:41:24.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:54:0)
[06:41:24.698] Timer tick, asking Buildbucket for the build status
[06:41:25.088] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:25.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:55:0) after 1m0s
[06:42:25.200] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:55:0)
[06:42:25.200] Timer tick, asking Buildbucket for the build status
[06:42:25.468] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:25.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:56:0) after 1m0s
[06:43:25.500] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:56:0)
[06:43:25.500] Timer tick, asking Buildbucket for the build status
[06:43:25.782] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:25.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:57:0) after 1m0s
[06:44:25.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:57:0)
[06:44:25.853] Timer tick, asking Buildbucket for the build status
[06:44:26.189] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:26.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:58:0) after 1m0s
[06:45:26.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:58:0)
[06:45:26.228] Timer tick, asking Buildbucket for the build status
[06:45:26.622] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:26.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:59:0) after 1m0s
[06:46:26.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:59:0)
[06:46:26.708] Timer tick, asking Buildbucket for the build status
[06:46:26.771] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:26.771] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:60:0) after 1m0s
[06:47:26.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:60:0)
[06:47:26.853] Timer tick, asking Buildbucket for the build status
[06:47:26.947] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:26.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:61:0) after 1m0s
[06:48:27.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:61:0)
[06:48:27.015] Timer tick, asking Buildbucket for the build status
[06:48:27.225] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:27.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:62:0) after 1m0s
[06:49:27.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:62:0)
[06:49:27.259] Timer tick, asking Buildbucket for the build status
[06:49:27.610] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:27.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:63:0) after 1m0s
[06:50:27.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:63:0)
[06:50:27.631] Timer tick, asking Buildbucket for the build status
[06:50:27.815] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:27.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:64:0) after 1m0s
[06:51:27.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:64:0)
[06:51:27.908] Timer tick, asking Buildbucket for the build status
[06:51:27.992] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:27.992] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:65:0) after 1m0s
[06:52:28.016] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:65:0)
[06:52:28.016] Timer tick, asking Buildbucket for the build status
[06:52:28.129] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:28.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:66:0) after 1m0s
[06:53:28.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:66:0)
[06:53:28.223] Timer tick, asking Buildbucket for the build status
[06:53:28.288] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:28.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:67:0) after 1m0s
[06:54:28.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:67:0)
[06:54:28.364] Timer tick, asking Buildbucket for the build status
[06:54:28.461] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:28.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:68:0) after 1m0s
[06:55:28.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:68:0)
[06:55:28.532] Timer tick, asking Buildbucket for the build status
[06:55:28.759] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:28.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:69:0) after 1m0s
[06:56:28.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:69:0)
[06:56:28.807] Timer tick, asking Buildbucket for the build status
[06:56:28.884] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:28.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:70:0) after 1m0s
[06:57:28.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:70:0)
[06:57:28.909] Timer tick, asking Buildbucket for the build status
[06:57:28.987] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:28.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:71:0) after 1m0s
[06:58:29.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:71:0)
[06:58:29.015] Timer tick, asking Buildbucket for the build status
[06:58:29.255] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:29.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:72:0) after 1m0s
[06:59:29.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:72:0)
[06:59:29.293] Timer tick, asking Buildbucket for the build status
[06:59:29.888] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:29.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:73:0) after 1m0s
[07:00:29.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:73:0)
[07:00:29.968] Timer tick, asking Buildbucket for the build status
[07:00:30.203] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:30.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:74:0) after 1m0s
[07:01:30.252] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:74:0)
[07:01:30.252] Timer tick, asking Buildbucket for the build status
[07:01:30.363] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:30.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:75:0) after 1m0s
[07:02:30.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:75:0)
[07:02:30.384] Timer tick, asking Buildbucket for the build status
[07:02:30.443] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:30.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:76:0) after 1m0s
[07:03:30.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:76:0)
[07:03:30.471] Timer tick, asking Buildbucket for the build status
[07:03:30.773] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:30.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:77:0) after 1m0s
[07:04:30.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:77:0)
[07:04:30.970] Timer tick, asking Buildbucket for the build status
[07:04:31.135] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:31.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:78:0) after 1m0s
[07:05:31.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:78:0)
[07:05:31.619] Timer tick, asking Buildbucket for the build status
[07:05:31.685] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:31.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:79:0) after 1m0s
[07:06:31.922] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:79:0)
[07:06:31.922] Timer tick, asking Buildbucket for the build status
[07:06:32.115] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:32.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:80:0) after 1m0s
[07:07:32.285] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:80:0)
[07:07:32.285] Timer tick, asking Buildbucket for the build status
[07:07:32.351] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:32.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:81:0) after 1m0s
[07:08:32.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:81:0)
[07:08:32.464] Timer tick, asking Buildbucket for the build status
[07:08:32.524] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:32.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:82:0) after 1m0s
[07:09:32.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:82:0)
[07:09:32.707] Timer tick, asking Buildbucket for the build status
[07:09:32.819] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:32.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:83:0) after 1m0s
[07:10:32.861] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:83:0)
[07:10:32.861] Timer tick, asking Buildbucket for the build status
[07:10:32.938] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:32.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:84:0) after 1m0s
[07:11:33.022] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:84:0)
[07:11:33.022] Timer tick, asking Buildbucket for the build status
[07:11:33.097] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:33.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:85:0) after 1m0s
[07:12:33.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:85:0)
[07:12:33.387] Timer tick, asking Buildbucket for the build status
[07:12:33.461] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:33.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:86:0) after 1m0s
[07:13:33.735] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:86:0)
[07:13:33.735] Timer tick, asking Buildbucket for the build status
[07:13:33.811] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:33.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:87:0) after 1m0s
[07:14:34.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:87:0)
[07:14:34.032] Timer tick, asking Buildbucket for the build status
[07:14:34.316] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:34.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:88:0) after 1m0s
[07:15:34.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:88:0)
[07:15:34.362] Timer tick, asking Buildbucket for the build status
[07:15:34.456] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:34.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:89:0) after 1m0s
[07:16:34.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:89:0)
[07:16:34.548] Timer tick, asking Buildbucket for the build status
[07:16:34.624] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:34.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:90:0) after 1m0s
[07:17:34.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:90:0)
[07:17:34.722] Timer tick, asking Buildbucket for the build status
[07:17:34.796] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:34.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:91:0) after 1m0s
[07:18:35.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:91:0)
[07:18:35.108] Timer tick, asking Buildbucket for the build status
[07:18:35.286] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:35.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:92:0) after 1m0s
[07:19:35.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:92:0)
[07:19:35.476] Timer tick, asking Buildbucket for the build status
[07:19:35.773] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:35.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:93:0) after 1m0s
[07:20:35.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:93:0)
[07:20:35.871] Timer tick, asking Buildbucket for the build status
[07:20:35.940] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:35.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:94:0) after 1m0s
[07:21:36.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:94:0)
[07:21:36.196] Timer tick, asking Buildbucket for the build status
[07:21:36.389] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:36.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:95:0) after 1m0s
[07:22:36.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:95:0)
[07:22:36.560] Timer tick, asking Buildbucket for the build status
[07:22:36.944] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:36.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:96:0) after 1m0s
[07:23:36.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:96:0)
[07:23:36.945] Timer tick, asking Buildbucket for the build status
[07:23:37.054] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:37.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:97:0) after 1m0s
[07:24:37.254] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:97:0)
[07:24:37.254] Timer tick, asking Buildbucket for the build status
[07:24:37.361] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:37.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:98:0) after 1m0s
[07:25:37.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:98:0)
[07:25:37.497] Timer tick, asking Buildbucket for the build status
[07:25:37.696] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:37.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:99:0) after 1m0s
[07:26:37.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:99:0)
[07:26:37.748] Timer tick, asking Buildbucket for the build status
[07:26:37.804] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:37.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:100:0) after 1m0s
[07:27:38.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:100:0)
[07:27:38.044] Timer tick, asking Buildbucket for the build status
[07:27:38.154] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:38.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:101:0) after 1m0s
[07:28:38.263] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:101:0)
[07:28:38.263] Timer tick, asking Buildbucket for the build status
[07:28:38.416] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:38.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:102:0) after 1m0s
[07:29:38.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:102:0)
[07:29:38.649] Timer tick, asking Buildbucket for the build status
[07:29:38.998] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:38.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:103:0) after 1m0s
[07:30:39.248] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:103:0)
[07:30:39.248] Timer tick, asking Buildbucket for the build status
[07:30:39.330] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:39.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:104:0) after 1m0s
[07:31:39.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:104:0)
[07:31:39.462] Timer tick, asking Buildbucket for the build status
[07:31:39.568] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:39.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:105:0) after 1m0s
[07:32:39.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:105:0)
[07:32:39.680] Timer tick, asking Buildbucket for the build status
[07:32:39.799] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:39.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:106:0) after 1m0s
[07:33:40.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:106:0)
[07:33:40.016] Timer tick, asking Buildbucket for the build status
[07:33:40.295] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:40.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:107:0) after 1m0s
[07:34:40.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:107:0)
[07:34:40.520] Timer tick, asking Buildbucket for the build status
[07:34:40.621] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:40.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:108:0) after 1m0s
[07:35:40.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:108:0)
[07:35:40.723] Timer tick, asking Buildbucket for the build status
[07:35:41.015] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:41.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:109:0) after 1m0s
[07:36:41.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:109:0)
[07:36:41.124] Timer tick, asking Buildbucket for the build status
[07:36:41.240] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:41.240] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:110:0) after 1m0s
[07:37:41.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:110:0)
[07:37:41.422] Timer tick, asking Buildbucket for the build status
[07:37:41.488] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:41.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:111:0) after 1m0s
[07:38:41.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:111:0)
[07:38:41.523] Timer tick, asking Buildbucket for the build status
[07:38:41.597] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:41.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:112:0) after 1m0s
[07:39:41.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:112:0)
[07:39:41.810] Timer tick, asking Buildbucket for the build status
[07:39:41.920] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:41.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:113:0) after 1m0s
[07:40:42.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:113:0)
[07:40:42.101] Timer tick, asking Buildbucket for the build status
[07:40:42.297] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:42.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:114:0) after 1m0s
[07:41:42.435] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:114:0)
[07:41:42.435] Timer tick, asking Buildbucket for the build status
[07:41:42.512] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:42.515] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:115:0) after 1m0s
[07:42:42.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:115:0)
[07:42:42.549] Timer tick, asking Buildbucket for the build status
[07:42:42.632] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:42.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:116:0) after 1m0s
[07:43:42.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:116:0)
[07:43:42.737] Timer tick, asking Buildbucket for the build status
[07:43:42.809] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:42.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:117:0) after 1m0s
[07:44:42.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:117:0)
[07:44:42.901] Timer tick, asking Buildbucket for the build status
[07:44:43.036] Build 8869297125466103104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:43.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034727187686884128:118:0) after 1m0s
[07:45:02.830] Received PubSub notification, asking Buildbucket for the build status
[07:45:02.893] Build 8869297125466103104: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[07:45:02.893] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1599983102461853",
"created_by": "project:chromium",
"created_ts": "1599976149075776",
"failure_reason": "BUILD_FAILURE",
"id": "8869297125466103104",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"29b1d668917eafc3c4f2f14081538457bf021edc\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**non_skia_renderer_browser_tests** failed because of:\\n\\n- DownloadWakeLockTest.WakeLockAcquireAndCancel\"}, \"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\": \"29b1d668917eafc3c4f2f14081538457bf021edc\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-52-emcm\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Linux Viz\", \"buildnumber\": 23874, \"got_angle_revision\": \"183a454b9d5474abb097da2c527805a9c7379a6c\", \"got_dawn_revision\": \"dbd34449af20f2d026b1e7f959073e254066ec83\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"29b1d668917eafc3c4f2f14081538457bf021edc\", \"got_revision_cp\": \"refs/heads/master@{#806481}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"41974f57973ebcdab4cfde6cc60354f6b79a5901\", \"got_v8_revision\": \"bb4817544d7ce327fc432a8229efa213952ca979\", \"got_v8_revision_cp\": \"refs/heads/8.7.76@{#1}\", \"got_webrtc_revision\": \"71d7c8e3cdd61b69d09fc392b93cc8c461168f0d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32091}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"29b1d668917eafc3c4f2f14081538457bf021edc\", \"swarm_hashes\": {\"blink_web_tests\": \"84423ec134d5320690619c3a6572d46384063f51\", \"browser_tests\": \"23196c885ea8eff9b993ad41409c4e5dc16bb080\", \"content_browsertests\": \"e24be39e4eaebdaca914e19effcf244b276e7996\"}, \"swarm_hashes_refs/heads/master(at){#806481}_without_patch\": {\"blink_web_tests\": \"84423ec134d5320690619c3a6572d46384063f51\", \"browser_tests\": \"23196c885ea8eff9b993ad41409c4e5dc16bb080\", \"content_browsertests\": \"e24be39e4eaebdaca914e19effcf244b276e7996\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_06bf165a3bf7a25e93955b74ebaf013d13a4a87ad7bcb716437f8a47afa74d09_v2\", \"builder_0b04f8cc6159258d804e25106396716d7d6fee48172e72693cbc82316c10e569_v2\", \"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_7701d7ffc8ab5fe38a709c77d4f18478e80f1a1d01dd8053f239f119334d81d1_v2\", \"builder_9abb531f9fa28fcfd3ce68b2370bf6d67201ddb083beddbd2671f7c5fe25be9e_v2\", \"builder_f11fafa89e130b21aaaf89babe10260b305cabf64cf9dbedf786af2782bba9d2_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-52-emcm\"], \"image\": [\"chrome-xenial-20090600-f98a2a06cf8\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5518-246c570\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**non_skia_renderer_browser_tests** failed because of:\\n\\n- DownloadWakeLockTest.WakeLockAcquireAndCancel\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1599976494055140",
"status": "COMPLETED",
"status_changed_ts": "1599976494522432",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/23874",
"builder:Linux Viz",
"buildset:commit/git/29b1d668917eafc3c4f2f14081538457bf021edc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29b1d668917eafc3c4f2f14081538457bf021edc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034727187686884128",
"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/8869297125466103104/+/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:4e9ed41e7ccb3610",
"user_agent:luci-scheduler"
],
"updated_ts": "1599983102603126",
"url": "https://ci.chromium.org/b/8869297125466103104",
"utcnow_ts": "1599983102886572"
}
}
[07:45:02.893] Invocation finished in 1h55m55.320350289s with status FAILED