[19:57:55.814] New invocation is queued and will start shortly
[19:57:57.034] Starting the invocation (attempt 1)
[19:57:57.071] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:57:57.071] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:57:57.071] Buildbucket request:
{
"bucket": "luci.v8.ci.br.beta",
"client_operation_id": "9018728719492140496",
"parameters_json": "{\"builder_name\":\"V8 Linux - full debug\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/branch-heads/9.0\",\"repo\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"589a00d352b91a3fa7c5b785fd389d8c05255f29\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/branch-heads/9.0@589a00d352b91a3fa7c5b785fd389d8c05255f29\",\"title\":\"589a00d352b91a3fa7c5b785fd389d8c05255f29\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/589a00d352b91a3fa7c5b785fd389d8c05255f29\"}]},\"branch\":\"refs/branch-heads/9.0\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"589a00d352b91a3fa7c5b785fd389d8c05255f29\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Linux - full debug",
"scheduler_invocation_id:9018728719492140496",
"scheduler_job_id:v8/ci.br.beta-V8 Linux - full debug",
"user_agent:luci-scheduler",
"buildset:commit/git/589a00d352b91a3fa7c5b785fd389d8c05255f29",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/589a00d352b91a3fa7c5b785fd389d8c05255f29",
"gitiles_ref:refs/branch-heads/9.0"
]
}
[19:57:57.759] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci.br.beta",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1615233477296387",
"id": "8853298657268771616",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/branch-heads/9.0\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"589a00d352b91a3fa7c5b785fd389d8c05255f29\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/branch-heads/9.0@589a00d352b91a3fa7c5b785fd389d8c05255f29\", \"title\": \"589a00d352b91a3fa7c5b785fd389d8c05255f29\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/589a00d352b91a3fa7c5b785fd389d8c05255f29\"}]}, \"branch\": \"refs/branch-heads/9.0\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"589a00d352b91a3fa7c5b785fd389d8c05255f29\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615233477671448",
"tags": [
"build_address:luci.v8.ci.br.beta/V8 Linux - full debug/177",
"builder:V8 Linux - full debug",
"buildset:commit/git/589a00d352b91a3fa7c5b785fd389d8c05255f29",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/589a00d352b91a3fa7c5b785fd389d8c05255f29",
"gitiles_ref:refs/branch-heads/9.0",
"scheduler_invocation_id:9018728719492140496",
"scheduler_job_id:v8/ci.br.beta-V8 Linux - full debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8853298657268771616/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:recipe_name:v8",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1615233477671594",
"url": "https://ci.chromium.org/b/8853298657268771616",
"utcnow_ts": "1615233477751980"
}
}
[19:57:57.759] Task URL: https://ci.chromium.org/b/8853298657268771616
[19:57:57.759] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:2:0) after 1m0s
[19:58:17.220] Received PubSub notification, asking Buildbucket for the build status
[19:58:17.281] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:57.777] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:2:0)
[19:58:57.777] Timer tick, asking Buildbucket for the build status
[19:58:57.863] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:57.863] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:4:0) after 1m0s
[19:59:57.942] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:4:0)
[19:59:57.942] Timer tick, asking Buildbucket for the build status
[19:59:58.154] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:58.155] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:5:0) after 1m0s
[20:00:58.298] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:5:0)
[20:00:58.298] Timer tick, asking Buildbucket for the build status
[20:00:58.973] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:58.973] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:6:0) after 1m0s
[20:01:59.142] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:6:0)
[20:01:59.142] Timer tick, asking Buildbucket for the build status
[20:01:59.200] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:59.200] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:7:0) after 1m0s
[20:02:59.285] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:7:0)
[20:02:59.285] Timer tick, asking Buildbucket for the build status
[20:02:59.521] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:59.521] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:8:0) after 1m0s
[20:03:59.562] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:8:0)
[20:03:59.562] Timer tick, asking Buildbucket for the build status
[20:03:59.640] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:59.640] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:9:0) after 1m0s
[20:04:59.668] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:9:0)
[20:04:59.668] Timer tick, asking Buildbucket for the build status
[20:04:59.848] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:59.848] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:10:0) after 1m0s
[20:05:59.890] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:10:0)
[20:05:59.890] Timer tick, asking Buildbucket for the build status
[20:05:59.987] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:59.987] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:11:0) after 1m0s
[20:06:59.973] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:11:0)
[20:06:59.973] Timer tick, asking Buildbucket for the build status
[20:07:00.143] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:00.143] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:12:0) after 1m0s
[20:08:00.166] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:12:0)
[20:08:00.166] Timer tick, asking Buildbucket for the build status
[20:08:00.236] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:00.236] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:13:0) after 1m0s
[20:09:00.272] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:13:0)
[20:09:00.272] Timer tick, asking Buildbucket for the build status
[20:09:01.039] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:01.039] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:14:0) after 1m0s
[20:10:01.055] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:14:0)
[20:10:01.055] Timer tick, asking Buildbucket for the build status
[20:10:03.528] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:03.528] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:15:0) after 1m0s
[20:11:03.771] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:15:0)
[20:11:03.771] Timer tick, asking Buildbucket for the build status
[20:11:04.543] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:04.543] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:16:0) after 1m0s
[20:12:04.715] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:16:0)
[20:12:04.715] Timer tick, asking Buildbucket for the build status
[20:12:04.792] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:04.792] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:17:0) after 1m0s
[20:13:04.868] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:17:0)
[20:13:04.868] Timer tick, asking Buildbucket for the build status
[20:13:04.939] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:04.939] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:18:0) after 1m0s
[20:14:05.092] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:18:0)
[20:14:05.092] Timer tick, asking Buildbucket for the build status
[20:14:05.597] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:05.597] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:19:0) after 1m0s
[20:15:05.614] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:19:0)
[20:15:05.614] Timer tick, asking Buildbucket for the build status
[20:15:05.937] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:05.937] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:20:0) after 1m0s
[20:16:05.966] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:20:0)
[20:16:05.966] Timer tick, asking Buildbucket for the build status
[20:16:07.953] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:07.953] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:21:0) after 1m0s
[20:17:08.153] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:21:0)
[20:17:08.153] Timer tick, asking Buildbucket for the build status
[20:17:08.229] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:08.229] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:22:0) after 1m0s
[20:18:08.309] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:22:0)
[20:18:08.310] Timer tick, asking Buildbucket for the build status
[20:18:08.416] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:08.416] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:23:0) after 1m0s
[20:19:08.412] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:23:0)
[20:19:08.412] Timer tick, asking Buildbucket for the build status
[20:19:08.545] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:08.545] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:24:0) after 1m0s
[20:20:08.555] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:24:0)
[20:20:08.556] Timer tick, asking Buildbucket for the build status
[20:20:08.627] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:08.627] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:25:0) after 1m0s
[20:21:08.645] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:25:0)
[20:21:08.645] Timer tick, asking Buildbucket for the build status
[20:21:08.762] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:08.762] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:26:0) after 1m0s
[20:22:08.912] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:26:0)
[20:22:08.912] Timer tick, asking Buildbucket for the build status
[20:22:09.095] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:09.095] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:27:0) after 1m0s
[20:23:09.186] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:27:0)
[20:23:09.186] Timer tick, asking Buildbucket for the build status
[20:23:09.277] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:09.278] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:28:0) after 1m0s
[20:24:09.347] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:28:0)
[20:24:09.347] Timer tick, asking Buildbucket for the build status
[20:24:09.429] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:09.429] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:29:0) after 1m0s
[20:25:09.465] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:29:0)
[20:25:09.465] Timer tick, asking Buildbucket for the build status
[20:25:09.550] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:09.550] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:30:0) after 1m0s
[20:26:09.538] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:30:0)
[20:26:09.538] Timer tick, asking Buildbucket for the build status
[20:26:09.609] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:09.609] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:31:0) after 1m0s
[20:27:09.713] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:31:0)
[20:27:09.713] Timer tick, asking Buildbucket for the build status
[20:27:10.706] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:10.707] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:32:0) after 1m0s
[20:28:10.739] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:32:0)
[20:28:10.739] Timer tick, asking Buildbucket for the build status
[20:28:10.943] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:10.943] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:33:0) after 1m0s
[20:29:10.969] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:33:0)
[20:29:10.969] Timer tick, asking Buildbucket for the build status
[20:29:11.031] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:11.031] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:34:0) after 1m0s
[20:30:11.110] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:34:0)
[20:30:11.110] Timer tick, asking Buildbucket for the build status
[20:30:11.181] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:11.181] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:35:0) after 1m0s
[20:31:11.202] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:35:0)
[20:31:11.202] Timer tick, asking Buildbucket for the build status
[20:31:11.476] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:11.476] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:36:0) after 1m0s
[20:32:11.490] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:36:0)
[20:32:11.490] Timer tick, asking Buildbucket for the build status
[20:32:11.819] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:11.819] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:37:0) after 1m0s
[20:33:11.985] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:37:0)
[20:33:11.985] Timer tick, asking Buildbucket for the build status
[20:33:12.090] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:12.090] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:38:0) after 1m0s
[20:34:12.129] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:38:0)
[20:34:12.129] Timer tick, asking Buildbucket for the build status
[20:34:12.201] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:12.201] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:39:0) after 1m0s
[20:35:12.418] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:39:0)
[20:35:12.419] Timer tick, asking Buildbucket for the build status
[20:35:13.568] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:13.568] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:40:0) after 1m0s
[20:36:13.630] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:40:0)
[20:36:13.630] Timer tick, asking Buildbucket for the build status
[20:36:13.719] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:13.719] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:41:0) after 1m0s
[20:37:13.794] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:41:0)
[20:37:13.794] Timer tick, asking Buildbucket for the build status
[20:37:13.964] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:13.964] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:42:0) after 1m0s
[20:38:14.057] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:42:0)
[20:38:14.057] Timer tick, asking Buildbucket for the build status
[20:38:14.310] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:14.310] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:43:0) after 1m0s
[20:39:14.428] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:43:0)
[20:39:14.428] Timer tick, asking Buildbucket for the build status
[20:39:14.499] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:14.499] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:44:0) after 1m0s
[20:40:14.832] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:44:0)
[20:40:14.832] Timer tick, asking Buildbucket for the build status
[20:40:15.181] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:15.181] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:45:0) after 1m0s
[20:41:15.243] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:45:0)
[20:41:15.243] Timer tick, asking Buildbucket for the build status
[20:41:15.297] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:15.297] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:46:0) after 1m0s
[20:42:15.316] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:46:0)
[20:42:15.316] Timer tick, asking Buildbucket for the build status
[20:42:15.446] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:15.446] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:47:0) after 1m0s
[20:43:15.455] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:47:0)
[20:43:15.455] Timer tick, asking Buildbucket for the build status
[20:43:15.710] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:15.710] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:48:0) after 1m0s
[20:44:15.753] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:48:0)
[20:44:15.753] Timer tick, asking Buildbucket for the build status
[20:44:15.857] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:15.857] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:49:0) after 1m0s
[20:45:15.880] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:49:0)
[20:45:15.880] Timer tick, asking Buildbucket for the build status
[20:45:15.968] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:15.968] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:50:0) after 1m0s
[20:46:16.003] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:50:0)
[20:46:16.003] Timer tick, asking Buildbucket for the build status
[20:46:16.268] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:16.268] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:51:0) after 1m0s
[20:47:16.363] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:51:0)
[20:47:16.363] Timer tick, asking Buildbucket for the build status
[20:47:18.022] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:18.022] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:52:0) after 1m0s
[20:48:18.116] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:52:0)
[20:48:18.116] Timer tick, asking Buildbucket for the build status
[20:48:18.210] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:18.210] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:53:0) after 1m0s
[20:49:18.221] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:53:0)
[20:49:18.221] Timer tick, asking Buildbucket for the build status
[20:49:19.951] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:19.951] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:54:0) after 1m0s
[20:50:20.230] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:54:0)
[20:50:20.230] Timer tick, asking Buildbucket for the build status
[20:50:20.379] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:20.379] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:55:0) after 1m0s
[20:51:20.417] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:55:0)
[20:51:20.417] Timer tick, asking Buildbucket for the build status
[20:51:20.480] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:20.480] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:56:0) after 1m0s
[20:52:20.512] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:56:0)
[20:52:20.512] Timer tick, asking Buildbucket for the build status
[20:52:20.656] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:20.656] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:57:0) after 1m0s
[20:53:20.725] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:57:0)
[20:53:20.725] Timer tick, asking Buildbucket for the build status
[20:53:20.826] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:20.826] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:58:0) after 1m0s
[20:54:20.841] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:58:0)
[20:54:20.842] Timer tick, asking Buildbucket for the build status
[20:54:20.914] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:20.914] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:59:0) after 1m0s
[20:55:20.920] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:59:0)
[20:55:20.920] Timer tick, asking Buildbucket for the build status
[20:55:24.164] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:24.164] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:60:0) after 1m0s
[20:56:24.237] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:60:0)
[20:56:24.237] Timer tick, asking Buildbucket for the build status
[20:56:24.315] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:24.315] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:61:0) after 1m0s
[20:57:24.425] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:61:0)
[20:57:24.425] Timer tick, asking Buildbucket for the build status
[20:57:24.505] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:24.505] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:62:0) after 1m0s
[20:58:24.614] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:62:0)
[20:58:24.614] Timer tick, asking Buildbucket for the build status
[20:58:24.783] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:24.783] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:63:0) after 1m0s
[20:59:24.880] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:63:0)
[20:59:24.880] Timer tick, asking Buildbucket for the build status
[20:59:24.985] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:24.985] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:64:0) after 1m0s
[21:00:25.120] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:64:0)
[21:00:25.120] Timer tick, asking Buildbucket for the build status
[21:00:25.201] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:25.201] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:65:0) after 1m0s
[21:01:25.309] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:65:0)
[21:01:25.309] Timer tick, asking Buildbucket for the build status
[21:01:25.378] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:25.378] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:66:0) after 1m0s
[21:02:25.430] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:66:0)
[21:02:25.430] Timer tick, asking Buildbucket for the build status
[21:02:25.610] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:25.611] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:67:0) after 1m0s
[21:03:25.638] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:67:0)
[21:03:25.638] Timer tick, asking Buildbucket for the build status
[21:03:25.760] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:25.760] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:68:0) after 1m0s
[21:04:25.783] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:68:0)
[21:04:25.783] Timer tick, asking Buildbucket for the build status
[21:04:25.923] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:25.923] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:69:0) after 1m0s
[21:05:25.968] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:69:0)
[21:05:25.968] Timer tick, asking Buildbucket for the build status
[21:05:26.098] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:26.098] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:70:0) after 1m0s
[21:06:26.144] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:70:0)
[21:06:26.144] Timer tick, asking Buildbucket for the build status
[21:06:26.227] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:26.227] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:71:0) after 1m0s
[21:07:26.222] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:71:0)
[21:07:26.222] Timer tick, asking Buildbucket for the build status
[21:07:26.284] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:26.284] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:72:0) after 1m0s
[21:08:26.308] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:72:0)
[21:08:26.308] Timer tick, asking Buildbucket for the build status
[21:08:28.026] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:28.026] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:73:0) after 1m0s
[21:09:28.126] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:73:0)
[21:09:28.126] Timer tick, asking Buildbucket for the build status
[21:09:28.440] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:28.440] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:74:0) after 1m0s
[21:10:28.550] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:74:0)
[21:10:28.550] Timer tick, asking Buildbucket for the build status
[21:10:33.106] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:33.106] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:75:0) after 1m0s
[21:11:33.146] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:75:0)
[21:11:33.146] Timer tick, asking Buildbucket for the build status
[21:11:33.211] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:33.211] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:76:0) after 1m0s
[21:12:33.242] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:76:0)
[21:12:33.242] Timer tick, asking Buildbucket for the build status
[21:12:33.311] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:33.311] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:77:0) after 1m0s
[21:13:33.378] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:77:0)
[21:13:33.378] Timer tick, asking Buildbucket for the build status
[21:13:33.440] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:33.440] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:78:0) after 1m0s
[21:14:33.445] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:78:0)
[21:14:33.445] Timer tick, asking Buildbucket for the build status
[21:14:33.560] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:33.560] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:79:0) after 1m0s
[21:15:33.569] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:79:0)
[21:15:33.569] Timer tick, asking Buildbucket for the build status
[21:15:33.700] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:33.700] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:80:0) after 1m0s
[21:16:33.798] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:80:0)
[21:16:33.798] Timer tick, asking Buildbucket for the build status
[21:16:33.893] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:33.893] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:81:0) after 1m0s
[21:17:33.893] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:81:0)
[21:17:33.893] Timer tick, asking Buildbucket for the build status
[21:17:33.969] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:33.969] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:82:0) after 1m0s
[21:18:34.049] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:82:0)
[21:18:34.049] Timer tick, asking Buildbucket for the build status
[21:18:34.232] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:34.232] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:83:0) after 1m0s
[21:19:34.314] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:83:0)
[21:19:34.314] Timer tick, asking Buildbucket for the build status
[21:19:34.496] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:34.496] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:84:0) after 1m0s
[21:20:34.683] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:84:0)
[21:20:34.683] Timer tick, asking Buildbucket for the build status
[21:20:34.811] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:34.811] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:85:0) after 1m0s
[21:21:34.971] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:85:0)
[21:21:34.971] Timer tick, asking Buildbucket for the build status
[21:21:35.056] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:35.056] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:86:0) after 1m0s
[21:22:35.664] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:86:0)
[21:22:35.664] Timer tick, asking Buildbucket for the build status
[21:22:35.770] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:35.770] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:87:0) after 1m0s
[21:23:35.825] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:87:0)
[21:23:35.825] Timer tick, asking Buildbucket for the build status
[21:23:35.988] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:35.988] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:88:0) after 1m0s
[21:24:36.055] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:88:0)
[21:24:36.055] Timer tick, asking Buildbucket for the build status
[21:24:36.133] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:36.133] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:89:0) after 1m0s
[21:25:36.193] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:89:0)
[21:25:36.193] Timer tick, asking Buildbucket for the build status
[21:25:36.258] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:36.258] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:90:0) after 1m0s
[21:26:36.346] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:90:0)
[21:26:36.346] Timer tick, asking Buildbucket for the build status
[21:26:36.438] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:36.438] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:91:0) after 1m0s
[21:27:36.534] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:91:0)
[21:27:36.534] Timer tick, asking Buildbucket for the build status
[21:27:36.643] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:36.643] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:92:0) after 1m0s
[21:28:36.792] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:92:0)
[21:28:36.792] Timer tick, asking Buildbucket for the build status
[21:28:36.862] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:36.862] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:93:0) after 1m0s
[21:29:37.120] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:93:0)
[21:29:37.120] Timer tick, asking Buildbucket for the build status
[21:29:37.429] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:37.429] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:94:0) after 1m0s
[21:30:37.447] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:94:0)
[21:30:37.447] Timer tick, asking Buildbucket for the build status
[21:30:37.520] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:37.520] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:95:0) after 1m0s
[21:31:37.577] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:95:0)
[21:31:37.577] Timer tick, asking Buildbucket for the build status
[21:31:37.671] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:37.671] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:96:0) after 1m0s
[21:32:37.690] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:96:0)
[21:32:37.690] Timer tick, asking Buildbucket for the build status
[21:32:37.863] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:37.863] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:97:0) after 1m0s
[21:33:37.903] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:97:0)
[21:33:37.903] Timer tick, asking Buildbucket for the build status
[21:33:38.018] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:38.018] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:98:0) after 1m0s
[21:34:38.039] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:98:0)
[21:34:38.039] Timer tick, asking Buildbucket for the build status
[21:34:38.132] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:38.132] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:99:0) after 1m0s
[21:35:38.715] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:99:0)
[21:35:38.715] Timer tick, asking Buildbucket for the build status
[21:35:38.828] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:38.828] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:100:0) after 1m0s
[21:36:38.944] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:100:0)
[21:36:38.944] Timer tick, asking Buildbucket for the build status
[21:36:39.220] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:39.220] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:101:0) after 1m0s
[21:37:39.298] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:101:0)
[21:37:39.298] Timer tick, asking Buildbucket for the build status
[21:37:39.418] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:39.418] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:102:0) after 1m0s
[21:38:39.557] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:102:0)
[21:38:39.557] Timer tick, asking Buildbucket for the build status
[21:38:39.955] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:39.955] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:103:0) after 1m0s
[21:39:39.967] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:103:0)
[21:39:39.967] Timer tick, asking Buildbucket for the build status
[21:39:40.086] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:40.086] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:104:0) after 1m0s
[21:40:40.088] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:104:0)
[21:40:40.088] Timer tick, asking Buildbucket for the build status
[21:40:40.190] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:40.190] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:105:0) after 1m0s
[21:41:40.236] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:105:0)
[21:41:40.236] Timer tick, asking Buildbucket for the build status
[21:41:40.311] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:40.311] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:106:0) after 1m0s
[21:42:40.375] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:106:0)
[21:42:40.375] Timer tick, asking Buildbucket for the build status
[21:42:40.441] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:40.441] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:107:0) after 1m0s
[21:43:40.739] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:107:0)
[21:43:40.739] Timer tick, asking Buildbucket for the build status
[21:43:41.129] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:41.129] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:108:0) after 1m0s
[21:44:41.359] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:108:0)
[21:44:41.359] Timer tick, asking Buildbucket for the build status
[21:44:41.435] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:41.435] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:109:0) after 1m0s
[21:45:41.590] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:109:0)
[21:45:41.590] Timer tick, asking Buildbucket for the build status
[21:45:42.944] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:42.945] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:110:0) after 1m0s
[21:46:43.015] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:110:0)
[21:46:43.015] Timer tick, asking Buildbucket for the build status
[21:46:43.841] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:43.841] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:111:0) after 1m0s
[21:47:44.063] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:111:0)
[21:47:44.063] Timer tick, asking Buildbucket for the build status
[21:47:44.168] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:44.168] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:112:0) after 1m0s
[21:48:44.457] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:112:0)
[21:48:44.457] Timer tick, asking Buildbucket for the build status
[21:48:45.213] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:45.213] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:113:0) after 1m0s
[21:49:45.231] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:113:0)
[21:49:45.232] Timer tick, asking Buildbucket for the build status
[21:49:45.322] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:45.322] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:114:0) after 1m0s
[21:50:45.370] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:114:0)
[21:50:45.370] Timer tick, asking Buildbucket for the build status
[21:50:45.455] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:45.455] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:115:0) after 1m0s
[21:51:45.552] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:115:0)
[21:51:45.552] Timer tick, asking Buildbucket for the build status
[21:51:45.641] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:45.641] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:116:0) after 1m0s
[21:52:45.736] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:116:0)
[21:52:45.736] Timer tick, asking Buildbucket for the build status
[21:52:46.158] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:46.158] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:117:0) after 1m0s
[21:53:46.316] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:117:0)
[21:53:46.316] Timer tick, asking Buildbucket for the build status
[21:53:46.404] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:46.404] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:118:0) after 1m0s
[21:54:46.398] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:118:0)
[21:54:46.398] Timer tick, asking Buildbucket for the build status
[21:54:46.482] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:46.482] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:119:0) after 1m0s
[21:55:46.477] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:119:0)
[21:55:46.477] Timer tick, asking Buildbucket for the build status
[21:55:46.616] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:46.616] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:120:0) after 1m0s
[21:56:46.634] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:120:0)
[21:56:46.634] Timer tick, asking Buildbucket for the build status
[21:56:46.833] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:46.833] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:121:0) after 1m0s
[21:57:46.881] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:121:0)
[21:57:46.881] Timer tick, asking Buildbucket for the build status
[21:57:47.122] Build 8853298657268771616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:47.122] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - full debug:9018728719492140496:122:0) after 1m0s
[21:58:37.621] Received PubSub notification, asking Buildbucket for the build status
[21:58:37.730] Build 8853298657268771616: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "TIMEOUT"
[21:58:37.730] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci.br.beta",
"canary_preference": "PROD",
"cancelation_reason": "TIMEOUT",
"completed_ts": "1615240717397346",
"created_by": "project:v8",
"created_ts": "1615233477296387",
"id": "8853298657268771616",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/branch-heads/9.0\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"589a00d352b91a3fa7c5b785fd389d8c05255f29\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/branch-heads/9.0@589a00d352b91a3fa7c5b785fd389d8c05255f29\", \"title\": \"589a00d352b91a3fa7c5b785fd389d8c05255f29\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/589a00d352b91a3fa7c5b785fd389d8c05255f29\"}]}, \"branch\": \"refs/branch-heads/9.0\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"589a00d352b91a3fa7c5b785fd389d8c05255f29\"}}",
"project": "v8",
"result": "CANCELED",
"result_details_json": "{\"error\": {\"message\": \"Uncaught Exception: AssertionError()\"}, \"properties\": {\"got_revision\": \"589a00d352b91a3fa7c5b785fd389d8c05255f29\", \"got_revision_cp\": \"refs/branch-heads/9.0@{#13}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"isolate_server\": \"https://isolateserver.appspot.com\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_109f6320a53de73e6a18123e59b9a5307478ec4c6452152f2a70a36c8ab67bf8_v2\", \"builder_243c519ad18ddadb640d67c9e88e83ca27856a2548a8449102db93c8491d5a95_v2\", \"builder_3ddc1e6738afb01c19c5328ebf3157ce1f828afa6f9bfedbccf804e743fd73fc_v2\", \"builder_3ea55f1fc4d84f334ff06f4145915181ecb188aaf4a0f3097433a510e03e9ee5_v2\", \"builder_6ca418e9970fe48f983c5180246a52a2117d4688d383d8c17f2d1635ea9cd1d6_v2\", \"builder_75e3add2abe6a2d0e3baf7d0dacc3b41b5b2e41e4e17207fa2103c3729e02a5f_v2\", \"builder_7ed37cbd131243c1a1f9ef557da6ead56fcfb5fbc05dcfb4114927911952372f_v2\", \"builder_c64f8bb326fc971a41dba811ce9a6d27a09b4f0e90271aa7edc5b608cb49c5b6_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-v8-ci-xenial-47-r02q\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.v8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5744-5c0a4b4\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"Uncaught Exception: AssertionError()\"}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615233495927771",
"status": "COMPLETED",
"status_changed_ts": "1615233496425487",
"tags": [
"build_address:luci.v8.ci.br.beta/V8 Linux - full debug/177",
"builder:V8 Linux - full debug",
"buildset:commit/git/589a00d352b91a3fa7c5b785fd389d8c05255f29",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/589a00d352b91a3fa7c5b785fd389d8c05255f29",
"gitiles_ref:refs/branch-heads/9.0",
"scheduler_invocation_id:9018728719492140496",
"scheduler_job_id:v8/ci.br.beta-V8 Linux - full debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8853298657268771616/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:v8",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:522c3c7555690810",
"user_agent:luci-scheduler"
],
"updated_ts": "1615240717397803",
"url": "https://ci.chromium.org/b/8853298657268771616",
"utcnow_ts": "1615240717720929"
}
}
[21:58:37.730] Invocation finished in 2h0m41.938509828s with status FAILED