[22:08:32.492] New invocation is queued and will start shortly
[22:08:33.911] Starting the invocation (attempt 1)
[22:08:33.956] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:08:33.956] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:08:33.956] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9097268072002466864",
"parameters_json": "{\"builder_name\":\"V8 Linux - full debug\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"7a975d1116897d5edf508db3def8cb9051390a47\"}}",
"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:9097268072002466864",
"scheduler_job_id:v8/V8 Linux - full debug",
"user_agent:luci-scheduler",
"buildset:commit/git/7a975d1116897d5edf508db3def8cb9051390a47",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/7a975d1116897d5edf508db3def8cb9051390a47",
"gitiles_ref:refs/heads/master"
]
}
[22:08:35.365] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540332514078035",
"id": "8931838009676259536",
"lease_expiration_ts": "1540447715046125",
"lease_key": "446282778",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"7a975d1116897d5edf508db3def8cb9051390a47\"}}",
"project": "v8",
"result_details_json": "null",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1540332515210747",
"tags": [
"build_address:luci.v8.ci/V8 Linux - full debug/5843",
"builder:V8 Linux - full debug",
"buildset:commit/git/7a975d1116897d5edf508db3def8cb9051390a47",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/7a975d1116897d5edf508db3def8cb9051390a47",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097268072002466864",
"scheduler_job_id:v8/V8 Linux - full debug",
"swarming_dimension:caches:builder_9cd6cdf87c7b7be4c5bc6394b239516af5c68a383cd11e92961cffdec8403d43_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/5843",
"swarming_tag:buildbucket_bucket:luci.v8.ci",
"swarming_tag:buildbucket_build_id:8931838009676259536",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:V8 Linux - full debug",
"swarming_tag:buildset:commit/git/7a975d1116897d5edf508db3def8cb9051390a47",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/7a975d1116897d5edf508db3def8cb9051390a47",
"swarming_tag:caches:builder_9cd6cdf87c7b7be4c5bc6394b239516af5c68a383cd11e92961cffdec8403d43_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/8931838009676259536/+/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:9097268072002466864",
"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:2a44b5d8e7a7c817d2f3a9563b498b88001060cb",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40bbca7592221b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1540332515210997",
"url": "https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 Linux - full debug/5843",
"utcnow_ts": "1540332515351842"
}
}
[22:08:35.365] Task URL: https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 Linux - full debug/5843
[22:08:35.365] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:2:0) after 1m0s
[22:09:08.228] Received PubSub notification, asking Buildbucket for the build status
[22:09:08.297] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:35.392] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:2:0)
[22:09:35.392] Timer tick, asking Buildbucket for the build status
[22:09:35.596] Build 8931838009676259536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:09:35.596] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:4:0) after 1m0s
[22:10:35.623] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:4:0)
[22:10:35.623] Timer tick, asking Buildbucket for the build status
[22:10:35.832] Build 8931838009676259536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:10:35.832] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:5:0) after 1m0s
[22:11:05.770] Received PubSub notification, asking Buildbucket for the build status
[22:11:05.866] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:35.851] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:5:0)
[22:11:35.851] Timer tick, asking Buildbucket for the build status
[22:11:35.888] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:35.888] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:7:0) after 1m0s
[22:12:35.909] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:7:0)
[22:12:35.909] Timer tick, asking Buildbucket for the build status
[22:12:35.946] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:35.946] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:8:0) after 1m0s
[22:13:35.969] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:8:0)
[22:13:35.969] Timer tick, asking Buildbucket for the build status
[22:13:36.135] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:36.135] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:9:0) after 1m0s
[22:14:36.210] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:9:0)
[22:14:36.210] Timer tick, asking Buildbucket for the build status
[22:14:36.463] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:36.463] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:10:0) after 1m0s
[22:15:36.484] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:10:0)
[22:15:36.484] Timer tick, asking Buildbucket for the build status
[22:15:36.729] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:36.729] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:11:0) after 1m0s
[22:16:36.755] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:11:0)
[22:16:36.755] Timer tick, asking Buildbucket for the build status
[22:16:36.814] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:36.814] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:12:0) after 1m0s
[22:17:36.841] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:12:0)
[22:17:36.841] Timer tick, asking Buildbucket for the build status
[22:17:36.942] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:36.942] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:13:0) after 1m0s
[22:18:36.960] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:13:0)
[22:18:36.960] Timer tick, asking Buildbucket for the build status
[22:18:37.099] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:37.099] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:14:0) after 1m0s
[22:19:37.117] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:14:0)
[22:19:37.117] Timer tick, asking Buildbucket for the build status
[22:19:37.160] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:37.160] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:15:0) after 1m0s
[22:20:37.177] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:15:0)
[22:20:37.177] Timer tick, asking Buildbucket for the build status
[22:20:37.227] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:37.228] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:16:0) after 1m0s
[22:21:37.289] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:16:0)
[22:21:37.289] Timer tick, asking Buildbucket for the build status
[22:21:37.364] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:37.364] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:17:0) after 1m0s
[22:22:37.390] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:17:0)
[22:22:37.391] Timer tick, asking Buildbucket for the build status
[22:22:37.465] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:37.465] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:18:0) after 1m0s
[22:23:37.519] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:18:0)
[22:23:37.519] Timer tick, asking Buildbucket for the build status
[22:23:37.994] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:37.994] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:19:0) after 1m0s
[22:24:38.040] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:19:0)
[22:24:38.040] Timer tick, asking Buildbucket for the build status
[22:24:38.203] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:38.203] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:20:0) after 1m0s
[22:25:38.227] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:20:0)
[22:25:38.227] Timer tick, asking Buildbucket for the build status
[22:25:38.466] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:38.466] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:21:0) after 1m0s
[22:26:38.487] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:21:0)
[22:26:38.487] Timer tick, asking Buildbucket for the build status
[22:26:38.563] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:38.563] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:22:0) after 1m0s
[22:27:38.585] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:22:0)
[22:27:38.585] Timer tick, asking Buildbucket for the build status
[22:27:38.663] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:38.663] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:23:0) after 1m0s
[22:28:38.680] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:23:0)
[22:28:38.680] Timer tick, asking Buildbucket for the build status
[22:28:39.234] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:39.234] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:24:0) after 1m0s
[22:29:39.254] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:24:0)
[22:29:39.254] Timer tick, asking Buildbucket for the build status
[22:29:39.291] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:39.291] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:25:0) after 1m0s
[22:30:39.319] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:25:0)
[22:30:39.319] Timer tick, asking Buildbucket for the build status
[22:30:39.471] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:39.471] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:26:0) after 1m0s
[22:31:39.490] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:26:0)
[22:31:39.490] Timer tick, asking Buildbucket for the build status
[22:31:39.531] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:39.532] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:27:0) after 1m0s
[22:32:39.553] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:27:0)
[22:32:39.553] Timer tick, asking Buildbucket for the build status
[22:32:39.684] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:39.684] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:28:0) after 1m0s
[22:33:39.702] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:28:0)
[22:33:39.702] Timer tick, asking Buildbucket for the build status
[22:33:39.745] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:39.745] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:29:0) after 1m0s
[22:34:39.787] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:29:0)
[22:34:39.787] Timer tick, asking Buildbucket for the build status
[22:34:39.873] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:39.873] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:30:0) after 1m0s
[22:35:39.889] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:30:0)
[22:35:39.889] Timer tick, asking Buildbucket for the build status
[22:35:39.956] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:39.956] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:31:0) after 1m0s
[22:36:39.983] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:31:0)
[22:36:39.983] Timer tick, asking Buildbucket for the build status
[22:36:40.048] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:40.048] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:32:0) after 1m0s
[22:37:40.073] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:32:0)
[22:37:40.073] Timer tick, asking Buildbucket for the build status
[22:37:40.140] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:40.141] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:33:0) after 1m0s
[22:38:40.160] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:33:0)
[22:38:40.160] Timer tick, asking Buildbucket for the build status
[22:38:40.495] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:40.495] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:34:0) after 1m0s
[22:39:40.513] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:34:0)
[22:39:40.513] Timer tick, asking Buildbucket for the build status
[22:39:40.553] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:40.553] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:35:0) after 1m0s
[22:40:40.585] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:35:0)
[22:40:40.585] Timer tick, asking Buildbucket for the build status
[22:40:40.631] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:40.631] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:36:0) after 1m0s
[22:41:40.684] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:36:0)
[22:41:40.684] Timer tick, asking Buildbucket for the build status
[22:41:40.734] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:40.734] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:37:0) after 1m0s
[22:42:40.761] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:37:0)
[22:42:40.761] Timer tick, asking Buildbucket for the build status
[22:42:40.922] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:40.922] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:38:0) after 1m0s
[22:43:40.956] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:38:0)
[22:43:40.956] Timer tick, asking Buildbucket for the build status
[22:43:41.006] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:41.006] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:39:0) after 1m0s
[22:44:41.026] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:39:0)
[22:44:41.026] Timer tick, asking Buildbucket for the build status
[22:44:41.175] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:41.175] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:40:0) after 1m0s
[22:45:41.222] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:40:0)
[22:45:41.222] Timer tick, asking Buildbucket for the build status
[22:45:41.264] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:41.264] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:41:0) after 1m0s
[22:46:41.291] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:41:0)
[22:46:41.291] Timer tick, asking Buildbucket for the build status
[22:46:41.351] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:41.351] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:42:0) after 1m0s
[22:47:41.373] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:42:0)
[22:47:41.373] Timer tick, asking Buildbucket for the build status
[22:47:41.420] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:41.420] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:43:0) after 1m0s
[22:48:41.502] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:43:0)
[22:48:41.502] Timer tick, asking Buildbucket for the build status
[22:48:41.632] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:41.632] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:44:0) after 1m0s
[22:49:41.660] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:44:0)
[22:49:41.660] Timer tick, asking Buildbucket for the build status
[22:49:41.710] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:41.710] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:45:0) after 1m0s
[22:50:41.741] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:45:0)
[22:50:41.741] Timer tick, asking Buildbucket for the build status
[22:50:41.796] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:41.796] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:46:0) after 1m0s
[22:51:41.869] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:46:0)
[22:51:41.869] Timer tick, asking Buildbucket for the build status
[22:51:41.953] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:41.953] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:47:0) after 1m0s
[22:52:41.972] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:47:0)
[22:52:41.972] Timer tick, asking Buildbucket for the build status
[22:52:42.266] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:42.266] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:48:0) after 1m0s
[22:53:42.313] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:48:0)
[22:53:42.313] Timer tick, asking Buildbucket for the build status
[22:53:42.420] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:42.420] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:49:0) after 1m0s
[22:54:42.442] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:49:0)
[22:54:42.442] Timer tick, asking Buildbucket for the build status
[22:54:42.486] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:42.486] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:50:0) after 1m0s
[22:55:42.600] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:50:0)
[22:55:42.600] Timer tick, asking Buildbucket for the build status
[22:55:42.636] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:42.636] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:51:0) after 1m0s
[22:56:42.674] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:51:0)
[22:56:42.674] Timer tick, asking Buildbucket for the build status
[22:56:42.724] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:42.724] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:52:0) after 1m0s
[22:57:42.744] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:52:0)
[22:57:42.744] Timer tick, asking Buildbucket for the build status
[22:57:42.800] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:42.800] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:53:0) after 1m0s
[22:58:42.880] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:53:0)
[22:58:42.880] Timer tick, asking Buildbucket for the build status
[22:58:43.006] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:43.006] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:54:0) after 1m0s
[22:59:43.028] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:54:0)
[22:59:43.028] Timer tick, asking Buildbucket for the build status
[22:59:43.366] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:43.366] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:55:0) after 1m0s
[23:00:43.399] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:55:0)
[23:00:43.399] Timer tick, asking Buildbucket for the build status
[23:00:43.461] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:43.461] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:56:0) after 1m0s
[23:01:43.478] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:56:0)
[23:01:43.478] Timer tick, asking Buildbucket for the build status
[23:01:43.566] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:43.566] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:57:0) after 1m0s
[23:02:43.595] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:57:0)
[23:02:43.595] Timer tick, asking Buildbucket for the build status
[23:02:43.649] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:43.649] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:58:0) after 1m0s
[23:03:43.674] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:58:0)
[23:03:43.674] Timer tick, asking Buildbucket for the build status
[23:03:43.820] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:43.821] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:59:0) after 1m0s
[23:04:43.851] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:59:0)
[23:04:43.851] Timer tick, asking Buildbucket for the build status
[23:04:43.971] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:43.971] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:60:0) after 1m0s
[23:05:43.990] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:60:0)
[23:05:43.990] Timer tick, asking Buildbucket for the build status
[23:05:44.139] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:44.139] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:61:0) after 1m0s
[23:06:44.279] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:61:0)
[23:06:44.279] Timer tick, asking Buildbucket for the build status
[23:06:44.365] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:44.365] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:62:0) after 1m0s
[23:07:44.500] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:62:0)
[23:07:44.500] Timer tick, asking Buildbucket for the build status
[23:07:44.583] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:44.583] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:63:0) after 1m0s
[23:08:44.762] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:63:0)
[23:08:44.762] Timer tick, asking Buildbucket for the build status
[23:08:44.869] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:44.869] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:64:0) after 1m0s
[23:09:44.962] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:64:0)
[23:09:44.962] Timer tick, asking Buildbucket for the build status
[23:09:45.045] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:45.045] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:65:0) after 1m0s
[23:10:45.077] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:65:0)
[23:10:45.077] Timer tick, asking Buildbucket for the build status
[23:10:45.140] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:45.141] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:66:0) after 1m0s
[23:11:45.218] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:66:0)
[23:11:45.218] Timer tick, asking Buildbucket for the build status
[23:11:45.319] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:45.319] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:67:0) after 1m0s
[23:12:45.368] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:67:0)
[23:12:45.368] Timer tick, asking Buildbucket for the build status
[23:12:45.456] Build 8931838009676259536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:45.456] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9097268072002466864:68:0) after 1m0s
[23:13:31.364] Received PubSub notification, asking Buildbucket for the build status
[23:13:31.412] Build 8931838009676259536: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:13:31.412] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1540336410003653",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540332514078035",
"id": "8931838009676259536",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"7a975d1116897d5edf508db3def8cb9051390a47\"}}",
"project": "v8",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"kvm\": [\"1\"], \"gpu\": [\"none\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3817-6aedaff\"], \"machine_type\": [\"n1-standard-8\"], \"host_class\": [\"default\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"swarm424-c4\"], \"pool\": [\"luci.v8.ci\"], \"caches\": [\"builder_09f33a749e659f114e86886ab3d8f33cac3788b6c4007abc3a1743a531a635cd_v2\", \"builder_0d3f246d10cb46330191fca35d969255136e6047e1143766d300f136b362b785_v2\", \"builder_0d593ee5aa3cf9dabcc2383ca6866d4a1d75fbc9d5b6881380b2a0d6835e6902_v2\", \"builder_0f400c48389e22d31c79c9d55cc2718a2af1c8414b286639bcdd377c1271926f_v2\", \"builder_13138f9e729092e71eb13ae6b13dd5178bbb184fb94d35390dc534255c4f8214_v2\", \"builder_199e15f2909213868b5d6a1a7359c0fe18b6b63573b85d52694558455a1d852c_v2\", \"builder_1fa59d8aa528e1e433e1a19fe2ab84522a322df079c647ba83dbc11395f1153f_v2\", \"builder_26a48cc87f17ce7957e9c14c97555a0e25f02f7667651daa5fe9505b367a369e_v2\", \"builder_2f21895df9bc873580ae930152de1cb506fbe4d990f9f6e1a2c9716ae74f393b_v2\", \"builder_310d90edfd68e72473acbfaa3524469048c24dc0d5b8eb217b4f24559fbd57f9_v2\", \"builder_37cd46001166294fa2187097f5e27316d0a3aedc6cadc8641809f4a7f20ba893_v2\", \"builder_383d1746f47e597dc0a409ac8ed11947882b67d14eabbaaa94c7dcbbd0d5a82b_v2\", \"builder_428164317b558f5753e2a39f0938b3df7d3a343c745e09c8f5eba3712ec57710_v2\", \"builder_478749f17381fe5fcbfd9933f1a7c5b8524aab2a32975ea43e8a497ba4d516a0_v2\", \"builder_4ff39610807516a7f79bc234e827579f245ad6b4c0ca867a80566991642d76f2_v2\", \"builder_5065fb4b532a6ed5ac2f311fc138e13fc59f7cca7bad8bfbf884f97671212ccb_v2\", \"builder_5a67369fddbade6dab3059fef0b25253ac32788b8dd17172ccec94449b615b97_v2\", \"builder_5cd57ff09bc176c74999080dd249dfc5d651a5e179040f09fc9c0193bd8abf24_v2\", \"builder_5d785600393096d51dde3b33f72226925c85e34616ed52893b4a22f58cb62ffe_v2\", \"builder_5f93e2294e3f53b65ad2aa7ee4c1e3e92578e63e62508173fbff659f306a61d7_v2\", \"builder_67e05df6f475288c71eac33e1fe4e86c20b62be5c9403a6e253d36598b254339_v2\", \"builder_6835a67d7ea73eaa30b8b54fda1f7f7ac830440b879302d164e12cbdbf1ab09e_v2\", \"builder_6ed438e828611c4e00215b639e4003f704cece86146766ee8b208b9bbceb0ee7_v2\", \"builder_762fc5caf6e589d23242c1f177533e856b5a225dc6e3f4747ed113ab3039b601_v2\", \"builder_78955e369eba41b6a3de99ca48d55d7116f6b0666a1b6b7539a4cd765288ceda_v2\", \"builder_825364b3d22fd72e64cc529ea04169d5b52547a634aae9944857084ec0a72d56_v2\", \"builder_8b4894ea8a9e171166fe846bbe50480646a6c2e3936d75fdb998c40e4207e60c_v2\", \"builder_99713025433303b519468812972cb3051039eebe65d726417a2577dcb40aafc0_v2\", \"builder_9cd6cdf87c7b7be4c5bc6394b239516af5c68a383cd11e92961cffdec8403d43_v2\", \"builder_abd5fc0df1a2b4811582d2f5c8e46b499d34b7e47e71450c63862d6ca6536ff3_v2\", \"builder_ac28d79f9b08d1c61f9e78ff2c943b9977977ff9784747ddc0ce0414c13b1981_v2\", \"builder_ac3c2c95ee9d0393f1c973dfa0d9b662d5d4f342d43628552856b54316dc09f4_v2\", \"builder_ad960b15a90962e52694b875d512c3db2015a7405c9ee457d20ee5d26470f5dc_v2\", \"builder_aeaceb7844fe871dc347bc8f9b97effb099ca44d1c670bf6ad89e3b916ebff1c_v2\", \"builder_b3be2ddb8b3909c86eb2f2e351f8c9ee4bd1d62a664e9dfdfe991faa015f31f4_v2\", \"builder_b8b11a58fe29ef6689b6058dff68ae0368936186a954e797667a5c8c95a3e18b_v2\", \"builder_bbf7d8c9645a5130bc0bf95ed2d2144340aedcb5d9c77e55885ef84b1bb499b8_v2\", \"builder_bd00e44002d3851655480955e12a74ba78a239d0bfca74437969a38cbcd16dd1_v2\", \"builder_cc8970c982910222dcd3677298b219e4c72bce31e54e3cf55c7285243a24bdc8_v2\", \"builder_cd5bd5d890c446f4d5e8e10bf1e58037146789300db5235094bfebe7993a6326_v2\", \"builder_d30338df262dc89f14436f3e60ba7f14b8b61d3f37a567b4f660820b0b98420c_v2\", \"builder_de11313f0ea94497dc267ca9e80b63a840a5d67ed4be3134da2ea43a778a9b30_v2\", \"builder_e68437fdb179fa80d04625a4d057e4631be49f278063fa762ab2eda2887336cf_v2\", \"builder_ef643481e043df3436a061274eacb219079f520ac32eee4906eece985ca76d0b_v2\", \"builder_f0a022c5310063eef96c9e5181ecc7ab364e2841ec527f1932fd765b150ef87c_v2\", \"builder_f32e7fe2e8c3dd59c8b6f138e46038b32f4d057bd48fb2350a0b2b12b6624ff5_v2\", \"builder_f50a38a96ac302413037c2ca6414dfb93f641a01f22b2d3448985320d72a9bbb_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\": 5843, \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"buildername\": \"V8 Linux - full debug\", \"got_revision\": \"7a975d1116897d5edf508db3def8cb9051390a47\", \"got_swarming_client_revision\": \"f78187ab77127de42555afe0ad410bebde6ac6a5\", \"recipe\": \"v8\", \"mastername\": \"client.v8\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1540332514078035, \"tags\": [\"builder:V8 Linux - full debug\", \"buildset:commit/git/7a975d1116897d5edf508db3def8cb9051390a47\", \"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/7a975d1116897d5edf508db3def8cb9051390a47\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9097268072002466864\", \"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\": \"8931838009676259536\"}}, \"got_revision_cp\": \"refs/heads/master@{#56915}\", \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"7a975d1116897d5edf508db3def8cb9051390a47\", \"bot_id\": \"swarm424-c4\"}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1540332547210658",
"status": "COMPLETED",
"status_changed_ts": "1540336410847321",
"tags": [
"build_address:luci.v8.ci/V8 Linux - full debug/5843",
"builder:V8 Linux - full debug",
"buildset:commit/git/7a975d1116897d5edf508db3def8cb9051390a47",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/7a975d1116897d5edf508db3def8cb9051390a47",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097268072002466864",
"scheduler_job_id:v8/V8 Linux - full debug",
"swarming_dimension:caches:builder_9cd6cdf87c7b7be4c5bc6394b239516af5c68a383cd11e92961cffdec8403d43_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/5843",
"swarming_tag:buildbucket_bucket:luci.v8.ci",
"swarming_tag:buildbucket_build_id:8931838009676259536",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:V8 Linux - full debug",
"swarming_tag:buildset:commit/git/7a975d1116897d5edf508db3def8cb9051390a47",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/7a975d1116897d5edf508db3def8cb9051390a47",
"swarming_tag:caches:builder_9cd6cdf87c7b7be4c5bc6394b239516af5c68a383cd11e92961cffdec8403d43_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/8931838009676259536/+/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:9097268072002466864",
"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:2a44b5d8e7a7c817d2f3a9563b498b88001060cb",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40bbca7592221b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1540336410849201",
"url": "https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 Linux - full debug/5843",
"utcnow_ts": "1540336411395422"
}
}
[23:13:31.412] Invocation finished in 1h4m58.936265718s with status SUCCEEDED