[11:20:16.291] New invocation is queued and will start shortly
[11:20:17.589] Starting the invocation (attempt 1)
[11:20:17.632] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:20:17.632] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:20:17.632] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9107274523929994032",
"parameters_json": "{\"builder_name\":\"V8 Linux - full debug\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"b2d211375ee67e4c5ae78027427b403d02af9480\"}}",
"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:9107274523929994032",
"scheduler_job_id:v8/V8 Linux - full debug",
"user_agent:luci-scheduler",
"buildset:commit/git/b2d211375ee67e4c5ae78027427b403d02af9480",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/b2d211375ee67e4c5ae78027427b403d02af9480",
"gitiles_ref:refs/heads/master"
]
}
[11:20:18.971] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1530789617706050",
"id": "8941844461782894400",
"lease_expiration_ts": "1530822018396870",
"lease_key": "772304306",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"b2d211375ee67e4c5ae78027427b403d02af9480\"}}",
"project": "v8",
"result_details_json": "null",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1530789618839770",
"tags": [
"build_address:luci.v8.ci/V8 Linux - full debug/4860",
"builder:V8 Linux - full debug",
"buildset:commit/git/b2d211375ee67e4c5ae78027427b403d02af9480",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/b2d211375ee67e4c5ae78027427b403d02af9480",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9107274523929994032",
"scheduler_job_id:v8/V8 Linux - full debug",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:host_class:default",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.v8.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.v8.ci/V8 Linux - full debug/4860",
"swarming_tag:buildbucket_bucket:luci.v8.ci",
"swarming_tag:buildbucket_build_id:8941844461782894400",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
"swarming_tag:builder:V8 Linux - full debug",
"swarming_tag:buildset:commit/git/b2d211375ee67e4c5ae78027427b403d02af9480",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/b2d211375ee67e4c5ae78027427b403d02af9480",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:host_class:default",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8941844461782894400/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.v8.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:v8",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9107274523929994032",
"swarming_tag:scheduler_job_id:v8/V8 Linux - full debug",
"swarming_tag:service_account:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:761be570b9ddc8b12cd9bf031b7ba136a1879f33",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e82fd69e3500810",
"user_agent:luci-scheduler"
],
"updated_ts": "1530789618839920",
"url": "https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 Linux - full debug/4860",
"utcnow_ts": "1530789618953350"
}
}
[11:20:18.971] Task URL: https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 Linux - full debug/4860
[11:20:18.971] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:2:0) after 1m0s
[11:21:18.990] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:2:0)
[11:21:18.990] Timer tick, asking Buildbucket for the build status
[11:21:19.050] Build 8941844461782894400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:21:19.050] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:3:0) after 1m0s
[11:22:19.067] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:3:0)
[11:22:19.067] Timer tick, asking Buildbucket for the build status
[11:22:19.166] Build 8941844461782894400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:22:19.166] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:4:0) after 1m0s
[11:22:45.833] Received PubSub notification, asking Buildbucket for the build status
[11:22:45.917] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:19.183] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:4:0)
[11:23:19.183] Timer tick, asking Buildbucket for the build status
[11:23:19.219] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:19.219] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:6:0) after 1m0s
[11:24:19.236] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:6:0)
[11:24:19.236] Timer tick, asking Buildbucket for the build status
[11:24:19.375] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:19.375] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:7:0) after 1m0s
[11:25:19.392] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:7:0)
[11:25:19.393] Timer tick, asking Buildbucket for the build status
[11:25:19.534] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:19.534] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:8:0) after 1m0s
[11:26:19.548] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:8:0)
[11:26:19.548] Timer tick, asking Buildbucket for the build status
[11:26:19.622] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:19.622] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:9:0) after 1m0s
[11:27:19.637] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:9:0)
[11:27:19.637] Timer tick, asking Buildbucket for the build status
[11:27:19.867] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:19.867] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:10:0) after 1m0s
[11:28:19.885] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:10:0)
[11:28:19.885] Timer tick, asking Buildbucket for the build status
[11:28:19.970] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:19.970] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:11:0) after 1m0s
[11:29:19.990] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:11:0)
[11:29:19.990] Timer tick, asking Buildbucket for the build status
[11:29:20.058] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:20.058] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:12:0) after 1m0s
[11:30:20.074] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:12:0)
[11:30:20.074] Timer tick, asking Buildbucket for the build status
[11:30:20.167] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:20.167] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:13:0) after 1m0s
[11:31:20.186] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:13:0)
[11:31:20.186] Timer tick, asking Buildbucket for the build status
[11:31:20.257] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:20.257] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:14:0) after 1m0s
[11:32:20.277] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:14:0)
[11:32:20.277] Timer tick, asking Buildbucket for the build status
[11:32:20.307] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:20.307] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:15:0) after 1m0s
[11:33:20.323] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:15:0)
[11:33:20.323] Timer tick, asking Buildbucket for the build status
[11:33:20.378] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:20.378] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:16:0) after 1m0s
[11:34:20.395] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:16:0)
[11:34:20.395] Timer tick, asking Buildbucket for the build status
[11:34:20.433] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:20.433] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:17:0) after 1m0s
[11:35:20.451] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:17:0)
[11:35:20.451] Timer tick, asking Buildbucket for the build status
[11:35:20.726] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:20.726] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:18:0) after 1m0s
[11:36:20.744] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:18:0)
[11:36:20.744] Timer tick, asking Buildbucket for the build status
[11:36:20.839] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:20.839] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:19:0) after 1m0s
[11:37:20.860] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:19:0)
[11:37:20.860] Timer tick, asking Buildbucket for the build status
[11:37:20.897] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:20.897] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:20:0) after 1m0s
[11:38:20.913] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:20:0)
[11:38:20.913] Timer tick, asking Buildbucket for the build status
[11:38:20.971] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:20.971] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:21:0) after 1m0s
[11:39:20.990] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:21:0)
[11:39:20.990] Timer tick, asking Buildbucket for the build status
[11:39:21.051] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:21.052] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:22:0) after 1m0s
[11:40:21.156] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:22:0)
[11:40:21.156] Timer tick, asking Buildbucket for the build status
[11:40:21.230] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:21.230] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:23:0) after 1m0s
[11:41:21.315] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:23:0)
[11:41:21.315] Timer tick, asking Buildbucket for the build status
[11:41:21.354] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:21.354] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:24:0) after 1m0s
[11:42:21.369] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:24:0)
[11:42:21.369] Timer tick, asking Buildbucket for the build status
[11:42:21.407] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:21.407] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:25:0) after 1m0s
[11:43:21.425] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:25:0)
[11:43:21.425] Timer tick, asking Buildbucket for the build status
[11:43:21.466] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:21.466] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:26:0) after 1m0s
[11:44:21.484] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:26:0)
[11:44:21.484] Timer tick, asking Buildbucket for the build status
[11:44:21.530] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:21.530] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:27:0) after 1m0s
[11:45:21.545] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:27:0)
[11:45:21.545] Timer tick, asking Buildbucket for the build status
[11:45:21.708] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:21.708] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:28:0) after 1m0s
[11:46:21.724] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:28:0)
[11:46:21.724] Timer tick, asking Buildbucket for the build status
[11:46:21.838] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:21.838] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:29:0) after 1m0s
[11:47:21.858] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:29:0)
[11:47:21.858] Timer tick, asking Buildbucket for the build status
[11:47:22.051] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:22.051] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:30:0) after 1m0s
[11:48:22.175] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:30:0)
[11:48:22.175] Timer tick, asking Buildbucket for the build status
[11:48:22.245] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:22.245] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:31:0) after 1m0s
[11:49:22.262] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:31:0)
[11:49:22.262] Timer tick, asking Buildbucket for the build status
[11:49:22.299] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:22.299] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:32:0) after 1m0s
[11:50:22.345] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:32:0)
[11:50:22.345] Timer tick, asking Buildbucket for the build status
[11:50:22.522] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:22.522] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:33:0) after 1m0s
[11:51:22.539] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:33:0)
[11:51:22.539] Timer tick, asking Buildbucket for the build status
[11:51:22.626] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:22.626] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:34:0) after 1m0s
[11:52:22.647] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:34:0)
[11:52:22.647] Timer tick, asking Buildbucket for the build status
[11:52:22.708] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:22.708] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:35:0) after 1m0s
[11:53:22.726] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:35:0)
[11:53:22.726] Timer tick, asking Buildbucket for the build status
[11:53:22.853] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:22.854] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:36:0) after 1m0s
[11:54:22.881] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:36:0)
[11:54:22.882] Timer tick, asking Buildbucket for the build status
[11:54:22.991] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:22.991] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:37:0) after 1m0s
[11:55:23.011] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:37:0)
[11:55:23.011] Timer tick, asking Buildbucket for the build status
[11:55:23.054] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:23.054] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:38:0) after 1m0s
[11:56:23.073] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:38:0)
[11:56:23.073] Timer tick, asking Buildbucket for the build status
[11:56:23.193] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:23.193] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:39:0) after 1m0s
[11:57:23.211] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:39:0)
[11:57:23.211] Timer tick, asking Buildbucket for the build status
[11:57:23.302] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:23.302] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:40:0) after 1m0s
[11:58:23.336] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:40:0)
[11:58:23.336] Timer tick, asking Buildbucket for the build status
[11:58:23.427] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:23.427] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:41:0) after 1m0s
[11:59:23.445] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:41:0)
[11:59:23.445] Timer tick, asking Buildbucket for the build status
[11:59:23.612] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:23.612] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:42:0) after 1m0s
[12:00:23.631] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:42:0)
[12:00:23.631] Timer tick, asking Buildbucket for the build status
[12:00:23.685] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:23.685] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:43:0) after 1m0s
[12:01:23.706] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:43:0)
[12:01:23.706] Timer tick, asking Buildbucket for the build status
[12:01:23.953] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:23.953] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:44:0) after 1m0s
[12:02:23.991] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:44:0)
[12:02:23.991] Timer tick, asking Buildbucket for the build status
[12:02:24.033] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:24.033] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:45:0) after 1m0s
[12:03:24.101] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:45:0)
[12:03:24.101] Timer tick, asking Buildbucket for the build status
[12:03:24.309] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:24.309] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:46:0) after 1m0s
[12:04:24.327] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:46:0)
[12:04:24.327] Timer tick, asking Buildbucket for the build status
[12:04:24.434] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:24.434] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:47:0) after 1m0s
[12:05:24.452] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:47:0)
[12:05:24.452] Timer tick, asking Buildbucket for the build status
[12:05:24.495] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:24.495] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:48:0) after 1m0s
[12:06:24.513] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:48:0)
[12:06:24.513] Timer tick, asking Buildbucket for the build status
[12:06:24.635] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:24.635] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:49:0) after 1m0s
[12:07:24.653] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:49:0)
[12:07:24.653] Timer tick, asking Buildbucket for the build status
[12:07:24.701] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:24.701] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:50:0) after 1m0s
[12:08:24.723] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:50:0)
[12:08:24.723] Timer tick, asking Buildbucket for the build status
[12:08:24.756] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:24.756] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:51:0) after 1m0s
[12:09:24.774] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:51:0)
[12:09:24.774] Timer tick, asking Buildbucket for the build status
[12:09:25.008] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:25.008] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:52:0) after 1m0s
[12:10:25.027] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:52:0)
[12:10:25.027] Timer tick, asking Buildbucket for the build status
[12:10:25.139] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:25.139] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:53:0) after 1m0s
[12:11:25.160] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:53:0)
[12:11:25.160] Timer tick, asking Buildbucket for the build status
[12:11:25.252] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:25.252] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:54:0) after 1m0s
[12:12:25.382] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:54:0)
[12:12:25.382] Timer tick, asking Buildbucket for the build status
[12:12:25.466] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:25.466] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:55:0) after 1m0s
[12:13:25.485] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:55:0)
[12:13:25.485] Timer tick, asking Buildbucket for the build status
[12:13:25.522] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:25.522] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:56:0) after 1m0s
[12:14:25.539] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:56:0)
[12:14:25.539] Timer tick, asking Buildbucket for the build status
[12:14:25.727] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:25.727] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:57:0) after 1m0s
[12:15:25.745] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:57:0)
[12:15:25.745] Timer tick, asking Buildbucket for the build status
[12:15:29.349] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:29.349] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:58:0) after 1m0s
[12:16:29.439] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:58:0)
[12:16:29.439] Timer tick, asking Buildbucket for the build status
[12:16:29.474] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:29.474] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:59:0) after 1m0s
[12:17:29.493] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:59:0)
[12:17:29.493] Timer tick, asking Buildbucket for the build status
[12:17:29.843] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:29.843] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:60:0) after 1m0s
[12:18:29.873] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:60:0)
[12:18:29.873] Timer tick, asking Buildbucket for the build status
[12:18:29.917] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:29.917] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:61:0) after 1m0s
[12:19:29.938] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:61:0)
[12:19:29.938] Timer tick, asking Buildbucket for the build status
[12:19:29.992] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:29.992] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:62:0) after 1m0s
[12:20:30.019] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:62:0)
[12:20:30.019] Timer tick, asking Buildbucket for the build status
[12:20:30.342] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:30.342] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:63:0) after 1m0s
[12:21:30.471] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:63:0)
[12:21:30.471] Timer tick, asking Buildbucket for the build status
[12:21:30.627] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:30.627] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:64:0) after 1m0s
[12:22:30.647] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:64:0)
[12:22:30.647] Timer tick, asking Buildbucket for the build status
[12:22:30.730] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:30.730] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:65:0) after 1m0s
[12:23:30.749] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:65:0)
[12:23:30.749] Timer tick, asking Buildbucket for the build status
[12:23:30.867] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:30.867] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:66:0) after 1m0s
[12:24:30.886] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:66:0)
[12:24:30.886] Timer tick, asking Buildbucket for the build status
[12:24:30.966] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:30.966] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:67:0) after 1m0s
[12:25:30.985] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:67:0)
[12:25:30.985] Timer tick, asking Buildbucket for the build status
[12:25:31.131] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:31.131] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:68:0) after 1m0s
[12:26:31.150] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:68:0)
[12:26:31.150] Timer tick, asking Buildbucket for the build status
[12:26:31.188] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:31.188] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:69:0) after 1m0s
[12:27:31.213] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:69:0)
[12:27:31.213] Timer tick, asking Buildbucket for the build status
[12:27:31.271] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:31.271] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:70:0) after 1m0s
[12:28:31.290] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:70:0)
[12:28:31.290] Timer tick, asking Buildbucket for the build status
[12:28:31.329] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:31.329] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:71:0) after 1m0s
[12:29:31.367] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:71:0)
[12:29:31.367] Timer tick, asking Buildbucket for the build status
[12:29:31.423] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:31.423] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:72:0) after 1m0s
[12:30:31.445] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:72:0)
[12:30:31.445] Timer tick, asking Buildbucket for the build status
[12:30:31.617] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:31.617] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:73:0) after 1m0s
[12:31:31.647] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:73:0)
[12:31:31.647] Timer tick, asking Buildbucket for the build status
[12:31:31.946] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:31.946] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:74:0) after 1m0s
[12:32:31.966] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:74:0)
[12:32:31.966] Timer tick, asking Buildbucket for the build status
[12:32:32.075] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:32.075] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:75:0) after 1m0s
[12:33:32.093] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:75:0)
[12:33:32.093] Timer tick, asking Buildbucket for the build status
[12:33:32.212] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:32.212] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:76:0) after 1m0s
[12:34:32.297] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:76:0)
[12:34:32.297] Timer tick, asking Buildbucket for the build status
[12:34:32.466] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:32.466] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:77:0) after 1m0s
[12:35:32.514] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:77:0)
[12:35:32.514] Timer tick, asking Buildbucket for the build status
[12:35:32.617] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:32.617] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:78:0) after 1m0s
[12:36:32.635] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:78:0)
[12:36:32.635] Timer tick, asking Buildbucket for the build status
[12:36:32.683] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:32.683] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:79:0) after 1m0s
[12:37:32.751] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:79:0)
[12:37:32.751] Timer tick, asking Buildbucket for the build status
[12:37:32.790] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:32.790] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:80:0) after 1m0s
[12:38:32.811] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:80:0)
[12:38:32.811] Timer tick, asking Buildbucket for the build status
[12:38:32.867] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:32.867] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:81:0) after 1m0s
[12:39:32.928] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:81:0)
[12:39:32.928] Timer tick, asking Buildbucket for the build status
[12:39:32.961] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:32.962] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:82:0) after 1m0s
[12:40:33.010] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:82:0)
[12:40:33.010] Timer tick, asking Buildbucket for the build status
[12:40:33.069] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:33.069] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:83:0) after 1m0s
[12:41:33.095] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:83:0)
[12:41:33.095] Timer tick, asking Buildbucket for the build status
[12:41:33.137] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:33.137] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:84:0) after 1m0s
[12:42:33.160] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:84:0)
[12:42:33.160] Timer tick, asking Buildbucket for the build status
[12:42:33.215] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:33.215] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:85:0) after 1m0s
[12:43:33.272] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:85:0)
[12:43:33.272] Timer tick, asking Buildbucket for the build status
[12:43:33.305] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:33.305] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:86:0) after 1m0s
[12:44:33.339] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:86:0)
[12:44:33.339] Timer tick, asking Buildbucket for the build status
[12:44:33.463] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:33.463] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:87:0) after 1m0s
[12:45:33.486] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:87:0)
[12:45:33.486] Timer tick, asking Buildbucket for the build status
[12:45:33.593] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:33.593] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:88:0) after 1m0s
[12:46:33.614] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:88:0)
[12:46:33.614] Timer tick, asking Buildbucket for the build status
[12:46:33.800] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:33.800] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:89:0) after 1m0s
[12:47:33.820] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:89:0)
[12:47:33.820] Timer tick, asking Buildbucket for the build status
[12:47:33.853] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:33.853] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:90:0) after 1m0s
[12:48:33.881] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:90:0)
[12:48:33.881] Timer tick, asking Buildbucket for the build status
[12:48:33.950] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:33.950] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:91:0) after 1m0s
[12:49:33.984] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:91:0)
[12:49:33.984] Timer tick, asking Buildbucket for the build status
[12:49:34.018] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:34.018] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:92:0) after 1m0s
[12:50:34.043] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:92:0)
[12:50:34.043] Timer tick, asking Buildbucket for the build status
[12:50:34.341] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:34.341] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:93:0) after 1m0s
[12:51:34.370] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:93:0)
[12:51:34.370] Timer tick, asking Buildbucket for the build status
[12:51:34.411] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:34.411] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:94:0) after 1m0s
[12:52:34.431] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:94:0)
[12:52:34.431] Timer tick, asking Buildbucket for the build status
[12:52:34.518] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:34.518] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:95:0) after 1m0s
[12:53:34.539] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:95:0)
[12:53:34.539] Timer tick, asking Buildbucket for the build status
[12:53:34.578] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:34.578] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:96:0) after 1m0s
[12:54:34.606] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:96:0)
[12:54:34.606] Timer tick, asking Buildbucket for the build status
[12:54:34.746] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:34.747] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:97:0) after 1m0s
[12:55:34.768] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:97:0)
[12:55:34.768] Timer tick, asking Buildbucket for the build status
[12:55:34.921] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:34.921] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:98:0) after 1m0s
[12:56:34.946] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:98:0)
[12:56:34.947] Timer tick, asking Buildbucket for the build status
[12:56:35.126] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:35.126] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:99:0) after 1m0s
[12:57:35.145] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:99:0)
[12:57:35.145] Timer tick, asking Buildbucket for the build status
[12:57:35.298] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:35.298] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:100:0) after 1m0s
[12:58:35.360] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:100:0)
[12:58:35.360] Timer tick, asking Buildbucket for the build status
[12:58:35.615] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:35.615] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:101:0) after 1m0s
[12:59:35.710] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:101:0)
[12:59:35.710] Timer tick, asking Buildbucket for the build status
[12:59:35.883] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:35.883] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:102:0) after 1m0s
[13:00:35.970] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:102:0)
[13:00:35.970] Timer tick, asking Buildbucket for the build status
[13:00:36.418] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:36.418] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:103:0) after 1m0s
[13:01:36.489] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:103:0)
[13:01:36.489] Timer tick, asking Buildbucket for the build status
[13:01:36.557] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:36.557] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:104:0) after 1m0s
[13:02:36.578] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:104:0)
[13:02:36.578] Timer tick, asking Buildbucket for the build status
[13:02:36.683] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:36.683] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:105:0) after 1m0s
[13:03:36.703] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:105:0)
[13:03:36.703] Timer tick, asking Buildbucket for the build status
[13:03:36.739] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:36.739] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:106:0) after 1m0s
[13:04:36.771] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:106:0)
[13:04:36.771] Timer tick, asking Buildbucket for the build status
[13:04:36.843] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:36.843] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:107:0) after 1m0s
[13:05:36.864] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:107:0)
[13:05:36.864] Timer tick, asking Buildbucket for the build status
[13:05:36.904] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:36.904] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:108:0) after 1m0s
[13:06:36.946] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:108:0)
[13:06:36.946] Timer tick, asking Buildbucket for the build status
[13:06:37.021] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:37.021] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:109:0) after 1m0s
[13:07:37.042] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:109:0)
[13:07:37.042] Timer tick, asking Buildbucket for the build status
[13:07:37.241] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:37.241] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:110:0) after 1m0s
[13:08:37.265] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:110:0)
[13:08:37.265] Timer tick, asking Buildbucket for the build status
[13:08:37.543] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:37.543] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:111:0) after 1m0s
[13:09:37.568] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:111:0)
[13:09:37.568] Timer tick, asking Buildbucket for the build status
[13:09:37.663] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:37.663] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:112:0) after 1m0s
[13:10:37.685] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:112:0)
[13:10:37.685] Timer tick, asking Buildbucket for the build status
[13:10:37.850] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:37.850] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:113:0) after 1m0s
[13:11:37.880] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:113:0)
[13:11:37.880] Timer tick, asking Buildbucket for the build status
[13:11:37.922] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:37.922] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:114:0) after 1m0s
[13:12:38.028] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:114:0)
[13:12:38.028] Timer tick, asking Buildbucket for the build status
[13:12:38.094] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:38.094] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:115:0) after 1m0s
[13:13:38.114] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:115:0)
[13:13:38.114] Timer tick, asking Buildbucket for the build status
[13:13:38.266] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:38.266] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:116:0) after 1m0s
[13:14:38.285] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:116:0)
[13:14:38.285] Timer tick, asking Buildbucket for the build status
[13:14:38.313] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:38.313] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:117:0) after 1m0s
[13:15:38.351] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:117:0)
[13:15:38.351] Timer tick, asking Buildbucket for the build status
[13:15:38.404] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:38.404] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:118:0) after 1m0s
[13:16:38.436] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:118:0)
[13:16:38.436] Timer tick, asking Buildbucket for the build status
[13:16:38.470] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:38.470] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:119:0) after 1m0s
[13:17:38.493] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:119:0)
[13:17:38.493] Timer tick, asking Buildbucket for the build status
[13:17:38.807] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:38.807] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:120:0) after 1m0s
[13:18:38.836] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:120:0)
[13:18:38.836] Timer tick, asking Buildbucket for the build status
[13:18:38.891] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:38.891] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:121:0) after 1m0s
[13:19:39.006] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:121:0)
[13:19:39.006] Timer tick, asking Buildbucket for the build status
[13:19:39.069] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:39.069] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:122:0) after 1m0s
[13:20:39.117] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:122:0)
[13:20:39.117] Timer tick, asking Buildbucket for the build status
[13:20:39.219] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:39.219] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:123:0) after 1m0s
[13:21:39.266] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:123:0)
[13:21:39.266] Timer tick, asking Buildbucket for the build status
[13:21:39.323] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:39.323] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:124:0) after 1m0s
[13:22:39.345] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:124:0)
[13:22:39.345] Timer tick, asking Buildbucket for the build status
[13:22:39.446] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:39.446] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:125:0) after 1m0s
[13:23:39.468] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:125:0)
[13:23:39.468] Timer tick, asking Buildbucket for the build status
[13:23:39.528] Build 8941844461782894400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:39.528] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107274523929994032:126:0) after 1m0s
[13:24:14.167] Received PubSub notification, asking Buildbucket for the build status
[13:24:14.203] Build 8941844461782894400: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[13:24:14.203] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "AUTO",
"completed_ts": "1530797051809220",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1530789617706050",
"failure_reason": "INFRA_FAILURE",
"id": "8941844461782894400",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"b2d211375ee67e4c5ae78027427b403d02af9480\"}}",
"project": "v8",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": {\"text\": \"kitchen crashed or got killed\", \"bootstrapperCallStack\": [], \"type\": \"BOOTSTRAPPER_ERROR\"}, \"recipeResult\": null, \"recipeExitCode\": null, \"recipe\": null, \"annotationUrl\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"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\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3675-21ffa58\"], \"machine_type\": [\"n1-standard-8\"], \"host_class\": [\"default\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"swarm344-c4\"], \"pool\": [\"luci.v8.ci\"], \"caches\": [\"builder_0d3f246d10cb46330191fca35d969255136e6047e1143766d300f136b362b785_v2\", \"builder_0d593ee5aa3cf9dabcc2383ca6866d4a1d75fbc9d5b6881380b2a0d6835e6902_v2\", \"builder_2f21895df9bc873580ae930152de1cb506fbe4d990f9f6e1a2c9716ae74f393b_v2\", \"builder_37cd46001166294fa2187097f5e27316d0a3aedc6cadc8641809f4a7f20ba893_v2\", \"builder_5065fb4b532a6ed5ac2f311fc138e13fc59f7cca7bad8bfbf884f97671212ccb_v2\", \"builder_5cd57ff09bc176c74999080dd249dfc5d651a5e179040f09fc9c0193bd8abf24_v2\", \"builder_5d785600393096d51dde3b33f72226925c85e34616ed52893b4a22f58cb62ffe_v2\", \"builder_762fc5caf6e589d23242c1f177533e856b5a225dc6e3f4747ed113ab3039b601_v2\", \"builder_78955e369eba41b6a3de99ca48d55d7116f6b0666a1b6b7539a4cd765288ceda_v2\", \"builder_825364b3d22fd72e64cc529ea04169d5b52547a634aae9944857084ec0a72d56_v2\", \"builder_84263641a01f2acc74af58d0b215a5f92709284d3a1fbbc17190bf41294861c5_v2\", \"builder_912922953e9db03a209b39fa4160850ba947765bc42561476ada7ded5270c7d4_v2\", \"builder_99713025433303b519468812972cb3051039eebe65d726417a2577dcb40aafc0_v2\", \"builder_9c514a0b24dc61db3bb3e2448a0b76e2c910d73814dcda449a1307918f7709c4_v2\", \"builder_a3d256aea25820692c751d41a83a0c63ef821e5449160c5829e19880fdb33445_v2\", \"builder_a8e098fc7a0bccbb4e4cd076d4f30e1e4c708aad5a6c7f7ad9ab46a69376587c_v2\", \"builder_abd5fc0df1a2b4811582d2f5c8e46b499d34b7e47e71450c63862d6ca6536ff3_v2\", \"builder_ad960b15a90962e52694b875d512c3db2015a7405c9ee457d20ee5d26470f5dc_v2\", \"builder_b23728735871e54308b3f36ea235b6a6f5c5e902d810ed4e93bc48a80096c140_v2\", \"builder_b3be2ddb8b3909c86eb2f2e351f8c9ee4bd1d62a664e9dfdfe991faa015f31f4_v2\", \"builder_bbf7d8c9645a5130bc0bf95ed2d2144340aedcb5d9c77e55885ef84b1bb499b8_v2\", \"builder_d08fad3df02a04e9ea1b124cb3e4cd9a49ba616b55f6e5d2fdacf76330bcef2a_v2\", \"builder_e68437fdb179fa80d04625a4d057e4631be49f278063fa762ab2eda2887336cf_v2\", \"builder_ea9251ddcec5763b81e0ba679247997722099f1d9a89e01bf81bf67c62173a40_v2\", \"builder_f0a022c5310063eef96c9e5181ecc7ab364e2841ec527f1932fd765b150ef87c_v2\", \"builder_f50a38a96ac302413037c2ca6414dfb93f641a01f22b2d3448985320d72a9bbb_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1530789764476090",
"status": "COMPLETED",
"status_changed_ts": "1530797053526190",
"tags": [
"build_address:luci.v8.ci/V8 Linux - full debug/4860",
"builder:V8 Linux - full debug",
"buildset:commit/git/b2d211375ee67e4c5ae78027427b403d02af9480",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/b2d211375ee67e4c5ae78027427b403d02af9480",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9107274523929994032",
"scheduler_job_id:v8/V8 Linux - full debug",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:host_class:default",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.v8.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.v8.ci/V8 Linux - full debug/4860",
"swarming_tag:buildbucket_bucket:luci.v8.ci",
"swarming_tag:buildbucket_build_id:8941844461782894400",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
"swarming_tag:builder:V8 Linux - full debug",
"swarming_tag:buildset:commit/git/b2d211375ee67e4c5ae78027427b403d02af9480",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/b2d211375ee67e4c5ae78027427b403d02af9480",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:host_class:default",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8941844461782894400/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.v8.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:v8",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9107274523929994032",
"swarming_tag:scheduler_job_id:v8/V8 Linux - full debug",
"swarming_tag:service_account:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:761be570b9ddc8b12cd9bf031b7ba136a1879f33",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e82fd69e3500810",
"user_agent:luci-scheduler"
],
"updated_ts": "1530797053527310",
"url": "https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 Linux - full debug/4860",
"utcnow_ts": "1530797054192440"
}
}
[13:24:14.203] Invocation finished in 2h3m57.927796439s with status FAILED