[19:46:44.309] New invocation is queued and will start shortly
[19:46:45.574] Starting the invocation (attempt 1)
[19:46:45.660] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:46:45.660] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:46:45.660] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9099088932806216560",
"parameters_json": "{\"builder_name\":\"V8 Linux - full debug\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"ab6462e8838f11faec130abf12d7bfb13600f265\"}}",
"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:9099088932806216560",
"scheduler_job_id:v8/V8 Linux - full debug",
"user_agent:luci-scheduler",
"buildset:commit/git/ab6462e8838f11faec130abf12d7bfb13600f265",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/ab6462e8838f11faec130abf12d7bfb13600f265",
"gitiles_ref:refs/heads/master"
]
}
[19:46:48.304] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1538596005787214",
"id": "8933658870593726608",
"lease_expiration_ts": "1538711207921058",
"lease_key": "1127531513",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"ab6462e8838f11faec130abf12d7bfb13600f265\"}}",
"project": "v8",
"result_details_json": "null",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1538596008171464",
"tags": [
"build_address:luci.v8.ci/V8 Linux - full debug/5654",
"builder:V8 Linux - full debug",
"buildset:commit/git/ab6462e8838f11faec130abf12d7bfb13600f265",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/ab6462e8838f11faec130abf12d7bfb13600f265",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9099088932806216560",
"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/5654",
"swarming_tag:buildbucket_bucket:luci.v8.ci",
"swarming_tag:buildbucket_build_id:8933658870593726608",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:V8 Linux - full debug",
"swarming_tag:buildset:commit/git/ab6462e8838f11faec130abf12d7bfb13600f265",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/ab6462e8838f11faec130abf12d7bfb13600f265",
"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/8933658870593726608/+/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:9099088932806216560",
"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:d431f79a1f9890266786724a5b445a445f332a3a",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:405449766b943810",
"user_agent:luci-scheduler"
],
"updated_ts": "1538596008171590",
"url": "https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 Linux - full debug/5654",
"utcnow_ts": "1538596008282134"
}
}
[19:46:48.304] Task URL: https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 Linux - full debug/5654
[19:46:48.304] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:2:0) after 1m0s
[19:47:48.339] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:2:0)
[19:47:48.339] Timer tick, asking Buildbucket for the build status
[19:47:48.400] Build 8933658870593726608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:47:48.400] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:3:0) after 1m0s
[19:48:48.485] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:3:0)
[19:48:48.485] Timer tick, asking Buildbucket for the build status
[19:48:48.522] Build 8933658870593726608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:48.522] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:4:0) after 1m0s
[19:49:48.639] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:4:0)
[19:49:48.639] Timer tick, asking Buildbucket for the build status
[19:49:48.733] Build 8933658870593726608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:48.733] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:5:0) after 1m0s
[19:49:54.990] Received PubSub notification, asking Buildbucket for the build status
[19:49:55.067] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:48.788] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:5:0)
[19:50:48.788] Timer tick, asking Buildbucket for the build status
[19:50:48.830] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:48.830] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:7:0) after 1m0s
[19:51:48.851] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:7:0)
[19:51:48.851] Timer tick, asking Buildbucket for the build status
[19:51:48.940] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:48.941] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:8:0) after 1m0s
[19:52:48.959] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:8:0)
[19:52:48.959] Timer tick, asking Buildbucket for the build status
[19:52:49.008] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:49.008] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:9:0) after 1m0s
[19:53:49.131] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:9:0)
[19:53:49.131] Timer tick, asking Buildbucket for the build status
[19:53:50.539] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:50.539] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:10:0) after 1m0s
[19:54:50.560] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:10:0)
[19:54:50.560] Timer tick, asking Buildbucket for the build status
[19:54:50.607] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:50.607] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:11:0) after 1m0s
[19:55:50.639] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:11:0)
[19:55:50.639] Timer tick, asking Buildbucket for the build status
[19:55:50.812] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:50.812] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:12:0) after 1m0s
[19:56:50.836] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:12:0)
[19:56:50.836] Timer tick, asking Buildbucket for the build status
[19:56:50.884] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:50.884] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:13:0) after 1m0s
[19:57:50.918] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:13:0)
[19:57:50.918] Timer tick, asking Buildbucket for the build status
[19:57:51.062] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:51.062] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:14:0) after 1m0s
[19:58:51.099] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:14:0)
[19:58:51.099] Timer tick, asking Buildbucket for the build status
[19:58:51.197] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:51.197] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:15:0) after 1m0s
[19:59:51.213] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:15:0)
[19:59:51.213] Timer tick, asking Buildbucket for the build status
[19:59:51.292] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:51.292] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:16:0) after 1m0s
[20:00:51.321] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:16:0)
[20:00:51.321] Timer tick, asking Buildbucket for the build status
[20:00:51.425] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:51.425] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:17:0) after 1m0s
[20:01:51.480] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:17:0)
[20:01:51.480] Timer tick, asking Buildbucket for the build status
[20:01:51.545] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:51.545] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:18:0) after 1m0s
[20:02:51.598] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:18:0)
[20:02:51.598] Timer tick, asking Buildbucket for the build status
[20:02:51.648] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:51.648] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:19:0) after 1m0s
[20:03:51.675] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:19:0)
[20:03:51.675] Timer tick, asking Buildbucket for the build status
[20:03:51.753] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:51.753] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:20:0) after 1m0s
[20:04:51.775] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:20:0)
[20:04:51.775] Timer tick, asking Buildbucket for the build status
[20:04:51.924] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:51.924] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:21:0) after 1m0s
[20:05:52.032] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:21:0)
[20:05:52.032] Timer tick, asking Buildbucket for the build status
[20:05:52.071] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:52.071] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:22:0) after 1m0s
[20:06:52.150] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:22:0)
[20:06:52.150] Timer tick, asking Buildbucket for the build status
[20:06:52.186] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:52.186] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:23:0) after 1m0s
[20:07:52.218] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:23:0)
[20:07:52.218] Timer tick, asking Buildbucket for the build status
[20:07:52.268] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:52.268] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:24:0) after 1m0s
[20:08:52.298] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:24:0)
[20:08:52.298] Timer tick, asking Buildbucket for the build status
[20:08:52.412] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:52.412] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:25:0) after 1m0s
[20:09:52.497] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:25:0)
[20:09:52.497] Timer tick, asking Buildbucket for the build status
[20:09:52.538] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:52.539] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:26:0) after 1m0s
[20:10:52.595] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:26:0)
[20:10:52.595] Timer tick, asking Buildbucket for the build status
[20:10:52.643] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:52.643] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:27:0) after 1m0s
[20:11:52.684] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:27:0)
[20:11:52.684] Timer tick, asking Buildbucket for the build status
[20:11:52.753] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:52.753] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:28:0) after 1m0s
[20:12:52.791] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:28:0)
[20:12:52.791] Timer tick, asking Buildbucket for the build status
[20:12:52.841] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:52.841] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:29:0) after 1m0s
[20:13:52.863] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:29:0)
[20:13:52.863] Timer tick, asking Buildbucket for the build status
[20:13:53.006] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:53.006] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:30:0) after 1m0s
[20:14:53.066] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:30:0)
[20:14:53.066] Timer tick, asking Buildbucket for the build status
[20:14:53.106] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:53.106] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:31:0) after 1m0s
[20:15:53.128] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:31:0)
[20:15:53.128] Timer tick, asking Buildbucket for the build status
[20:15:53.186] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:53.186] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:32:0) after 1m0s
[20:16:53.203] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:32:0)
[20:16:53.203] Timer tick, asking Buildbucket for the build status
[20:16:53.249] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:53.249] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:33:0) after 1m0s
[20:17:53.270] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:33:0)
[20:17:53.270] Timer tick, asking Buildbucket for the build status
[20:17:53.306] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:53.306] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:34:0) after 1m0s
[20:18:53.327] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:34:0)
[20:18:53.327] Timer tick, asking Buildbucket for the build status
[20:18:53.397] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:53.398] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:35:0) after 1m0s
[20:19:53.425] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:35:0)
[20:19:53.425] Timer tick, asking Buildbucket for the build status
[20:19:53.484] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:53.484] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:36:0) after 1m0s
[20:20:53.503] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:36:0)
[20:20:53.503] Timer tick, asking Buildbucket for the build status
[20:20:53.530] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:53.530] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:37:0) after 1m0s
[20:21:53.550] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:37:0)
[20:21:53.550] Timer tick, asking Buildbucket for the build status
[20:21:53.620] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:53.620] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:38:0) after 1m0s
[20:22:53.640] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:38:0)
[20:22:53.640] Timer tick, asking Buildbucket for the build status
[20:22:53.679] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:53.679] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:39:0) after 1m0s
[20:23:53.698] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:39:0)
[20:23:53.698] Timer tick, asking Buildbucket for the build status
[20:23:53.732] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:53.732] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:40:0) after 1m0s
[20:24:53.749] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:40:0)
[20:24:53.749] Timer tick, asking Buildbucket for the build status
[20:24:53.821] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:53.821] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:41:0) after 1m0s
[20:25:53.837] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:41:0)
[20:25:53.837] Timer tick, asking Buildbucket for the build status
[20:25:53.868] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:53.868] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:42:0) after 1m0s
[20:26:53.891] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:42:0)
[20:26:53.891] Timer tick, asking Buildbucket for the build status
[20:26:53.964] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:53.964] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:43:0) after 1m0s
[20:27:53.984] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:43:0)
[20:27:53.984] Timer tick, asking Buildbucket for the build status
[20:27:54.059] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:54.059] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:44:0) after 1m0s
[20:28:54.081] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:44:0)
[20:28:54.081] Timer tick, asking Buildbucket for the build status
[20:28:54.156] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:54.156] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:45:0) after 1m0s
[20:29:54.193] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:45:0)
[20:29:54.193] Timer tick, asking Buildbucket for the build status
[20:29:54.268] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:54.268] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:46:0) after 1m0s
[20:30:54.308] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:46:0)
[20:30:54.308] Timer tick, asking Buildbucket for the build status
[20:30:54.374] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:54.374] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:47:0) after 1m0s
[20:31:54.400] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:47:0)
[20:31:54.400] Timer tick, asking Buildbucket for the build status
[20:31:54.462] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:54.462] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:48:0) after 1m0s
[20:32:54.484] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:48:0)
[20:32:54.484] Timer tick, asking Buildbucket for the build status
[20:32:54.589] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:54.589] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:49:0) after 1m0s
[20:33:54.617] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:49:0)
[20:33:54.617] Timer tick, asking Buildbucket for the build status
[20:33:54.672] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:54.672] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:50:0) after 1m0s
[20:34:54.716] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:50:0)
[20:34:54.716] Timer tick, asking Buildbucket for the build status
[20:34:54.807] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:54.807] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:51:0) after 1m0s
[20:35:54.829] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:51:0)
[20:35:54.829] Timer tick, asking Buildbucket for the build status
[20:35:54.870] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:54.870] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:52:0) after 1m0s
[20:36:54.897] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:52:0)
[20:36:54.897] Timer tick, asking Buildbucket for the build status
[20:36:54.937] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:54.937] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:53:0) after 1m0s
[20:37:54.980] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:53:0)
[20:37:54.981] Timer tick, asking Buildbucket for the build status
[20:37:55.079] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:55.079] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:54:0) after 1m0s
[20:38:55.100] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:54:0)
[20:38:55.100] Timer tick, asking Buildbucket for the build status
[20:38:55.222] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:55.222] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:55:0) after 1m0s
[20:39:55.247] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:55:0)
[20:39:55.247] Timer tick, asking Buildbucket for the build status
[20:39:55.291] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:55.291] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:56:0) after 1m0s
[20:40:55.312] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:56:0)
[20:40:55.312] Timer tick, asking Buildbucket for the build status
[20:40:55.427] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:55.427] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:57:0) after 1m0s
[20:41:55.481] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:57:0)
[20:41:55.481] Timer tick, asking Buildbucket for the build status
[20:41:55.521] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:55.521] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:58:0) after 1m0s
[20:42:55.547] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:58:0)
[20:42:55.547] Timer tick, asking Buildbucket for the build status
[20:42:55.588] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:55.588] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:59:0) after 1m0s
[20:43:55.679] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:59:0)
[20:43:55.679] Timer tick, asking Buildbucket for the build status
[20:43:55.754] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:55.754] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:60:0) after 1m0s
[20:44:55.774] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:60:0)
[20:44:55.774] Timer tick, asking Buildbucket for the build status
[20:44:55.957] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:55.957] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:61:0) after 1m0s
[20:45:55.997] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:61:0)
[20:45:55.997] Timer tick, asking Buildbucket for the build status
[20:45:56.058] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:56.058] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:62:0) after 1m0s
[20:46:56.082] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:62:0)
[20:46:56.082] Timer tick, asking Buildbucket for the build status
[20:46:56.120] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:56.120] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:63:0) after 1m0s
[20:47:56.148] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:63:0)
[20:47:56.148] Timer tick, asking Buildbucket for the build status
[20:47:56.200] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:56.200] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:64:0) after 1m0s
[20:48:56.235] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:64:0)
[20:48:56.235] Timer tick, asking Buildbucket for the build status
[20:48:56.303] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:56.303] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:65:0) after 1m0s
[20:49:56.329] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:65:0)
[20:49:56.329] Timer tick, asking Buildbucket for the build status
[20:49:56.361] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:56.361] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:66:0) after 1m0s
[20:50:56.388] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:66:0)
[20:50:56.388] Timer tick, asking Buildbucket for the build status
[20:50:56.423] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:56.423] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:67:0) after 1m0s
[20:51:56.451] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:67:0)
[20:51:56.452] Timer tick, asking Buildbucket for the build status
[20:51:56.495] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:56.495] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:68:0) after 1m0s
[20:52:56.534] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:68:0)
[20:52:56.534] Timer tick, asking Buildbucket for the build status
[20:52:56.645] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:56.645] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:69:0) after 1m0s
[20:53:56.670] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:69:0)
[20:53:56.670] Timer tick, asking Buildbucket for the build status
[20:53:56.778] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:56.778] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:70:0) after 1m0s
[20:54:56.815] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:70:0)
[20:54:56.815] Timer tick, asking Buildbucket for the build status
[20:54:56.972] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:56.972] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:71:0) after 1m0s
[20:55:57.007] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:71:0)
[20:55:57.007] Timer tick, asking Buildbucket for the build status
[20:55:57.101] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:57.101] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:72:0) after 1m0s
[20:56:57.120] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:72:0)
[20:56:57.120] Timer tick, asking Buildbucket for the build status
[20:56:57.192] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:57.192] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:73:0) after 1m0s
[20:57:57.222] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:73:0)
[20:57:57.222] Timer tick, asking Buildbucket for the build status
[20:57:57.633] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:57.633] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:74:0) after 1m0s
[20:58:57.668] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:74:0)
[20:58:57.668] Timer tick, asking Buildbucket for the build status
[20:58:57.705] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:57.705] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:75:0) after 1m0s
[20:59:57.736] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:75:0)
[20:59:57.736] Timer tick, asking Buildbucket for the build status
[20:59:57.783] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:57.783] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:76:0) after 1m0s
[21:00:57.818] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:76:0)
[21:00:57.818] Timer tick, asking Buildbucket for the build status
[21:00:58.028] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:58.029] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:77:0) after 1m0s
[21:01:58.056] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:77:0)
[21:01:58.056] Timer tick, asking Buildbucket for the build status
[21:01:58.092] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:58.092] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:78:0) after 1m0s
[21:02:58.117] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:78:0)
[21:02:58.117] Timer tick, asking Buildbucket for the build status
[21:02:58.219] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:58.219] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:79:0) after 1m0s
[21:03:58.251] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:79:0)
[21:03:58.251] Timer tick, asking Buildbucket for the build status
[21:03:58.289] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:58.290] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:80:0) after 1m0s
[21:04:58.377] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:80:0)
[21:04:58.377] Timer tick, asking Buildbucket for the build status
[21:04:58.537] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:58.537] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:81:0) after 1m0s
[21:05:58.571] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:81:0)
[21:05:58.571] Timer tick, asking Buildbucket for the build status
[21:05:58.633] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:58.633] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:82:0) after 1m0s
[21:06:58.677] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:82:0)
[21:06:58.677] Timer tick, asking Buildbucket for the build status
[21:06:58.750] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:58.750] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:83:0) after 1m0s
[21:07:58.890] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:83:0)
[21:07:58.890] Timer tick, asking Buildbucket for the build status
[21:07:58.971] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:58.971] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:84:0) after 1m0s
[21:08:58.992] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:84:0)
[21:08:58.992] Timer tick, asking Buildbucket for the build status
[21:08:59.050] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:59.050] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:85:0) after 1m0s
[21:09:59.093] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:85:0)
[21:09:59.093] Timer tick, asking Buildbucket for the build status
[21:09:59.184] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:59.184] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:86:0) after 1m0s
[21:10:59.206] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:86:0)
[21:10:59.206] Timer tick, asking Buildbucket for the build status
[21:10:59.242] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:59.242] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:87:0) after 1m0s
[21:11:59.283] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:87:0)
[21:11:59.283] Timer tick, asking Buildbucket for the build status
[21:11:59.328] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:59.328] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:88:0) after 1m0s
[21:12:59.351] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:88:0)
[21:12:59.351] Timer tick, asking Buildbucket for the build status
[21:12:59.440] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:59.440] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:89:0) after 1m0s
[21:13:59.462] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:89:0)
[21:13:59.462] Timer tick, asking Buildbucket for the build status
[21:13:59.514] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:59.514] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:90:0) after 1m0s
[21:14:59.543] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:90:0)
[21:14:59.543] Timer tick, asking Buildbucket for the build status
[21:14:59.586] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:59.586] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:91:0) after 1m0s
[21:15:59.678] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:91:0)
[21:15:59.678] Timer tick, asking Buildbucket for the build status
[21:15:59.828] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:59.828] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:92:0) after 1m0s
[21:16:59.852] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:92:0)
[21:16:59.852] Timer tick, asking Buildbucket for the build status
[21:17:00.275] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:00.275] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:93:0) after 1m0s
[21:18:00.303] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:93:0)
[21:18:00.303] Timer tick, asking Buildbucket for the build status
[21:18:00.341] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:00.341] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:94:0) after 1m0s
[21:19:00.380] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:94:0)
[21:19:00.380] Timer tick, asking Buildbucket for the build status
[21:19:00.418] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:00.418] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:95:0) after 1m0s
[21:20:00.472] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:95:0)
[21:20:00.472] Timer tick, asking Buildbucket for the build status
[21:20:00.576] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:00.576] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:96:0) after 1m0s
[21:21:00.616] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:96:0)
[21:21:00.616] Timer tick, asking Buildbucket for the build status
[21:21:00.691] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:00.691] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:97:0) after 1m0s
[21:22:00.713] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:97:0)
[21:22:00.713] Timer tick, asking Buildbucket for the build status
[21:22:00.897] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:00.897] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:98:0) after 1m0s
[21:23:00.973] Handling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:98:0)
[21:23:00.973] Timer tick, asking Buildbucket for the build status
[21:23:01.106] Build 8933658870593726608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:01.106] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux - full debug:9099088932806216560:99:0) after 1m0s
[21:23:38.692] Received PubSub notification, asking Buildbucket for the build status
[21:23:38.763] Build 8933658870593726608: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:23:38.763] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "AUTO",
"completed_ts": "1538601817470740",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1538596005787214",
"id": "8933658870593726608",
"parameters_json": "{\"builder_name\": \"V8 Linux - full debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"ab6462e8838f11faec130abf12d7bfb13600f265\"}}",
"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/8933658870593726608/+/annotations\"}, \"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\": [\"3801-8761768\"], \"machine_type\": [\"n1-standard-8\"], \"host_class\": [\"default\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"swarm347-c4\"], \"pool\": [\"luci.v8.ci\"], \"caches\": [\"builder_09f33a749e659f114e86886ab3d8f33cac3788b6c4007abc3a1743a531a635cd_v2\", \"builder_0d2dfaac3b021b56dd6690c6e8bb90a0c6fffff02572a51f33961ae816cb76a8_v2\", \"builder_0d3f246d10cb46330191fca35d969255136e6047e1143766d300f136b362b785_v2\", \"builder_195a7061e86da43c0e4b7e8111b9cd77115f02f5451c411c16498294f4d01606_v2\", \"builder_199e15f2909213868b5d6a1a7359c0fe18b6b63573b85d52694558455a1d852c_v2\", \"builder_1bb44dd0c7e49c4f8acac99e06a8aae69c59ba9a190677d7c7969fb9441d0016_v2\", \"builder_1bfefd1dd1cce64113c5642e43efcd98b90a48965fab021697420f685ef79cbf_v2\", \"builder_2f21895df9bc873580ae930152de1cb506fbe4d990f9f6e1a2c9716ae74f393b_v2\", \"builder_322c13be6a4fc0eb79cc2dc0eeca30d857ecc40cac7a944bfd6a404599989d21_v2\", \"builder_37cd46001166294fa2187097f5e27316d0a3aedc6cadc8641809f4a7f20ba893_v2\", \"builder_3db5e1b6b0647e7d9f8cc4e1bff4fe3e76258618fe20b2551da6ab5c5ef76653_v2\", \"builder_41f1247bbcab38c4748e3f8e434f42b6c708cfc487a9e1d55fbd9dd2fd2c405b_v2\", \"builder_47fc71ef057c0307c0d282d85c63a0ffb939fb092fce19eb8547766042fb9c64_v2\", \"builder_4d3ea79d0dc85294f6eab683648d103750714f5c171e96b3b64a06b20e42dedf_v2\", \"builder_5065fb4b532a6ed5ac2f311fc138e13fc59f7cca7bad8bfbf884f97671212ccb_v2\", \"builder_58154cfe06b5c81d7474f82fb1f8b07061e3178a51e4015ec80a4cdf767b2ceb_v2\", \"builder_5a67369fddbade6dab3059fef0b25253ac32788b8dd17172ccec94449b615b97_v2\", \"builder_6663bce5795f35107b20705747c8e1a3615ae4a0e95ce3c4b3ebda70a32d0c7f_v2\", \"builder_67e05df6f475288c71eac33e1fe4e86c20b62be5c9403a6e253d36598b254339_v2\", \"builder_6835a67d7ea73eaa30b8b54fda1f7f7ac830440b879302d164e12cbdbf1ab09e_v2\", \"builder_762fc5caf6e589d23242c1f177533e856b5a225dc6e3f4747ed113ab3039b601_v2\", \"builder_78955e369eba41b6a3de99ca48d55d7116f6b0666a1b6b7539a4cd765288ceda_v2\", \"builder_7c670c1a7f4aa17304a17b0d552ed831b53e09e721d4d09ecd1ca9493597d96c_v2\", \"builder_7d53e00b9f90f15bd8b4d4c3c67b8746a84f1ff4bdd4b3b752b53580e9a425fa_v2\", \"builder_825364b3d22fd72e64cc529ea04169d5b52547a634aae9944857084ec0a72d56_v2\", \"builder_9cd6cdf87c7b7be4c5bc6394b239516af5c68a383cd11e92961cffdec8403d43_v2\", \"builder_a8e098fc7a0bccbb4e4cd076d4f30e1e4c708aad5a6c7f7ad9ab46a69376587c_v2\", \"builder_ac28d79f9b08d1c61f9e78ff2c943b9977977ff9784747ddc0ce0414c13b1981_v2\", \"builder_ac3c2c95ee9d0393f1c973dfa0d9b662d5d4f342d43628552856b54316dc09f4_v2\", \"builder_ad960b15a90962e52694b875d512c3db2015a7405c9ee457d20ee5d26470f5dc_v2\", \"builder_aeaceb7844fe871dc347bc8f9b97effb099ca44d1c670bf6ad89e3b916ebff1c_v2\", \"builder_b3be2ddb8b3909c86eb2f2e351f8c9ee4bd1d62a664e9dfdfe991faa015f31f4_v2\", \"builder_b8b11a58fe29ef6689b6058dff68ae0368936186a954e797667a5c8c95a3e18b_v2\", \"builder_bd00e44002d3851655480955e12a74ba78a239d0bfca74437969a38cbcd16dd1_v2\", \"builder_bfbf036cc5379e0d23048bab3b45e75ae5d57c7f8f87aa6ee1694c410f4b6f24_v2\", \"builder_cd5bd5d890c446f4d5e8e10bf1e58037146789300db5235094bfebe7993a6326_v2\", \"builder_cf2981f787534062bc22270b0c8a3c4c3a07e397c2632b07e958a675d466bb7a_v2\", \"builder_d08fad3df02a04e9ea1b124cb3e4cd9a49ba616b55f6e5d2fdacf76330bcef2a_v2\", \"builder_e68437fdb179fa80d04625a4d057e4631be49f278063fa762ab2eda2887336cf_v2\", \"builder_e8764282158a30264850feb6e3946f670edd4b6b51abb4b165a8560dcaca3c5b_v2\", \"builder_ea9251ddcec5763b81e0ba679247997722099f1d9a89e01bf81bf67c62173a40_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\": 5654, \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"buildername\": \"V8 Linux - full debug\", \"got_revision\": \"ab6462e8838f11faec130abf12d7bfb13600f265\", \"recipe\": \"v8\", \"mastername\": \"client.v8\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1538596005787214, \"tags\": [\"builder:V8 Linux - full debug\", \"buildset:commit/git/ab6462e8838f11faec130abf12d7bfb13600f265\", \"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/ab6462e8838f11faec130abf12d7bfb13600f265\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9099088932806216560\", \"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\": \"8933658870593726608\"}}, \"got_revision_cp\": \"refs/heads/master@{#56356}\", \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"ab6462e8838f11faec130abf12d7bfb13600f265\", \"bot_id\": \"swarm347-c4\"}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1538596194055679",
"status": "COMPLETED",
"status_changed_ts": "1538601818162275",
"tags": [
"build_address:luci.v8.ci/V8 Linux - full debug/5654",
"builder:V8 Linux - full debug",
"buildset:commit/git/ab6462e8838f11faec130abf12d7bfb13600f265",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/ab6462e8838f11faec130abf12d7bfb13600f265",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9099088932806216560",
"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/5654",
"swarming_tag:buildbucket_bucket:luci.v8.ci",
"swarming_tag:buildbucket_build_id:8933658870593726608",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:V8 Linux - full debug",
"swarming_tag:buildset:commit/git/ab6462e8838f11faec130abf12d7bfb13600f265",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/ab6462e8838f11faec130abf12d7bfb13600f265",
"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/8933658870593726608/+/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:9099088932806216560",
"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:d431f79a1f9890266786724a5b445a445f332a3a",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:405449766b943810",
"user_agent:luci-scheduler"
],
"updated_ts": "1538601818164265",
"url": "https://ci.chromium.org/p/v8/builders/luci.v8.ci/V8 Linux - full debug/5654",
"utcnow_ts": "1538601818717840"
}
}
[21:23:38.763] Invocation finished in 1h36m54.468510173s with status SUCCEEDED