[08:03:46.238] New invocation is queued and will start shortly
[08:03:47.628] Starting the invocation (attempt 1)
[08:03:47.665] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:03:47.665] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:03:47.665] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9107921065525050912",
"parameters_json": "{\"builder_name\":\"V8 Linux - full debug\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"5b7262870994ed883ec07a0b68ff741b30584180\"}}",
"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:9107921065525050912",
"scheduler_job_id:v8/V8 Linux - full debug",
"user_agent:luci-scheduler",
"buildset:commit/git/5b7262870994ed883ec07a0b68ff741b30584180",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/5b7262870994ed883ec07a0b68ff741b30584180",
"gitiles_ref:refs/heads/master"
]
}
[08:03:49.125] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1530173027733627",
"id": "8942491003230469328",
"lease_expiration_ts": "1530205428635328",
"lease_key": "83767636",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"5b7262870994ed883ec07a0b68ff741b30584180\"}}",
"project": "v8",
"result_details_json": "null",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1530173029006577",
"tags": [
"build_address:luci.v8.ci/V8 Linux - full debug/4804",
"builder:V8 Linux - full debug",
"buildset:commit/git/5b7262870994ed883ec07a0b68ff741b30584180",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/5b7262870994ed883ec07a0b68ff741b30584180",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9107921065525050912",
"scheduler_job_id:v8/V8 Linux - full debug",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:multibot:0",
"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/4804",
"swarming_tag:buildbucket_bucket:luci.v8.ci",
"swarming_tag:buildbucket_build_id:8942491003230469328",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:333db54570a89c15ad8da08696be059fc5ece41a",
"swarming_tag:builder:V8 Linux - full debug",
"swarming_tag:buildset:commit/git/5b7262870994ed883ec07a0b68ff741b30584180",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/5b7262870994ed883ec07a0b68ff741b30584180",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8942491003230469328/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:multibot:0",
"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:9107921065525050912",
"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:8a4c808613839e717254e3b5b02ccb035adc8f73",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e5e3d0080125c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1530173029006708",
"url": "https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 Linux - full debug/4804",
"utcnow_ts": "1530173029111295"
}
}
[08:03:49.125] Task URL: https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 Linux - full debug/4804
[08:03:49.125] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:2:0) after 1m0s
[08:03:50.689] Received PubSub notification, asking Buildbucket for the build status
[08:03:50.738] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:49.143] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:2:0)
[08:04:49.143] Timer tick, asking Buildbucket for the build status
[08:04:49.451] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:49.451] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:4:0) after 1m0s
[08:05:49.468] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:4:0)
[08:05:49.468] Timer tick, asking Buildbucket for the build status
[08:05:49.521] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:49.521] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:5:0) after 1m0s
[08:06:49.541] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:5:0)
[08:06:49.541] Timer tick, asking Buildbucket for the build status
[08:06:50.138] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:50.138] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:6:0) after 1m0s
[08:07:50.158] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:6:0)
[08:07:50.158] Timer tick, asking Buildbucket for the build status
[08:07:50.229] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:50.229] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:7:0) after 1m0s
[08:08:50.252] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:7:0)
[08:08:50.252] Timer tick, asking Buildbucket for the build status
[08:08:50.314] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:50.314] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:8:0) after 1m0s
[08:09:50.331] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:8:0)
[08:09:50.331] Timer tick, asking Buildbucket for the build status
[08:09:50.451] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:50.451] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:9:0) after 1m0s
[08:10:50.489] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:9:0)
[08:10:50.489] Timer tick, asking Buildbucket for the build status
[08:10:50.528] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:50.528] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:10:0) after 1m0s
[08:11:50.665] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:10:0)
[08:11:50.665] Timer tick, asking Buildbucket for the build status
[08:11:50.715] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:50.715] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:11:0) after 1m0s
[08:12:50.740] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:11:0)
[08:12:50.740] Timer tick, asking Buildbucket for the build status
[08:12:50.810] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:50.810] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:12:0) after 1m0s
[08:13:50.827] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:12:0)
[08:13:50.827] Timer tick, asking Buildbucket for the build status
[08:13:50.862] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:50.862] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:13:0) after 1m0s
[08:14:50.879] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:13:0)
[08:14:50.879] Timer tick, asking Buildbucket for the build status
[08:14:50.937] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:50.937] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:14:0) after 1m0s
[08:15:50.957] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:14:0)
[08:15:50.957] Timer tick, asking Buildbucket for the build status
[08:15:51.087] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:51.087] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:15:0) after 1m0s
[08:16:51.129] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:15:0)
[08:16:51.129] Timer tick, asking Buildbucket for the build status
[08:16:51.235] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:51.235] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:16:0) after 1m0s
[08:17:51.263] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:16:0)
[08:17:51.263] Timer tick, asking Buildbucket for the build status
[08:17:51.627] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:51.627] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:17:0) after 1m0s
[08:18:51.645] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:17:0)
[08:18:51.645] Timer tick, asking Buildbucket for the build status
[08:18:51.750] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:51.750] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:18:0) after 1m0s
[08:19:51.860] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:18:0)
[08:19:51.860] Timer tick, asking Buildbucket for the build status
[08:19:52.041] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:52.041] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:19:0) after 1m0s
[08:20:52.139] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:19:0)
[08:20:52.139] Timer tick, asking Buildbucket for the build status
[08:20:52.273] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:52.273] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:20:0) after 1m0s
[08:21:52.291] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:20:0)
[08:21:52.291] Timer tick, asking Buildbucket for the build status
[08:21:52.351] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:52.351] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:21:0) after 1m0s
[08:22:52.371] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:21:0)
[08:22:52.371] Timer tick, asking Buildbucket for the build status
[08:22:52.556] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:52.556] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:22:0) after 1m0s
[08:23:52.574] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:22:0)
[08:23:52.574] Timer tick, asking Buildbucket for the build status
[08:23:52.688] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:52.688] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:23:0) after 1m0s
[08:24:52.705] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:23:0)
[08:24:52.705] Timer tick, asking Buildbucket for the build status
[08:24:52.860] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:52.860] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:24:0) after 1m0s
[08:25:52.878] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:24:0)
[08:25:52.878] Timer tick, asking Buildbucket for the build status
[08:25:52.932] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:52.932] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:25:0) after 1m0s
[08:26:52.951] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:25:0)
[08:26:52.951] Timer tick, asking Buildbucket for the build status
[08:26:53.327] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:53.327] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:26:0) after 1m0s
[08:27:53.345] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:26:0)
[08:27:53.346] Timer tick, asking Buildbucket for the build status
[08:27:53.407] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:53.407] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:27:0) after 1m0s
[08:28:53.428] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:27:0)
[08:28:53.428] Timer tick, asking Buildbucket for the build status
[08:28:53.479] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:53.479] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:28:0) after 1m0s
[08:29:53.498] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:28:0)
[08:29:53.498] Timer tick, asking Buildbucket for the build status
[08:29:53.556] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:53.556] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:29:0) after 1m0s
[08:30:53.574] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:29:0)
[08:30:53.574] Timer tick, asking Buildbucket for the build status
[08:30:53.799] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:53.799] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:30:0) after 1m0s
[08:31:53.820] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:30:0)
[08:31:53.820] Timer tick, asking Buildbucket for the build status
[08:31:53.940] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:53.940] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:31:0) after 1m0s
[08:32:53.961] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:31:0)
[08:32:53.961] Timer tick, asking Buildbucket for the build status
[08:32:54.128] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:54.128] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:32:0) after 1m0s
[08:33:54.148] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:32:0)
[08:33:54.148] Timer tick, asking Buildbucket for the build status
[08:33:54.230] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:54.230] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:33:0) after 1m0s
[08:34:54.249] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:33:0)
[08:34:54.249] Timer tick, asking Buildbucket for the build status
[08:34:54.398] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:54.398] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:34:0) after 1m0s
[08:35:54.416] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:34:0)
[08:35:54.416] Timer tick, asking Buildbucket for the build status
[08:35:54.618] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:54.618] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:35:0) after 1m0s
[08:36:54.638] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:35:0)
[08:36:54.638] Timer tick, asking Buildbucket for the build status
[08:36:54.697] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:54.697] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:36:0) after 1m0s
[08:37:54.753] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:36:0)
[08:37:54.753] Timer tick, asking Buildbucket for the build status
[08:37:54.817] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:54.817] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:37:0) after 1m0s
[08:38:54.842] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:37:0)
[08:38:54.842] Timer tick, asking Buildbucket for the build status
[08:38:54.896] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:54.896] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:38:0) after 1m0s
[08:39:54.917] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:38:0)
[08:39:54.917] Timer tick, asking Buildbucket for the build status
[08:39:55.021] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:55.021] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:39:0) after 1m0s
[08:40:55.041] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:39:0)
[08:40:55.041] Timer tick, asking Buildbucket for the build status
[08:40:55.103] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:55.103] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:40:0) after 1m0s
[08:41:55.122] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:40:0)
[08:41:55.122] Timer tick, asking Buildbucket for the build status
[08:41:55.224] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:55.224] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:41:0) after 1m0s
[08:42:55.245] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:41:0)
[08:42:55.245] Timer tick, asking Buildbucket for the build status
[08:42:55.299] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:55.299] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:42:0) after 1m0s
[08:43:55.535] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:42:0)
[08:43:55.535] Timer tick, asking Buildbucket for the build status
[08:43:55.721] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:55.721] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:43:0) after 1m0s
[08:44:55.740] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:43:0)
[08:44:55.740] Timer tick, asking Buildbucket for the build status
[08:44:55.793] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:55.793] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:44:0) after 1m0s
[08:45:55.813] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:44:0)
[08:45:55.813] Timer tick, asking Buildbucket for the build status
[08:45:55.923] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:55.923] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:45:0) after 1m0s
[08:46:57.805] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:45:0)
[08:46:57.805] Timer tick, asking Buildbucket for the build status
[08:46:57.926] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:57.926] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:46:0) after 1m0s
[08:47:57.946] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:46:0)
[08:47:57.946] Timer tick, asking Buildbucket for the build status
[08:47:57.979] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:57.979] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:47:0) after 1m0s
[08:48:57.997] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:47:0)
[08:48:57.997] Timer tick, asking Buildbucket for the build status
[08:48:58.058] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:58.058] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:48:0) after 1m0s
[08:49:58.141] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:48:0)
[08:49:58.141] Timer tick, asking Buildbucket for the build status
[08:49:58.428] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:58.428] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:49:0) after 1m0s
[08:50:58.449] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:49:0)
[08:50:58.449] Timer tick, asking Buildbucket for the build status
[08:50:58.529] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:58.529] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:50:0) after 1m0s
[08:51:58.546] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:50:0)
[08:51:58.546] Timer tick, asking Buildbucket for the build status
[08:51:58.742] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:58.742] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:51:0) after 1m0s
[08:52:58.761] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:51:0)
[08:52:58.761] Timer tick, asking Buildbucket for the build status
[08:52:58.793] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:58.793] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:52:0) after 1m0s
[08:53:58.815] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:52:0)
[08:53:58.815] Timer tick, asking Buildbucket for the build status
[08:53:58.865] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:58.865] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:53:0) after 1m0s
[08:54:58.931] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:53:0)
[08:54:58.931] Timer tick, asking Buildbucket for the build status
[08:54:58.996] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:58.996] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:54:0) after 1m0s
[08:55:59.015] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:54:0)
[08:55:59.015] Timer tick, asking Buildbucket for the build status
[08:55:59.076] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:59.076] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:55:0) after 1m0s
[08:56:59.097] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:55:0)
[08:56:59.097] Timer tick, asking Buildbucket for the build status
[08:56:59.159] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:59.159] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:56:0) after 1m0s
[08:57:59.196] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:56:0)
[08:57:59.196] Timer tick, asking Buildbucket for the build status
[08:57:59.320] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:59.320] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:57:0) after 1m0s
[08:58:59.390] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:57:0)
[08:58:59.390] Timer tick, asking Buildbucket for the build status
[08:58:59.539] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:59.539] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:58:0) after 1m0s
[08:59:59.558] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:58:0)
[08:59:59.558] Timer tick, asking Buildbucket for the build status
[08:59:59.624] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:59.624] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:59:0) after 1m0s
[09:00:59.650] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:59:0)
[09:00:59.650] Timer tick, asking Buildbucket for the build status
[09:00:59.696] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:59.696] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:60:0) after 1m0s
[09:01:59.720] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:60:0)
[09:01:59.720] Timer tick, asking Buildbucket for the build status
[09:01:59.889] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:59.889] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:61:0) after 1m0s
[09:02:59.924] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:61:0)
[09:02:59.924] Timer tick, asking Buildbucket for the build status
[09:03:00.115] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:00.115] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:62:0) after 1m0s
[09:04:00.147] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:62:0)
[09:04:00.147] Timer tick, asking Buildbucket for the build status
[09:04:00.269] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:00.269] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:63:0) after 1m0s
[09:05:00.292] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:63:0)
[09:05:00.292] Timer tick, asking Buildbucket for the build status
[09:05:00.356] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:00.357] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:64:0) after 1m0s
[09:06:00.378] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:64:0)
[09:06:00.378] Timer tick, asking Buildbucket for the build status
[09:06:00.476] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:00.476] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:65:0) after 1m0s
[09:07:00.566] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:65:0)
[09:07:00.566] Timer tick, asking Buildbucket for the build status
[09:07:00.639] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:00.639] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:66:0) after 1m0s
[09:08:00.660] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:66:0)
[09:08:00.660] Timer tick, asking Buildbucket for the build status
[09:08:00.712] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:00.712] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:67:0) after 1m0s
[09:09:00.746] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:67:0)
[09:09:00.746] Timer tick, asking Buildbucket for the build status
[09:09:00.803] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:00.803] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:68:0) after 1m0s
[09:10:00.826] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:68:0)
[09:10:00.826] Timer tick, asking Buildbucket for the build status
[09:10:01.001] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:01.001] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:69:0) after 1m0s
[09:11:01.025] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:69:0)
[09:11:01.025] Timer tick, asking Buildbucket for the build status
[09:11:01.060] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:01.060] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:70:0) after 1m0s
[09:12:01.148] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:70:0)
[09:12:01.148] Timer tick, asking Buildbucket for the build status
[09:12:01.376] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:01.376] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:71:0) after 1m0s
[09:13:01.468] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:71:0)
[09:13:01.468] Timer tick, asking Buildbucket for the build status
[09:13:01.526] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:01.526] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:72:0) after 1m0s
[09:14:01.545] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:72:0)
[09:14:01.545] Timer tick, asking Buildbucket for the build status
[09:14:01.619] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:01.619] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:73:0) after 1m0s
[09:15:01.652] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:73:0)
[09:15:01.652] Timer tick, asking Buildbucket for the build status
[09:15:01.717] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:01.717] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:74:0) after 1m0s
[09:16:01.741] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:74:0)
[09:16:01.741] Timer tick, asking Buildbucket for the build status
[09:16:05.823] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:05.823] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:75:0) after 1m0s
[09:17:05.842] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:75:0)
[09:17:05.842] Timer tick, asking Buildbucket for the build status
[09:17:05.895] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:05.895] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:76:0) after 1m0s
[09:18:05.914] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:76:0)
[09:18:05.914] Timer tick, asking Buildbucket for the build status
[09:18:05.984] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:05.984] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:77:0) after 1m0s
[09:19:06.002] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:77:0)
[09:19:06.002] Timer tick, asking Buildbucket for the build status
[09:19:06.326] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:06.326] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:78:0) after 1m0s
[09:20:06.348] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:78:0)
[09:20:06.348] Timer tick, asking Buildbucket for the build status
[09:20:06.425] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:06.425] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:79:0) after 1m0s
[09:21:06.445] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:79:0)
[09:21:06.446] Timer tick, asking Buildbucket for the build status
[09:21:06.516] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:06.516] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:80:0) after 1m0s
[09:22:06.553] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:80:0)
[09:22:06.554] Timer tick, asking Buildbucket for the build status
[09:22:06.768] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:06.768] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:81:0) after 1m0s
[09:23:06.786] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:81:0)
[09:23:06.786] Timer tick, asking Buildbucket for the build status
[09:23:06.841] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:06.841] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:82:0) after 1m0s
[09:24:06.864] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:82:0)
[09:24:06.864] Timer tick, asking Buildbucket for the build status
[09:24:06.945] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:06.945] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:83:0) after 1m0s
[09:25:06.966] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:83:0)
[09:25:06.966] Timer tick, asking Buildbucket for the build status
[09:25:07.273] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:07.273] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:84:0) after 1m0s
[09:26:07.293] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:84:0)
[09:26:07.293] Timer tick, asking Buildbucket for the build status
[09:26:07.353] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:07.353] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:85:0) after 1m0s
[09:27:07.371] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:85:0)
[09:27:07.371] Timer tick, asking Buildbucket for the build status
[09:27:07.404] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:07.404] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:86:0) after 1m0s
[09:28:07.426] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:86:0)
[09:28:07.426] Timer tick, asking Buildbucket for the build status
[09:28:07.477] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:07.477] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:87:0) after 1m0s
[09:29:07.504] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:87:0)
[09:29:07.504] Timer tick, asking Buildbucket for the build status
[09:29:07.584] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:07.584] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:88:0) after 1m0s
[09:30:07.604] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:88:0)
[09:30:07.604] Timer tick, asking Buildbucket for the build status
[09:30:07.752] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:07.752] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:89:0) after 1m0s
[09:31:07.773] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:89:0)
[09:31:07.773] Timer tick, asking Buildbucket for the build status
[09:31:07.843] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:07.843] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:90:0) after 1m0s
[09:32:07.900] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:90:0)
[09:32:07.900] Timer tick, asking Buildbucket for the build status
[09:32:07.999] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:07.999] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:91:0) after 1m0s
[09:33:08.020] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:91:0)
[09:33:08.020] Timer tick, asking Buildbucket for the build status
[09:33:08.080] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:08.080] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:92:0) after 1m0s
[09:34:08.118] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:92:0)
[09:34:08.118] Timer tick, asking Buildbucket for the build status
[09:34:08.177] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:08.177] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:93:0) after 1m0s
[09:35:08.218] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:93:0)
[09:35:08.218] Timer tick, asking Buildbucket for the build status
[09:35:08.347] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:08.347] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:94:0) after 1m0s
[09:36:08.462] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:94:0)
[09:36:08.462] Timer tick, asking Buildbucket for the build status
[09:36:08.722] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:08.722] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:95:0) after 1m0s
[09:37:08.746] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:95:0)
[09:37:08.746] Timer tick, asking Buildbucket for the build status
[09:37:08.832] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:08.832] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:96:0) after 1m0s
[09:38:08.853] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:96:0)
[09:38:08.853] Timer tick, asking Buildbucket for the build status
[09:38:08.925] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:08.925] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:97:0) after 1m0s
[09:39:08.955] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:97:0)
[09:39:08.955] Timer tick, asking Buildbucket for the build status
[09:39:09.013] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:09.013] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:98:0) after 1m0s
[09:40:09.108] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:98:0)
[09:40:09.108] Timer tick, asking Buildbucket for the build status
[09:40:09.200] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:09.200] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:99:0) after 1m0s
[09:41:09.332] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:99:0)
[09:41:09.332] Timer tick, asking Buildbucket for the build status
[09:41:09.451] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:09.451] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:100:0) after 1m0s
[09:42:09.472] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:100:0)
[09:42:09.472] Timer tick, asking Buildbucket for the build status
[09:42:09.538] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:09.538] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:101:0) after 1m0s
[09:43:09.558] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:101:0)
[09:43:09.558] Timer tick, asking Buildbucket for the build status
[09:43:09.590] Build 8942491003230469328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:09.590] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9107921065525050912:102:0) after 1m0s
[09:43:54.164] Received PubSub notification, asking Buildbucket for the build status
[09:43:54.269] Build 8942491003230469328: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:43:54.269] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1530179032265253",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1530173027733627",
"id": "8942491003230469328",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"5b7262870994ed883ec07a0b68ff741b30584180\"}}",
"project": "v8",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"jsonResult\": \"null\"}, \"recipeExitCode\": {\"value\": 0}, \"recipe\": {\"name\": \"v8\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8942491003230469328/+/annotations\"}, \"swarming\": {\"task_result\": {\"cipd_pins\": {\"packages\": [{\"path\": \".\", \"version\": \"308257c4405c65372caf4a59d9158509a31d0eb1\", \"package_name\": \"infra/tools/luci/kitchen/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"b245a31a4df87bd38f7e7d0cf19d492695bd7a7e\", \"package_name\": \"infra/git/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"46c0c897ca0f053799ee41fd148bb7a47232df47\", \"package_name\": \"infra/python/cpython/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"6e5ff69bbe48c38117c44fd735cb7adb32417549\", \"package_name\": \"infra/tools/buildbucket/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"4672ed11a416bb60e9ec6738dab9cc41386971f5\", \"package_name\": \"infra/tools/cloudtail/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"b83e1ae8c931a5261509cc15d443c2d608f65b15\", \"package_name\": \"infra/tools/git/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"df53a719b65668e3b16ecdb600f29f8c901cd67e\", \"package_name\": \"infra/tools/luci-auth/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"72f5c9ec60e557643b06eac503836fb78359ca06\", \"package_name\": \"infra/tools/luci/git-credential-luci/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"aa3483984e49de4cf3467e9b34d84f38d926f434\", \"package_name\": \"infra/tools/luci/vpython-native/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"88b621371d3cca0cd1102df97632ff497e4c9577\", \"package_name\": \"infra/tools/luci/vpython/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"7ac9ea00b7d1d664e9015d2bbd537bc8cb3bfda4\", \"package_name\": \"infra/tools/prpc/linux-amd64\"}, {\"path\": \"kitchen-checkout\", \"version\": \"3ed648fe0b1052bdd4c831ab108912749203ba26\", \"package_name\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}], \"client_package\": {\"version\": \"933f3c2c20066d8f959aa0ca489f070c50de38e7\", \"package_name\": \"infra/tools/cipd/linux-amd64\"}}, \"run_id\": \"3e5e3d0080125c11\", \"outputs_ref\": {\"isolatedserver\": \"https://isolateserver.appspot.com\", \"namespace\": \"default-gzip\", \"isolated\": \"109cc69d963c82543a5e94421d8bca617c6b988a\"}, \"server_versions\": [\"3672-f0a13a4\"], \"duration\": 5863.505970001221, \"completed_ts\": \"2018-06-28T09:43:52.265253\", \"started_ts\": \"2018-06-28T08:03:49.917496\", \"internal_failure\": false, \"exit_code\": \"0\", \"state\": \"COMPLETED\", \"bot_version\": \"34b6ffeb086896c55927625aa336629a0f6e3c5fa84931ff92f6e9f73a9d3f60\", \"tags\": [\"build_address:luci.v8.ci/V8 Linux - full debug/4804\", \"buildbucket_bucket:luci.v8.ci\", \"buildbucket_build_id:8942491003230469328\", \"buildbucket_hostname:cr-buildbucket.appspot.com\", \"buildbucket_template_canary:1\", \"buildbucket_template_revision:333db54570a89c15ad8da08696be059fc5ece41a\", \"builder:V8 Linux - full debug\", \"buildset:commit/git/5b7262870994ed883ec07a0b68ff741b30584180\", \"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/5b7262870994ed883ec07a0b68ff741b30584180\", \"cpu:x86-64\", \"gitiles_ref:refs/heads/master\", \"log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8942491003230469328/+/annotations\", \"luci_project:v8\", \"multibot:0\", \"os:Ubuntu-14.04\", \"pool:luci.v8.ci\", \"priority:30\", \"recipe_name:v8\", \"recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\", \"scheduler_invocation_id:9107921065525050912\", \"scheduler_job_id:v8/V8 Linux - full debug\", \"service_account:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com\", \"swarming.pool.template:skip\", \"swarming.pool.version:8a4c808613839e717254e3b5b02ccb035adc8f73\", \"user:None\", \"user_agent:luci-scheduler\", \"vpython:native-python-wrapper\"], \"failure\": false, \"modified_ts\": \"2018-06-28T09:43:52.265253\", \"user\": \"\", \"created_ts\": \"2018-06-28T08:03:48.362581\", \"name\": \"bb-8942491003230469328-v8-V8 Linux - full debug\", \"task_id\": \"3e5e3d0080125c10\", \"bot_dimensions\": [{\"value\": [\"0\"], \"key\": \"beefy_baremetal\"}, {\"value\": [\"builder_0d593ee5aa3cf9dabcc2383ca6866d4a1d75fbc9d5b6881380b2a0d6835e6902_v2\", \"builder_3db5e1b6b0647e7d9f8cc4e1bff4fe3e76258618fe20b2551da6ab5c5ef76653_v2\", \"builder_7618236dcda6485ff7b7c49f5ba63222ca2ec4f80e755043529cad88aa2b97c4_v2\", \"builder_7d53e00b9f90f15bd8b4d4c3c67b8746a84f1ff4bdd4b3b752b53580e9a425fa_v2\", \"builder_96fb8a61895f2088bec06eb0e2010c50a1c2e6652a3a5eb671a28bab6d12efe1_v2\", \"builder_9c514a0b24dc61db3bb3e2448a0b76e2c910d73814dcda449a1307918f7709c4_v2\", \"builder_ac28d79f9b08d1c61f9e78ff2c943b9977977ff9784747ddc0ce0414c13b1981_v2\", \"builder_cf2981f787534062bc22270b0c8a3c4c3a07e397c2632b07e958a675d466bb7a_v2\", \"builder_f50a38a96ac302413037c2ca6414dfb93f641a01f22b2d3448985320d72a9bbb_v2\", \"builder_ff0ff18cc904346d61969d3e19dfe8ae3e10ad5cce744a40c0eef377f7766c30_v2\", \"git\", \"goma_v2\", \"vpython\"], \"key\": \"caches\"}, {\"value\": [\"8\"], \"key\": \"cores\"}, {\"value\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"key\": \"cpu\"}, {\"value\": [\"none\"], \"key\": \"gpu\"}, {\"value\": [\"swarm435-c4\"], \"key\": \"id\"}, {\"value\": [\"0\"], \"key\": \"inside_docker\"}, {\"value\": [\"1\"], \"key\": \"kvm\"}, {\"value\": [\"n1-standard-8\"], \"key\": \"machine_type\"}, {\"value\": [\"0\"], \"key\": \"multibot\"}, {\"value\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"key\": \"os\"}, {\"value\": [\"luci.v8.ci\"], \"key\": \"pool\"}, {\"value\": [\"2.7.6\"], \"key\": \"python\"}, {\"value\": [\"3672-f0a13a4\"], \"key\": \"server_version\"}, {\"value\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"], \"key\": \"zone\"}], \"try_number\": \"1\", \"current_task_slice\": \"0\", \"costs_usd\": [0.6810255852441766], \"bot_id\": \"swarm435-c4\"}}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"buildnumber\": 4804, \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"buildername\": \"V8 Linux - full debug\", \"got_revision\": \"5b7262870994ed883ec07a0b68ff741b30584180\", \"recipe\": \"v8\", \"mastername\": \"client.v8\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1530173027733627, \"tags\": [\"builder:V8 Linux - full debug\", \"buildset:commit/git/5b7262870994ed883ec07a0b68ff741b30584180\", \"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/5b7262870994ed883ec07a0b68ff741b30584180\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9107921065525050912\", \"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\": \"8942491003230469328\"}}, \"got_revision_cp\": \"refs/heads/master@{#54075}\", \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"5b7262870994ed883ec07a0b68ff741b30584180\", \"bot_id\": \"swarm435-c4\"}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1530173029917496",
"status": "COMPLETED",
"status_changed_ts": "1530179033512913",
"tags": [
"build_address:luci.v8.ci/V8 Linux - full debug/4804",
"builder:V8 Linux - full debug",
"buildset:commit/git/5b7262870994ed883ec07a0b68ff741b30584180",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/5b7262870994ed883ec07a0b68ff741b30584180",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9107921065525050912",
"scheduler_job_id:v8/V8 Linux - full debug",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:multibot:0",
"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/4804",
"swarming_tag:buildbucket_bucket:luci.v8.ci",
"swarming_tag:buildbucket_build_id:8942491003230469328",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:333db54570a89c15ad8da08696be059fc5ece41a",
"swarming_tag:builder:V8 Linux - full debug",
"swarming_tag:buildset:commit/git/5b7262870994ed883ec07a0b68ff741b30584180",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/5b7262870994ed883ec07a0b68ff741b30584180",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8942491003230469328/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:multibot:0",
"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:9107921065525050912",
"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:8a4c808613839e717254e3b5b02ccb035adc8f73",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e5e3d0080125c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1530179033588329",
"url": "https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 Linux - full debug/4804",
"utcnow_ts": "1530179034260031"
}
}
[09:43:54.269] Invocation finished in 1h40m8.108332609s with status SUCCEEDED