[20:42:50.151] New invocation is queued and will start shortly
[20:42:51.445] Starting the invocation (attempt 1)
[20:42:51.483] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:42:51.483] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:42:51.483] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9086401828174319264",
"parameters_json": "{\"builder_name\":\"V8 Linux - full debug\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"72ce4de2c8bc7268421ada151afd51af022df47d\"}}",
"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:9086401828174319264",
"scheduler_job_id:v8/V8 Linux - full debug",
"user_agent:luci-scheduler",
"buildset:commit/git/72ce4de2c8bc7268421ada151afd51af022df47d",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/72ce4de2c8bc7268421ada151afd51af022df47d",
"gitiles_ref:refs/heads/master"
]
}
[20:42:52.638] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550695371593562",
"id": "8920971765995213232",
"lease_expiration_ts": "1550810572291057",
"lease_key": "681213260",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"72ce4de2c8bc7268421ada151afd51af022df47d\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1550695372464093",
"tags": [
"build_address:luci.v8.ci/V8 Linux - full debug/7230",
"builder:V8 Linux - full debug",
"buildset:commit/git/72ce4de2c8bc7268421ada151afd51af022df47d",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/72ce4de2c8bc7268421ada151afd51af022df47d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9086401828174319264",
"scheduler_job_id:v8/V8 Linux - full debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8920971765995213232/+/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:4325771cc75ba210",
"user_agent:luci-scheduler"
],
"updated_ts": "1550695372464219",
"url": "https://ci.chromium.org/b/8920971765995213232",
"utcnow_ts": "1550695372628352"
}
}
[20:42:52.638] Task URL: https://ci.chromium.org/b/8920971765995213232
[20:42:52.638] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:2:0) after 1m0s
[20:42:59.257] Received PubSub notification, asking Buildbucket for the build status
[20:42:59.304] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:52.669] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:2:0)
[20:43:52.669] Timer tick, asking Buildbucket for the build status
[20:43:52.855] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:52.855] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:4:0) after 1m0s
[20:44:52.959] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:4:0)
[20:44:52.959] Timer tick, asking Buildbucket for the build status
[20:44:53.083] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:53.083] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:5:0) after 1m0s
[20:45:53.106] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:5:0)
[20:45:53.106] Timer tick, asking Buildbucket for the build status
[20:45:53.320] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:53.320] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:6:0) after 1m0s
[20:46:53.337] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:6:0)
[20:46:53.337] Timer tick, asking Buildbucket for the build status
[20:46:53.402] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:53.403] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:7:0) after 1m0s
[20:47:53.419] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:7:0)
[20:47:53.419] Timer tick, asking Buildbucket for the build status
[20:47:53.495] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:53.495] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:8:0) after 1m0s
[20:48:53.513] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:8:0)
[20:48:53.513] Timer tick, asking Buildbucket for the build status
[20:48:53.585] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:53.585] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:9:0) after 1m0s
[20:49:53.605] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:9:0)
[20:49:53.605] Timer tick, asking Buildbucket for the build status
[20:49:53.664] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:53.664] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:10:0) after 1m0s
[20:50:53.684] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:10:0)
[20:50:53.684] Timer tick, asking Buildbucket for the build status
[20:50:53.928] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:53.928] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:11:0) after 1m0s
[20:51:53.943] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:11:0)
[20:51:53.943] Timer tick, asking Buildbucket for the build status
[20:51:54.162] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:54.162] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:12:0) after 1m0s
[20:52:54.181] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:12:0)
[20:52:54.181] Timer tick, asking Buildbucket for the build status
[20:52:54.287] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:54.287] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:13:0) after 1m0s
[20:53:54.307] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:13:0)
[20:53:54.307] Timer tick, asking Buildbucket for the build status
[20:53:54.348] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:54.348] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:14:0) after 1m0s
[20:54:54.371] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:14:0)
[20:54:54.371] Timer tick, asking Buildbucket for the build status
[20:54:54.417] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:54.417] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:15:0) after 1m0s
[20:55:54.440] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:15:0)
[20:55:54.440] Timer tick, asking Buildbucket for the build status
[20:55:54.585] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:54.585] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:16:0) after 1m0s
[20:56:54.610] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:16:0)
[20:56:54.610] Timer tick, asking Buildbucket for the build status
[20:56:54.663] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:54.664] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:17:0) after 1m0s
[20:57:54.682] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:17:0)
[20:57:54.682] Timer tick, asking Buildbucket for the build status
[20:57:54.800] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:54.800] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:18:0) after 1m0s
[20:58:54.818] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:18:0)
[20:58:54.818] Timer tick, asking Buildbucket for the build status
[20:58:54.872] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:54.872] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:19:0) after 1m0s
[20:59:54.890] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:19:0)
[20:59:54.890] Timer tick, asking Buildbucket for the build status
[20:59:54.934] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:54.934] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:20:0) after 1m0s
[21:00:54.951] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:20:0)
[21:00:54.951] Timer tick, asking Buildbucket for the build status
[21:00:54.993] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:54.993] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:21:0) after 1m0s
[21:01:55.019] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:21:0)
[21:01:55.019] Timer tick, asking Buildbucket for the build status
[21:01:55.182] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:55.182] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:22:0) after 1m0s
[21:02:55.201] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:22:0)
[21:02:55.201] Timer tick, asking Buildbucket for the build status
[21:02:55.472] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:55.472] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:23:0) after 1m0s
[21:03:55.494] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:23:0)
[21:03:55.494] Timer tick, asking Buildbucket for the build status
[21:03:55.542] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:55.542] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:24:0) after 1m0s
[21:04:55.561] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:24:0)
[21:04:55.561] Timer tick, asking Buildbucket for the build status
[21:04:55.785] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:55.785] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:25:0) after 1m0s
[21:05:55.993] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:25:0)
[21:05:55.993] Timer tick, asking Buildbucket for the build status
[21:05:56.068] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:56.068] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:26:0) after 1m0s
[21:06:56.098] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:26:0)
[21:06:56.099] Timer tick, asking Buildbucket for the build status
[21:06:56.172] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:56.172] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:27:0) after 1m0s
[21:07:56.204] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:27:0)
[21:07:56.204] Timer tick, asking Buildbucket for the build status
[21:07:56.259] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:56.260] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:28:0) after 1m0s
[21:08:56.280] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:28:0)
[21:08:56.280] Timer tick, asking Buildbucket for the build status
[21:08:56.325] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:56.326] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:29:0) after 1m0s
[21:09:56.372] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:29:0)
[21:09:56.372] Timer tick, asking Buildbucket for the build status
[21:09:56.465] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:56.465] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:30:0) after 1m0s
[21:10:56.491] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:30:0)
[21:10:56.491] Timer tick, asking Buildbucket for the build status
[21:10:56.554] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:56.554] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:31:0) after 1m0s
[21:11:56.592] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:31:0)
[21:11:56.592] Timer tick, asking Buildbucket for the build status
[21:11:56.635] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:56.635] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:32:0) after 1m0s
[21:12:56.662] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:32:0)
[21:12:56.662] Timer tick, asking Buildbucket for the build status
[21:12:56.895] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:56.895] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:33:0) after 1m0s
[21:13:56.932] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:33:0)
[21:13:56.932] Timer tick, asking Buildbucket for the build status
[21:13:56.983] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:56.983] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:34:0) after 1m0s
[21:14:57.001] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:34:0)
[21:14:57.001] Timer tick, asking Buildbucket for the build status
[21:14:57.066] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:57.066] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:35:0) after 1m0s
[21:15:57.086] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:35:0)
[21:15:57.086] Timer tick, asking Buildbucket for the build status
[21:15:57.286] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:57.287] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:36:0) after 1m0s
[21:16:57.302] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:36:0)
[21:16:57.302] Timer tick, asking Buildbucket for the build status
[21:16:57.385] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:57.385] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:37:0) after 1m0s
[21:17:57.429] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:37:0)
[21:17:57.429] Timer tick, asking Buildbucket for the build status
[21:17:57.473] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:57.473] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:38:0) after 1m0s
[21:18:57.495] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:38:0)
[21:18:57.495] Timer tick, asking Buildbucket for the build status
[21:18:57.590] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:57.590] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:39:0) after 1m0s
[21:19:57.614] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:39:0)
[21:19:57.614] Timer tick, asking Buildbucket for the build status
[21:19:57.714] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:57.714] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:40:0) after 1m0s
[21:20:57.738] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:40:0)
[21:20:57.738] Timer tick, asking Buildbucket for the build status
[21:20:57.871] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:57.871] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:41:0) after 1m0s
[21:21:57.894] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:41:0)
[21:21:57.894] Timer tick, asking Buildbucket for the build status
[21:21:57.961] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:57.961] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:42:0) after 1m0s
[21:22:57.979] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:42:0)
[21:22:57.979] Timer tick, asking Buildbucket for the build status
[21:22:58.024] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:58.024] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:43:0) after 1m0s
[21:23:58.053] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:43:0)
[21:23:58.053] Timer tick, asking Buildbucket for the build status
[21:23:58.107] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:58.107] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:44:0) after 1m0s
[21:24:58.128] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:44:0)
[21:24:58.128] Timer tick, asking Buildbucket for the build status
[21:24:58.187] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:58.187] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:45:0) after 1m0s
[21:25:58.209] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:45:0)
[21:25:58.209] Timer tick, asking Buildbucket for the build status
[21:25:58.250] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:58.251] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:46:0) after 1m0s
[21:26:58.261] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:46:0)
[21:26:58.261] Timer tick, asking Buildbucket for the build status
[21:26:58.329] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:58.329] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:47:0) after 1m0s
[21:27:58.363] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:47:0)
[21:27:58.363] Timer tick, asking Buildbucket for the build status
[21:27:58.479] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:58.479] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:48:0) after 1m0s
[21:28:58.498] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:48:0)
[21:28:58.498] Timer tick, asking Buildbucket for the build status
[21:28:58.665] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:58.665] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:49:0) after 1m0s
[21:29:58.685] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:49:0)
[21:29:58.685] Timer tick, asking Buildbucket for the build status
[21:29:58.762] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:58.762] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:50:0) after 1m0s
[21:30:58.790] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:50:0)
[21:30:58.790] Timer tick, asking Buildbucket for the build status
[21:30:58.974] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:58.974] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:51:0) after 1m0s
[21:31:58.993] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:51:0)
[21:31:58.993] Timer tick, asking Buildbucket for the build status
[21:31:59.042] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:59.042] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:52:0) after 1m0s
[21:32:59.065] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:52:0)
[21:32:59.065] Timer tick, asking Buildbucket for the build status
[21:32:59.117] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:59.117] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:53:0) after 1m0s
[21:33:59.134] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:53:0)
[21:33:59.134] Timer tick, asking Buildbucket for the build status
[21:33:59.180] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:59.180] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:54:0) after 1m0s
[21:34:59.198] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:54:0)
[21:34:59.198] Timer tick, asking Buildbucket for the build status
[21:34:59.320] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:59.320] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:55:0) after 1m0s
[21:35:59.353] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:55:0)
[21:35:59.353] Timer tick, asking Buildbucket for the build status
[21:35:59.585] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:59.585] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:56:0) after 1m0s
[21:36:59.605] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:56:0)
[21:36:59.605] Timer tick, asking Buildbucket for the build status
[21:36:59.684] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:59.684] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:57:0) after 1m0s
[21:37:59.705] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:57:0)
[21:37:59.705] Timer tick, asking Buildbucket for the build status
[21:37:59.751] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:59.751] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:58:0) after 1m0s
[21:38:59.771] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:58:0)
[21:38:59.771] Timer tick, asking Buildbucket for the build status
[21:38:59.824] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:59.824] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:59:0) after 1m0s
[21:39:59.847] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:59:0)
[21:39:59.847] Timer tick, asking Buildbucket for the build status
[21:39:59.901] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:59.902] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:60:0) after 1m0s
[21:40:59.934] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:60:0)
[21:40:59.934] Timer tick, asking Buildbucket for the build status
[21:40:59.987] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:59.987] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:61:0) after 1m0s
[21:42:00.056] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:61:0)
[21:42:00.056] Timer tick, asking Buildbucket for the build status
[21:42:00.232] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:00.232] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:62:0) after 1m0s
[21:43:00.264] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:62:0)
[21:43:00.264] Timer tick, asking Buildbucket for the build status
[21:43:00.336] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:00.336] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:63:0) after 1m0s
[21:44:00.353] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:63:0)
[21:44:00.353] Timer tick, asking Buildbucket for the build status
[21:44:00.704] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:00.704] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:64:0) after 1m0s
[21:45:00.726] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:64:0)
[21:45:00.726] Timer tick, asking Buildbucket for the build status
[21:45:00.851] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:00.851] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:65:0) after 1m0s
[21:46:00.929] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:65:0)
[21:46:00.929] Timer tick, asking Buildbucket for the build status
[21:46:01.022] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:01.022] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:66:0) after 1m0s
[21:47:01.072] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:66:0)
[21:47:01.072] Timer tick, asking Buildbucket for the build status
[21:47:01.371] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:01.371] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:67:0) after 1m0s
[21:48:01.392] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:67:0)
[21:48:01.392] Timer tick, asking Buildbucket for the build status
[21:48:01.444] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:01.444] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:68:0) after 1m0s
[21:49:01.518] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:68:0)
[21:49:01.518] Timer tick, asking Buildbucket for the build status
[21:49:01.784] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:01.784] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:69:0) after 1m0s
[21:50:01.813] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:69:0)
[21:50:01.813] Timer tick, asking Buildbucket for the build status
[21:50:01.886] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:01.886] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:70:0) after 1m0s
[21:51:01.906] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:70:0)
[21:51:01.906] Timer tick, asking Buildbucket for the build status
[21:51:01.960] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:01.960] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:71:0) after 1m0s
[21:52:01.980] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:71:0)
[21:52:01.980] Timer tick, asking Buildbucket for the build status
[21:52:02.060] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:02.060] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:72:0) after 1m0s
[21:53:02.090] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:72:0)
[21:53:02.090] Timer tick, asking Buildbucket for the build status
[21:53:02.143] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:02.143] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:73:0) after 1m0s
[21:54:02.163] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:73:0)
[21:54:02.164] Timer tick, asking Buildbucket for the build status
[21:54:02.280] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:02.280] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:74:0) after 1m0s
[21:55:02.297] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:74:0)
[21:55:02.297] Timer tick, asking Buildbucket for the build status
[21:55:02.343] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:02.343] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:75:0) after 1m0s
[21:56:02.365] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:75:0)
[21:56:02.365] Timer tick, asking Buildbucket for the build status
[21:56:03.295] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:03.295] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:76:0) after 1m0s
[21:57:03.388] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:76:0)
[21:57:03.388] Timer tick, asking Buildbucket for the build status
[21:57:03.498] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:03.498] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:77:0) after 1m0s
[21:58:03.525] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:77:0)
[21:58:03.525] Timer tick, asking Buildbucket for the build status
[21:58:03.773] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:03.773] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:78:0) after 1m0s
[21:59:03.788] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:78:0)
[21:59:03.788] Timer tick, asking Buildbucket for the build status
[21:59:03.932] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:03.932] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:79:0) after 1m0s
[22:00:03.961] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:79:0)
[22:00:03.961] Timer tick, asking Buildbucket for the build status
[22:00:04.024] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:04.024] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:80:0) after 1m0s
[22:01:04.059] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:80:0)
[22:01:04.059] Timer tick, asking Buildbucket for the build status
[22:01:04.147] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:04.147] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:81:0) after 1m0s
[22:02:04.170] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:81:0)
[22:02:04.170] Timer tick, asking Buildbucket for the build status
[22:02:04.223] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:04.223] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:82:0) after 1m0s
[22:03:04.251] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:82:0)
[22:03:04.251] Timer tick, asking Buildbucket for the build status
[22:03:04.430] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:04.430] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:83:0) after 1m0s
[22:04:04.489] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:83:0)
[22:04:04.489] Timer tick, asking Buildbucket for the build status
[22:04:04.596] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:04.596] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:84:0) after 1m0s
[22:05:04.615] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:84:0)
[22:05:04.615] Timer tick, asking Buildbucket for the build status
[22:05:04.784] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:04.784] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:85:0) after 1m0s
[22:06:04.892] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:85:0)
[22:06:04.892] Timer tick, asking Buildbucket for the build status
[22:06:04.960] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:04.960] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:86:0) after 1m0s
[22:07:04.988] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:86:0)
[22:07:04.988] Timer tick, asking Buildbucket for the build status
[22:07:05.053] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:05.053] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:87:0) after 1m0s
[22:08:05.076] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:87:0)
[22:08:05.076] Timer tick, asking Buildbucket for the build status
[22:08:05.137] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:05.137] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:88:0) after 1m0s
[22:09:05.159] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:88:0)
[22:09:05.159] Timer tick, asking Buildbucket for the build status
[22:09:05.216] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:05.216] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:89:0) after 1m0s
[22:10:05.242] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:89:0)
[22:10:05.242] Timer tick, asking Buildbucket for the build status
[22:10:05.290] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:05.290] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:90:0) after 1m0s
[22:11:05.309] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:90:0)
[22:11:05.309] Timer tick, asking Buildbucket for the build status
[22:11:05.366] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:05.366] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:91:0) after 1m0s
[22:12:05.387] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:91:0)
[22:12:05.387] Timer tick, asking Buildbucket for the build status
[22:12:05.525] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:05.525] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:92:0) after 1m0s
[22:13:05.551] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:92:0)
[22:13:05.551] Timer tick, asking Buildbucket for the build status
[22:13:05.598] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:05.598] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:93:0) after 1m0s
[22:14:05.618] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:93:0)
[22:14:05.618] Timer tick, asking Buildbucket for the build status
[22:14:05.666] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:05.666] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:94:0) after 1m0s
[22:15:05.698] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:94:0)
[22:15:05.699] Timer tick, asking Buildbucket for the build status
[22:15:05.876] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:05.876] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:95:0) after 1m0s
[22:16:05.901] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:95:0)
[22:16:05.901] Timer tick, asking Buildbucket for the build status
[22:16:05.975] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:05.975] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:96:0) after 1m0s
[22:17:06.009] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:96:0)
[22:17:06.009] Timer tick, asking Buildbucket for the build status
[22:17:06.079] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:06.079] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:97:0) after 1m0s
[22:18:06.170] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:97:0)
[22:18:06.170] Timer tick, asking Buildbucket for the build status
[22:18:06.426] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:06.426] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:98:0) after 1m0s
[22:19:06.451] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:98:0)
[22:19:06.451] Timer tick, asking Buildbucket for the build status
[22:19:06.528] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:06.528] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:99:0) after 1m0s
[22:20:06.568] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:99:0)
[22:20:06.568] Timer tick, asking Buildbucket for the build status
[22:20:06.826] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:06.826] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:100:0) after 1m0s
[22:21:06.875] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:100:0)
[22:21:06.875] Timer tick, asking Buildbucket for the build status
[22:21:06.923] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:06.923] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:101:0) after 1m0s
[22:22:06.994] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:101:0)
[22:22:06.994] Timer tick, asking Buildbucket for the build status
[22:22:07.056] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:07.056] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:102:0) after 1m0s
[22:23:07.078] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:102:0)
[22:23:07.078] Timer tick, asking Buildbucket for the build status
[22:23:07.165] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:07.165] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:103:0) after 1m0s
[22:24:07.195] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:103:0)
[22:24:07.195] Timer tick, asking Buildbucket for the build status
[22:24:07.304] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:07.304] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:104:0) after 1m0s
[22:25:07.324] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:104:0)
[22:25:07.324] Timer tick, asking Buildbucket for the build status
[22:25:07.452] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:07.452] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:105:0) after 1m0s
[22:26:07.474] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:105:0)
[22:26:07.474] Timer tick, asking Buildbucket for the build status
[22:26:07.582] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:07.582] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:106:0) after 1m0s
[22:27:07.618] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:106:0)
[22:27:07.619] Timer tick, asking Buildbucket for the build status
[22:27:07.721] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:07.721] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:107:0) after 1m0s
[22:28:07.745] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:107:0)
[22:28:07.745] Timer tick, asking Buildbucket for the build status
[22:28:07.807] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:07.807] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:108:0) after 1m0s
[22:29:07.839] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:108:0)
[22:29:07.839] Timer tick, asking Buildbucket for the build status
[22:29:07.887] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:07.887] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:109:0) after 1m0s
[22:30:07.914] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:109:0)
[22:30:07.914] Timer tick, asking Buildbucket for the build status
[22:30:08.011] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:08.011] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:110:0) after 1m0s
[22:31:08.043] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:110:0)
[22:31:08.043] Timer tick, asking Buildbucket for the build status
[22:31:08.168] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:08.168] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:111:0) after 1m0s
[22:32:08.187] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:111:0)
[22:32:08.187] Timer tick, asking Buildbucket for the build status
[22:32:08.264] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:08.264] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:112:0) after 1m0s
[22:33:08.290] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:112:0)
[22:33:08.290] Timer tick, asking Buildbucket for the build status
[22:33:08.338] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:08.338] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:113:0) after 1m0s
[22:34:08.374] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:113:0)
[22:34:08.374] Timer tick, asking Buildbucket for the build status
[22:34:08.492] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:08.492] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:114:0) after 1m0s
[22:35:08.535] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:114:0)
[22:35:08.535] Timer tick, asking Buildbucket for the build status
[22:35:08.609] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:08.609] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:115:0) after 1m0s
[22:36:08.632] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:115:0)
[22:36:08.632] Timer tick, asking Buildbucket for the build status
[22:36:08.685] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:08.685] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:116:0) after 1m0s
[22:37:08.707] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:116:0)
[22:37:08.707] Timer tick, asking Buildbucket for the build status
[22:37:08.769] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:08.769] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:117:0) after 1m0s
[22:38:08.790] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:117:0)
[22:38:08.790] Timer tick, asking Buildbucket for the build status
[22:38:08.879] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:08.879] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:118:0) after 1m0s
[22:39:08.901] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:118:0)
[22:39:08.901] Timer tick, asking Buildbucket for the build status
[22:39:08.951] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:08.951] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:119:0) after 1m0s
[22:40:08.970] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:119:0)
[22:40:08.970] Timer tick, asking Buildbucket for the build status
[22:40:09.117] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:09.117] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:120:0) after 1m0s
[22:41:09.138] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:120:0)
[22:41:09.138] Timer tick, asking Buildbucket for the build status
[22:41:09.199] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:09.199] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:121:0) after 1m0s
[22:42:09.224] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:121:0)
[22:42:09.224] Timer tick, asking Buildbucket for the build status
[22:42:09.269] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:09.269] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:122:0) after 1m0s
[22:43:09.339] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:122:0)
[22:43:09.339] Timer tick, asking Buildbucket for the build status
[22:43:09.386] Build 8920971765995213232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:09.386] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9086401828174319264:123:0) after 1m0s
[22:43:17.715] Received PubSub notification, asking Buildbucket for the build status
[22:43:17.780] Build 8920971765995213232: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[22:43:17.780] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "AUTO",
"completed_ts": "1550702596870099",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550695371593562",
"failure_reason": "INFRA_FAILURE",
"id": "8920971765995213232",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"72ce4de2c8bc7268421ada151afd51af022df47d\"}}",
"project": "v8",
"result": "FAILURE",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"kvm\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm340-c4\"], \"server_version\": [\"4113-bca9810\"], \"machine_type\": [\"n1-standard-8\"], \"cores\": [\"8\"], \"host_class\": [\"default\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"pool\": [\"luci.v8.ci\"], \"caches\": [\"builder_03c5ae9530a8ed30bd746307a05779781f04226079aeafcd655699f601e4ec9e_v2\", \"builder_059913401744bb04b4f0325f49d9f2b7fffd6203b60027586e7e300df69a48d5_v2\", \"builder_0756c5b6dc276f8ca56bf3d27eff9e06c4e026b9904c870a497a8be050bbc4b4_v2\", \"builder_169c96a1328ab0b6facbef10500ae2c5a77d97d149604a09a2662990a027f8ce_v2\", \"builder_1b6217a3dba1f84344d6eefd131be6928bfde80a0f048f8359f8129018fd93b8_v2\", \"builder_1d30c424b905a4fef536d86d86adfff78f7657c030268dee9960141e1ec68064_v2\", \"builder_243c519ad18ddadb640d67c9e88e83ca27856a2548a8449102db93c8491d5a95_v2\", \"builder_2726d3b90e16a89e027470678f1714430e2dcc5ad5b287d2d68d97fc2eb4d942_v2\", \"builder_328429ac2b059cadd72b2d5729fa2b546d8e5e8ba6c5c8bd87f1d2416689d5d0_v2\", \"builder_3ddc1e6738afb01c19c5328ebf3157ce1f828afa6f9bfedbccf804e743fd73fc_v2\", \"builder_3f9034e60101d3695fe7ca470f378cea7bcb75392ebaa67f43e146decc03c34e_v2\", \"builder_4180ee241bf03a2f704e3869d8835fa2524e2f45776cd7decb643e8031343e0b_v2\", \"builder_43d2cea24662dfaa1bc36ce0ffc85bf194801438bbf85827b525625396a6346b_v2\", \"builder_59f28fbb43ccf45a12913e9755409e0ed041b0f00bbe0d5138ca936d6d11aa7c_v2\", \"builder_5a7fdfafde4a1a2f1232842a5a22515ef4e41636739b1cabcddb933de133a078_v2\", \"builder_62a854bb7b06732d15f402ad8daff723e29e7ac573d17df256807040c71f83b5_v2\", \"builder_6505571aa603deb67a1fe1014af43647afd42d39e48a173373f63a67ae763ab5_v2\", \"builder_75302009cb925294b340c7c555d19b42cc3d2b4af3e9ba84dbd22091f62dad25_v2\", \"builder_75e3add2abe6a2d0e3baf7d0dacc3b41b5b2e41e4e17207fa2103c3729e02a5f_v2\", \"builder_7ed37cbd131243c1a1f9ef557da6ead56fcfb5fbc05dcfb4114927911952372f_v2\", \"builder_84671296ec1ed8a9c1442b402b2805dc5345a6d03ef5bd58708af00cb70779b0_v2\", \"builder_8c8bfe4a177720f3cdc3d8a926a6526529c5bc999e5099e1156d8ad583c8677f_v2\", \"builder_975f5f7789fb702942aa7d49b8b84183931fa374bd520566c5e8da1125ee2a4a_v2\", \"builder_9b159905eeffe713823eae1794f1c6f09950fc3f589ebba603593230892be49b_v2\", \"builder_a80f5e092292a0eeac8af219217427d7ea436f4845bc055ea4a436d664d3aaae_v2\", \"builder_b4460c21c18938b906540774294f2dad1256b696afaec8ed5adb05ffba120505_v2\", \"builder_b5e5b3d3bb687d4b556c08f6658c4c50b06d966106cf0f2f5001e38a1792d409_v2\", \"builder_bc06f376a31bd56bddce686d22f98836fdfbf781aebd6e27eae11a635b4049a0_v2\", \"builder_c368724c57ee8de9c84d58f8fbf12fe89fc00d271686ce269459495f29248893_v2\", \"builder_d8c99dfd56db853acad6eb761d453b584dd650d0aaf8755b052ff87f48c15591_v2\", \"builder_dcb42709b95abf4d2acc93ae93716b3a721915602d34902fe536fa7968576c06_v2\", \"builder_e1f9954f18035478cd49c9df666e20bb2aa8363b19b712d6e157a0dd73e51cdd_v2\", \"builder_ed1cd6acc6c7aa105be57112bbdc516c4c5cd063c5d11932f9754f1e51f57e18_v2\", \"builder_f172317607b2082a0053b1263df18c22c671af461f90153c66f037a4a3d0c4e7_v2\", \"builder_f8c6e0738d04370b798503576240475aa7ab65c495f5c7172f3c89f9749f4446_v2\", \"builder_f975c502a5d814331fe0a835ca896efa6b1b58304271166c3c331213b6d5e8e2_v2\", \"builder_fd5b6657f1d3a2f1a487e0b5530f22908da59be7cac27acc2fc249a9d5248335_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"buildnumber\": 7230, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"got_swarming_client_revision\": \"0e3e1c4dc4e79f25a5b58fcbc135dc93183c0c54\", \"got_revision\": \"72ce4de2c8bc7268421ada151afd51af022df47d\", \"buildername\": \"V8 Linux - full debug\", \"recipe\": \"v8\", \"mastername\": \"client.v8\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"isolate_server\": \"https://isolateserver.appspot.com\", \"got_revision_cp\": \"refs/heads/master@{#59746}\", \"$recipe_engine/buildbucket\": {\"build\": {\"tags\": [{\"key\": \"builder\", \"value\": \"V8 Linux - full debug\"}, {\"value\": \"commit/git/72ce4de2c8bc7268421ada151afd51af022df47d\", \"key\": \"buildset\"}, {\"key\": \"buildset\", \"value\": \"commit/gitiles/chromium.googlesource.com/v8/v8/+/72ce4de2c8bc7268421ada151afd51af022df47d\"}, {\"value\": \"9086401828174319264\", \"key\": \"scheduler_invocation_id\"}, {\"key\": \"scheduler_job_id\", \"value\": \"v8/V8 Linux - full debug\"}, {\"key\": \"user_agent\", \"value\": \"luci-scheduler\"}], \"builder\": {\"project\": \"v8\", \"builder\": \"V8 Linux - full debug\", \"bucket\": \"ci\"}, \"number\": 7230.0, \"createTime\": \"2019-02-20T20:42:51.593562Z\", \"infra\": {\"recipe\": {\"name\": \"v8\", \"cipdPackage\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}, \"swarming\": {\"hostname\": \"chromium-swarm.appspot.com\"}, \"buildbucket\": {\"serviceConfigRevision\": \"3dab7a70bce848a6486670afc32d65ade65b8058\"}}, \"createdBy\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"input\": {\"gitilesCommit\": {\"project\": \"v8/v8\", \"host\": \"chromium.googlesource.com\", \"ref\": \"refs/heads/master\", \"id\": \"72ce4de2c8bc7268421ada151afd51af022df47d\"}}, \"id\": \"8920971765995213232\"}}, \"build_config\": \"Debug\", \"path_config\": \"generic\", \"revision\": \"72ce4de2c8bc7268421ada151afd51af022df47d\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1550695371593562.0, \"tags\": [\"build_address:luci.v8.ci/V8 Linux - full debug/7230\", \"builder:V8 Linux - full debug\", \"buildset:commit/git/72ce4de2c8bc7268421ada151afd51af022df47d\", \"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/72ce4de2c8bc7268421ada151afd51af022df47d\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9086401828174319264\", \"scheduler_job_id:v8/V8 Linux - full debug\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.v8.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"v8\", \"id\": \"8920971765995213232\"}}, \"bot_id\": \"swarm340-c4\"}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1550695378548423",
"status": "COMPLETED",
"status_changed_ts": "1550702597278657",
"tags": [
"build_address:luci.v8.ci/V8 Linux - full debug/7230",
"builder:V8 Linux - full debug",
"buildset:commit/git/72ce4de2c8bc7268421ada151afd51af022df47d",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/72ce4de2c8bc7268421ada151afd51af022df47d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9086401828174319264",
"scheduler_job_id:v8/V8 Linux - full debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8920971765995213232/+/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:4325771cc75ba210",
"user_agent:luci-scheduler"
],
"updated_ts": "1550702597282739",
"url": "https://ci.chromium.org/b/8920971765995213232",
"utcnow_ts": "1550702597770028"
}
}
[22:43:17.780] Invocation finished in 2h0m27.649026104s with status FAILED