[11:16:12.347] New invocation is queued and will start shortly
[11:16:13.602] Starting the invocation (attempt 1)
[11:16:13.635] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:16:13.636] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:16:13.636] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9094862995329682816",
"parameters_json": "{\"builder_name\":\"V8 Linux - full debug\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee\"}}",
"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:9094862995329682816",
"scheduler_job_id:v8/V8 Linux - full debug",
"user_agent:luci-scheduler",
"buildset:commit/git/2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee",
"gitiles_ref:refs/heads/master"
]
}
[11:16:15.035] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1542626173714553",
"id": "8929432933229405280",
"lease_expiration_ts": "1542741374557279",
"lease_key": "1310842571",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee\"}}",
"project": "v8",
"result_details_json": "null",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1542626174816493",
"tags": [
"build_address:luci.v8.ci/V8 Linux - full debug/6166",
"builder:V8 Linux - full debug",
"buildset:commit/git/2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9094862995329682816",
"scheduler_job_id:v8/V8 Linux - full debug",
"swarming_dimension:caches:builder_3ddc1e6738afb01c19c5328ebf3157ce1f828afa6f9bfedbccf804e743fd73fc_v2",
"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/6166",
"swarming_tag:buildbucket_bucket:v8/ci",
"swarming_tag:buildbucket_build_id:8929432933229405280",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:da5491be675c79d05750cef9051038aa905ddaff",
"swarming_tag:builder:V8 Linux - full debug",
"swarming_tag:buildset:commit/git/2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee",
"swarming_tag:caches:builder_3ddc1e6738afb01c19c5328ebf3157ce1f828afa6f9bfedbccf804e743fd73fc_v2",
"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/8929432933229405280/+/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:9094862995329682816",
"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:7f5ce4d7633892d1ef2fcf6c79071652be2c4013",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:414480ed1c169610",
"user_agent:luci-scheduler"
],
"updated_ts": "1542626174816593",
"url": "https://ci.chromium.org/b/8929432933229405280",
"utcnow_ts": "1542626175016851"
}
}
[11:16:15.035] Task URL: https://ci.chromium.org/b/8929432933229405280
[11:16:15.035] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:2:0) after 1m0s
[11:17:15.054] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:2:0)
[11:17:15.054] Timer tick, asking Buildbucket for the build status
[11:17:15.247] Build 8929432933229405280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:17:15.247] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:3:0) after 1m0s
[11:18:15.266] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:3:0)
[11:18:15.266] Timer tick, asking Buildbucket for the build status
[11:18:15.339] Build 8929432933229405280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:18:15.339] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:4:0) after 1m0s
[11:19:15.383] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:4:0)
[11:19:15.383] Timer tick, asking Buildbucket for the build status
[11:19:15.717] Build 8929432933229405280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:19:15.717] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:5:0) after 1m0s
[11:20:10.692] Received PubSub notification, asking Buildbucket for the build status
[11:20:10.726] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:15.738] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:5:0)
[11:20:15.738] Timer tick, asking Buildbucket for the build status
[11:20:15.775] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:15.775] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:7:0) after 1m0s
[11:21:15.809] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:7:0)
[11:21:15.809] Timer tick, asking Buildbucket for the build status
[11:21:15.924] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:15.924] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:8:0) after 1m0s
[11:22:15.943] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:8:0)
[11:22:15.943] Timer tick, asking Buildbucket for the build status
[11:22:15.999] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:15.999] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:9:0) after 1m0s
[11:23:16.016] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:9:0)
[11:23:16.016] Timer tick, asking Buildbucket for the build status
[11:23:16.218] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:16.218] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:10:0) after 1m0s
[11:24:16.237] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:10:0)
[11:24:16.237] Timer tick, asking Buildbucket for the build status
[11:24:16.309] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:16.309] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:11:0) after 1m0s
[11:25:16.336] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:11:0)
[11:25:16.336] Timer tick, asking Buildbucket for the build status
[11:25:16.396] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:16.396] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:12:0) after 1m0s
[11:26:16.414] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:12:0)
[11:26:16.414] Timer tick, asking Buildbucket for the build status
[11:26:16.734] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:16.734] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:13:0) after 1m0s
[11:27:16.752] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:13:0)
[11:27:16.752] Timer tick, asking Buildbucket for the build status
[11:27:16.871] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:16.871] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:14:0) after 1m0s
[11:28:16.896] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:14:0)
[11:28:16.896] Timer tick, asking Buildbucket for the build status
[11:28:16.985] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:16.985] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:15:0) after 1m0s
[11:29:17.008] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:15:0)
[11:29:17.008] Timer tick, asking Buildbucket for the build status
[11:29:17.043] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:17.043] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:16:0) after 1m0s
[11:30:17.089] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:16:0)
[11:30:17.089] Timer tick, asking Buildbucket for the build status
[11:30:17.144] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:17.144] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:17:0) after 1m0s
[11:31:17.172] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:17:0)
[11:31:17.172] Timer tick, asking Buildbucket for the build status
[11:31:17.244] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:17.244] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:18:0) after 1m0s
[11:32:17.264] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:18:0)
[11:32:17.264] Timer tick, asking Buildbucket for the build status
[11:32:17.352] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:17.352] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:19:0) after 1m0s
[11:33:17.371] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:19:0)
[11:33:17.371] Timer tick, asking Buildbucket for the build status
[11:33:17.523] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:17.523] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:20:0) after 1m0s
[11:34:17.541] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:20:0)
[11:34:17.541] Timer tick, asking Buildbucket for the build status
[11:34:17.634] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:17.634] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:21:0) after 1m0s
[11:35:17.664] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:21:0)
[11:35:17.664] Timer tick, asking Buildbucket for the build status
[11:35:17.698] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:17.698] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:22:0) after 1m0s
[11:36:17.717] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:22:0)
[11:36:17.717] Timer tick, asking Buildbucket for the build status
[11:36:17.834] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:17.834] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:23:0) after 1m0s
[11:37:17.854] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:23:0)
[11:37:17.854] Timer tick, asking Buildbucket for the build status
[11:37:17.919] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:17.919] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:24:0) after 1m0s
[11:38:17.937] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:24:0)
[11:38:17.937] Timer tick, asking Buildbucket for the build status
[11:38:18.030] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:18.030] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:25:0) after 1m0s
[11:39:18.112] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:25:0)
[11:39:18.112] Timer tick, asking Buildbucket for the build status
[11:39:18.195] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:18.195] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:26:0) after 1m0s
[11:40:18.212] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:26:0)
[11:40:18.212] Timer tick, asking Buildbucket for the build status
[11:40:18.324] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:18.324] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:27:0) after 1m0s
[11:41:18.473] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:27:0)
[11:41:18.473] Timer tick, asking Buildbucket for the build status
[11:41:18.546] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:18.546] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:28:0) after 1m0s
[11:42:18.584] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:28:0)
[11:42:18.584] Timer tick, asking Buildbucket for the build status
[11:42:18.644] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:18.644] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:29:0) after 1m0s
[11:43:18.702] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:29:0)
[11:43:18.702] Timer tick, asking Buildbucket for the build status
[11:43:18.768] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:18.768] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:30:0) after 1m0s
[11:44:18.786] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:30:0)
[11:44:18.786] Timer tick, asking Buildbucket for the build status
[11:44:19.059] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:19.059] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:31:0) after 1m0s
[11:45:19.109] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:31:0)
[11:45:19.109] Timer tick, asking Buildbucket for the build status
[11:45:19.148] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:19.148] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:32:0) after 1m0s
[11:46:19.170] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:32:0)
[11:46:19.170] Timer tick, asking Buildbucket for the build status
[11:46:19.240] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:19.240] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:33:0) after 1m0s
[11:47:19.277] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:33:0)
[11:47:19.277] Timer tick, asking Buildbucket for the build status
[11:47:19.425] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:19.425] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:34:0) after 1m0s
[11:48:19.445] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:34:0)
[11:48:19.445] Timer tick, asking Buildbucket for the build status
[11:48:19.897] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:19.897] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:35:0) after 1m0s
[11:49:19.986] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:35:0)
[11:49:19.986] Timer tick, asking Buildbucket for the build status
[11:49:20.079] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:20.079] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:36:0) after 1m0s
[11:50:20.133] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:36:0)
[11:50:20.133] Timer tick, asking Buildbucket for the build status
[11:50:20.185] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:20.186] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:37:0) after 1m0s
[11:51:20.287] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:37:0)
[11:51:20.287] Timer tick, asking Buildbucket for the build status
[11:51:20.819] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:20.819] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:38:0) after 1m0s
[11:52:20.837] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:38:0)
[11:52:20.837] Timer tick, asking Buildbucket for the build status
[11:52:21.026] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:21.026] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:39:0) after 1m0s
[11:53:21.052] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:39:0)
[11:53:21.052] Timer tick, asking Buildbucket for the build status
[11:53:21.345] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:21.345] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:40:0) after 1m0s
[11:54:21.408] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:40:0)
[11:54:21.408] Timer tick, asking Buildbucket for the build status
[11:54:21.506] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:21.506] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:41:0) after 1m0s
[11:55:21.591] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:41:0)
[11:55:21.591] Timer tick, asking Buildbucket for the build status
[11:55:21.669] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:21.669] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:42:0) after 1m0s
[11:56:21.693] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:42:0)
[11:56:21.693] Timer tick, asking Buildbucket for the build status
[11:56:21.808] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:21.808] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:43:0) after 1m0s
[11:57:21.828] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:43:0)
[11:57:21.828] Timer tick, asking Buildbucket for the build status
[11:57:21.984] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:21.984] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:44:0) after 1m0s
[11:58:22.104] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:44:0)
[11:58:22.104] Timer tick, asking Buildbucket for the build status
[11:58:22.209] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:22.209] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:45:0) after 1m0s
[11:59:22.268] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:45:0)
[11:59:22.268] Timer tick, asking Buildbucket for the build status
[11:59:22.368] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:22.368] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:46:0) after 1m0s
[12:00:22.451] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:46:0)
[12:00:22.451] Timer tick, asking Buildbucket for the build status
[12:00:22.607] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:22.607] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:47:0) after 1m0s
[12:01:22.629] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:47:0)
[12:01:22.629] Timer tick, asking Buildbucket for the build status
[12:01:22.691] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:22.691] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:48:0) after 1m0s
[12:02:22.711] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:48:0)
[12:02:22.711] Timer tick, asking Buildbucket for the build status
[12:02:22.848] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:22.848] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:49:0) after 1m0s
[12:03:22.871] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:49:0)
[12:03:22.871] Timer tick, asking Buildbucket for the build status
[12:03:22.921] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:22.921] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:50:0) after 1m0s
[12:04:22.974] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:50:0)
[12:04:22.974] Timer tick, asking Buildbucket for the build status
[12:04:23.095] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:23.095] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:51:0) after 1m0s
[12:05:23.116] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:51:0)
[12:05:23.116] Timer tick, asking Buildbucket for the build status
[12:05:23.252] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:23.252] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:52:0) after 1m0s
[12:06:23.313] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:52:0)
[12:06:23.313] Timer tick, asking Buildbucket for the build status
[12:06:23.382] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:23.382] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:53:0) after 1m0s
[12:07:23.400] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:53:0)
[12:07:23.400] Timer tick, asking Buildbucket for the build status
[12:07:23.508] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:23.508] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:54:0) after 1m0s
[12:08:23.530] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:54:0)
[12:08:23.530] Timer tick, asking Buildbucket for the build status
[12:08:23.670] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:23.670] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:55:0) after 1m0s
[12:09:23.705] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:55:0)
[12:09:23.705] Timer tick, asking Buildbucket for the build status
[12:09:23.745] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:23.745] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:56:0) after 1m0s
[12:10:23.767] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:56:0)
[12:10:23.767] Timer tick, asking Buildbucket for the build status
[12:10:23.900] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:23.900] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:57:0) after 1m0s
[12:11:23.916] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:57:0)
[12:11:23.916] Timer tick, asking Buildbucket for the build status
[12:11:24.010] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:24.010] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:58:0) after 1m0s
[12:12:24.035] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:58:0)
[12:12:24.035] Timer tick, asking Buildbucket for the build status
[12:12:24.084] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:24.084] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:59:0) after 1m0s
[12:13:24.109] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:59:0)
[12:13:24.109] Timer tick, asking Buildbucket for the build status
[12:13:24.173] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:24.173] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:60:0) after 1m0s
[12:14:24.196] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:60:0)
[12:14:24.196] Timer tick, asking Buildbucket for the build status
[12:14:24.235] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:24.235] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:61:0) after 1m0s
[12:15:24.307] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:61:0)
[12:15:24.307] Timer tick, asking Buildbucket for the build status
[12:15:24.494] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:24.494] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:62:0) after 1m0s
[12:16:24.525] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:62:0)
[12:16:24.525] Timer tick, asking Buildbucket for the build status
[12:16:24.583] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:24.583] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:63:0) after 1m0s
[12:17:24.888] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:63:0)
[12:17:24.888] Timer tick, asking Buildbucket for the build status
[12:17:24.968] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:24.968] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:64:0) after 1m0s
[12:18:24.998] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:64:0)
[12:18:24.998] Timer tick, asking Buildbucket for the build status
[12:18:25.046] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:25.046] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:65:0) after 1m0s
[12:19:25.176] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:65:0)
[12:19:25.176] Timer tick, asking Buildbucket for the build status
[12:19:25.361] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:25.361] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:66:0) after 1m0s
[12:20:25.593] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:66:0)
[12:20:25.593] Timer tick, asking Buildbucket for the build status
[12:20:25.904] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:25.904] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:67:0) after 1m0s
[12:21:25.937] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:67:0)
[12:21:25.937] Timer tick, asking Buildbucket for the build status
[12:21:26.014] Build 8929432933229405280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:26.014] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9094862995329682816:68:0) after 1m0s
[12:21:33.218] Received PubSub notification, asking Buildbucket for the build status
[12:21:33.265] Build 8929432933229405280: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:21:33.265] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "AUTO",
"completed_ts": "1542630092227561",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1542626173714553",
"id": "8929432933229405280",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee\"}}",
"project": "v8",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"kvm\": [\"1\"], \"gpu\": [\"none\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3844-124e68f\"], \"machine_type\": [\"n1-standard-8\"], \"host_class\": [\"default\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"swarm349-c4\"], \"pool\": [\"luci.v8.ci\"], \"caches\": [\"builder_013b67fc6a24ef38ce64919e0efdbdf1b0fd7949fecc48a6ab253e9a289f8b16_v2\", \"builder_027e887950f4e1261c5fbefcfd25638551c322cb6c453b6cc815b66d10d6f3e0_v2\", \"builder_0756c5b6dc276f8ca56bf3d27eff9e06c4e026b9904c870a497a8be050bbc4b4_v2\", \"builder_18d91c7d645e01d7791b6a71b2dde61fb40586af70fc89de67b73b7e53b267cf_v2\", \"builder_1b6217a3dba1f84344d6eefd131be6928bfde80a0f048f8359f8129018fd93b8_v2\", \"builder_225a2cec8b7772d06155bfd792996ef72e144f6dde2f4fa5f1abbf24f9a9df1b_v2\", \"builder_24150ed9c440462bd23854e15cf06af2e676a0194567105d6e11fb365dd5feac_v2\", \"builder_243c519ad18ddadb640d67c9e88e83ca27856a2548a8449102db93c8491d5a95_v2\", \"builder_31b9df838848cc4abda4c7a7b9abbf5da9ced7d841ac04c11635354ae46cf85b_v2\", \"builder_38fb4169af79eefa60c45ee01eff2e779be776db1001f15de2142dcfe6c03c75_v2\", \"builder_3b434f64dd3d5e652b0d0df7d86e20f3038c0ae1132eaae346be5d58c6868448_v2\", \"builder_3f9034e60101d3695fe7ca470f378cea7bcb75392ebaa67f43e146decc03c34e_v2\", \"builder_43a0420d43c28514aff61366a386e990efc55945e81febd6af28fa5f227b8c5f_v2\", \"builder_5a7fdfafde4a1a2f1232842a5a22515ef4e41636739b1cabcddb933de133a078_v2\", \"builder_747a7ec53b29bd7ea89c813fdb40b171a4f34d5594b7bc052e2217e9a3957ff9_v2\", \"builder_76351fbe332104f381d9951b66f0248416b9cda509fc9dcbaf6ac55a16cc4fba_v2\", \"builder_7ed37cbd131243c1a1f9ef557da6ead56fcfb5fbc05dcfb4114927911952372f_v2\", \"builder_811766b64b8273b43813ff3d29ac40f0b8fd1070074ed1ae4351c12b486595af_v2\", \"builder_84671296ec1ed8a9c1442b402b2805dc5345a6d03ef5bd58708af00cb70779b0_v2\", \"builder_8b1f4643b88abb3d2809d1cf715bd494d7f2e76b679c1144e8459962d5a9b1fe_v2\", \"builder_8c8bfe4a177720f3cdc3d8a926a6526529c5bc999e5099e1156d8ad583c8677f_v2\", \"builder_8ef00b4a8a0ee3b1980af49bd253d1cd799cb68ba0b38eaf035a5976d5f9ca9c_v2\", \"builder_a92c108f11c3d34e9013ba234943c3f4a0463676337d2a29a74e1ad233557df5_v2\", \"builder_ae58da545b16feb8c591c2ad9d44af76e9cb91934fb5831134711d56f167ebc0_v2\", \"builder_b29f6cb9a9748e9edf3a26558b46c81ffe8a5adf46bb4af2939c1531095243d8_v2\", \"builder_b734b1635d9798419e561d721e7ab7ca5a6e0b6220250ebb8b8d3518c34cb0f4_v2\", \"builder_c9989bfe340ab2908fe4b5b4ad665cc175261b929b861cbaeb729bb4e0c0fd3f_v2\", \"builder_d4c8d50107cd91fabf6707d16013c94c2294707f15fb7765243d0d150f8a594c_v2\", \"builder_d8c99dfd56db853acad6eb761d453b584dd650d0aaf8755b052ff87f48c15591_v2\", \"builder_deefd27b3a613dd2e5c4871b28d5ccb6064afe0b497d1c5e0d1faf83735a9792_v2\", \"builder_e1f9954f18035478cd49c9df666e20bb2aa8363b19b712d6e157a0dd73e51cdd_v2\", \"builder_e8d2d44c90d6dd6168a8751e7732a46c861a9b050ff8bfc0c39c1c133184e355_v2\", \"builder_f172317607b2082a0053b1263df18c22c671af461f90153c66f037a4a3d0c4e7_v2\", \"builder_f4d32939a803e1f39954fecbbfd1d5ac5ae16c2c88aecd45cbf3fa3aa591ceca_v2\", \"builder_f848e4fa96b3ee2cb6ef89f22b31816e0d372d03a59f870883f76d0b6b21fbd9_v2\", \"builder_fd5b6657f1d3a2f1a487e0b5530f22908da59be7cac27acc2fc249a9d5248335_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"buildnumber\": 6166, \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"buildername\": \"V8 Linux - full debug\", \"got_revision\": \"2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee\", \"got_swarming_client_revision\": \"7f463e66e1c4bb830ef3de9d046aa227d28e1b00\", \"recipe\": \"v8\", \"mastername\": \"client.v8\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1542626173714553, \"tags\": [\"builder:V8 Linux - full debug\", \"buildset:commit/git/2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee\", \"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9094862995329682816\", \"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\": \"8929432933229405280\"}}, \"got_revision_cp\": \"refs/heads/master@{#57600}\", \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"build_config\": \"Debug\", \"revision\": \"2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee\", \"bot_id\": \"swarm349-c4\"}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1542626410064875",
"status": "COMPLETED",
"status_changed_ts": "1542630092893754",
"tags": [
"build_address:luci.v8.ci/V8 Linux - full debug/6166",
"builder:V8 Linux - full debug",
"buildset:commit/git/2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9094862995329682816",
"scheduler_job_id:v8/V8 Linux - full debug",
"swarming_dimension:caches:builder_3ddc1e6738afb01c19c5328ebf3157ce1f828afa6f9bfedbccf804e743fd73fc_v2",
"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/6166",
"swarming_tag:buildbucket_bucket:v8/ci",
"swarming_tag:buildbucket_build_id:8929432933229405280",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:da5491be675c79d05750cef9051038aa905ddaff",
"swarming_tag:builder:V8 Linux - full debug",
"swarming_tag:buildset:commit/git/2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/2bc9d01ed0998a77a29d5ecd34c0a7e237bfceee",
"swarming_tag:caches:builder_3ddc1e6738afb01c19c5328ebf3157ce1f828afa6f9bfedbccf804e743fd73fc_v2",
"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/8929432933229405280/+/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:9094862995329682816",
"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:7f5ce4d7633892d1ef2fcf6c79071652be2c4013",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:414480ed1c169610",
"user_agent:luci-scheduler"
],
"updated_ts": "1542630092895117",
"url": "https://ci.chromium.org/b/8929432933229405280",
"utcnow_ts": "1542630093248828"
}
}
[12:21:33.265] Invocation finished in 1h5m20.9365405s with status SUCCEEDED