[11:09:43.152] New invocation is queued and will start shortly
[11:09:43.152] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[11:09:44.663] Starting the invocation (attempt 1)
[11:09:44.726] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:09:44.726] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:09:44.726] Buildbucket request:
{
"bucket": "luci.v8.ci.br.beta",
"client_operation_id": "9022204636374809376",
"parameters_json": "{\"builder_name\":\"V8 Linux - debug\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"newest_gitiles_revision\":\"18448093208e58e937501af6b1cec59a9cba2f44\",\"oldest_gitiles_revision\":\"18448093208e58e937501af6b1cec59a9cba2f44\",\"parent_build_environment\":{\"gn_args\":\"is_component_build = true is_debug = true target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"},\"parent_buildername\":\"V8 Linux - debug builder\",\"parent_got_revision\":\"18448093208e58e937501af6b1cec59a9cba2f44\",\"parent_got_revision_cp\":\"refs/branch-heads/8.9@{#28}\",\"parent_got_swarming_client_revision\":\"1a072711d4388c62e02480fabc26c68c24494be9\",\"parent_test_spec\":{\"swarming_dimensions\":{\"cpu\":\"x86-64-avx2\",\"os\":\"Ubuntu-16.04\"},\"swarming_task_attrs\":{},\"tests\":[[\"benchmarks\",1,null,\"\",[],{},{}],[\"benchmarks\",1,\"code_serializer\",\"code_serializer\",[],{},{}],[\"benchmarks\",1,\"extra\",\"extra\",[],{},{}],[\"d8testing\",1,\"code_serializer\",\"code_serializer\",[],{},{}],[\"mjsunit_sp_frame_access\",1,null,\"\",[],{},{}],[\"mozilla\",1,null,\"\",[],{},{}],[\"mozilla\",1,\"code_serializer\",\"code_serializer\",[],{},{}],[\"mozilla\",1,\"extra\",\"extra\",[],{},{}],[\"optimize_for_size\",1,null,\"\",[],{},{}],[\"test262\",6,null,\"\",[],{},{}],[\"test262\",2,\"code_serializer\",\"code_serializer\",[],{},{}],[\"test262\",3,\"extra\",\"extra\",[],{},{}],[\"v8testing\",3,null,\"\",[],{},{}],[\"v8testing\",4,null,\"isolates\",[\"--isolates\"],{},{}],[\"v8testing\",2,\"extra\",\"extra\",[],{},{}],[\"mozilla\",1,null,\"nosse3\",[\"--extra-flags\",\"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"],{},{}],[\"test262\",1,\"default\",\"nosse3\",[\"--extra-flags\",\"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"],{},{}],[\"v8testing\",3,null,\"nosse3\",[\"--extra-flags\",\"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"],{},{}],[\"mozilla\",1,null,\"nosse4\",[\"--extra-flags\",\"--noenable-sse4-1 --noenable-avx\"],{},{}],[\"test262\",1,\"default\",\"nosse4\",[\"--extra-flags\",\"--noenable-sse4-1 --noenable-avx\"],{},{}],[\"v8testing\",3,null,\"nosse4\",[\"--extra-flags\",\"--noenable-sse4-1 --noenable-avx\"],{},{}],[\"mozilla\",1,null,\"noavx\",[\"--extra-flags\",\"--noenable-avx\"],{},{}],[\"test262\",1,\"default\",\"noavx\",[\"--extra-flags\",\"--noenable-avx\"],{},{}],[\"v8testing\",2,null,\"noavx\",[\"--extra-flags\",\"--noenable-avx\"],{},{}]]},\"revision\":\"18448093208e58e937501af6b1cec59a9cba2f44\",\"swarm_hashes\":{\"benchmarks\":\"86dddef7f486a7a05adf36904a1c980168387ca1\",\"bot_default\":\"9df0474e93a1930f958f685c18d037b49be76629\",\"d8_default\":\"b6ca0da077dbf4f8efc06ba50ff3ed123cd06156\",\"mjsunit\":\"db6390528bbb6d190332e91709dfcc6709b6f9eb\",\"mozilla\":\"9e323675110bef5dbe74c7fe7ea8e6059f1b245f\",\"optimize_for_size\":\"5284e42c5245886676b166c5e13ea3041148c170\",\"test262\":\"7a021ad217d921633d9b94e2161000fcc3291136\"}},\"tags\":[\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/18448093208e58e937501af6b1cec59a9cba2f44\",\"gitiles_ref:refs/branch-heads/8.9\",\"parent_buildername:V8 Linux - debug builder\",\"parent_buildnumber:156\",\"user_agent:recipe\"]},\"id\":\"afa5de84-66c0-42ae-9f98-3f0ea59eb5c8\",\"title\":\"V8 Linux - debug builder/156\"}]},\"newest_gitiles_revision\":\"18448093208e58e937501af6b1cec59a9cba2f44\",\"oldest_gitiles_revision\":\"18448093208e58e937501af6b1cec59a9cba2f44\",\"parent_build_environment\":{\"gn_args\":\"is_component_build = true is_debug = true target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"},\"parent_buildername\":\"V8 Linux - debug builder\",\"parent_got_revision\":\"18448093208e58e937501af6b1cec59a9cba2f44\",\"parent_got_revision_cp\":\"refs/branch-heads/8.9@{#28}\",\"parent_got_swarming_client_revision\":\"1a072711d4388c62e02480fabc26c68c24494be9\",\"parent_test_spec\":{\"swarming_dimensions\":{\"cpu\":\"x86-64-avx2\",\"os\":\"Ubuntu-16.04\"},\"swarming_task_attrs\":{},\"tests\":[[\"benchmarks\",1,null,\"\",[],{},{}],[\"benchmarks\",1,\"code_serializer\",\"code_serializer\",[],{},{}],[\"benchmarks\",1,\"extra\",\"extra\",[],{},{}],[\"d8testing\",1,\"code_serializer\",\"code_serializer\",[],{},{}],[\"mjsunit_sp_frame_access\",1,null,\"\",[],{},{}],[\"mozilla\",1,null,\"\",[],{},{}],[\"mozilla\",1,\"code_serializer\",\"code_serializer\",[],{},{}],[\"mozilla\",1,\"extra\",\"extra\",[],{},{}],[\"optimize_for_size\",1,null,\"\",[],{},{}],[\"test262\",6,null,\"\",[],{},{}],[\"test262\",2,\"code_serializer\",\"code_serializer\",[],{},{}],[\"test262\",3,\"extra\",\"extra\",[],{},{}],[\"v8testing\",3,null,\"\",[],{},{}],[\"v8testing\",4,null,\"isolates\",[\"--isolates\"],{},{}],[\"v8testing\",2,\"extra\",\"extra\",[],{},{}],[\"mozilla\",1,null,\"nosse3\",[\"--extra-flags\",\"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"],{},{}],[\"test262\",1,\"default\",\"nosse3\",[\"--extra-flags\",\"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"],{},{}],[\"v8testing\",3,null,\"nosse3\",[\"--extra-flags\",\"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"],{},{}],[\"mozilla\",1,null,\"nosse4\",[\"--extra-flags\",\"--noenable-sse4-1 --noenable-avx\"],{},{}],[\"test262\",1,\"default\",\"nosse4\",[\"--extra-flags\",\"--noenable-sse4-1 --noenable-avx\"],{},{}],[\"v8testing\",3,null,\"nosse4\",[\"--extra-flags\",\"--noenable-sse4-1 --noenable-avx\"],{},{}],[\"mozilla\",1,null,\"noavx\",[\"--extra-flags\",\"--noenable-avx\"],{},{}],[\"test262\",1,\"default\",\"noavx\",[\"--extra-flags\",\"--noenable-avx\"],{},{}],[\"v8testing\",2,null,\"noavx\",[\"--extra-flags\",\"--noenable-avx\"],{},{}]]},\"revision\":\"18448093208e58e937501af6b1cec59a9cba2f44\",\"swarm_hashes\":{\"benchmarks\":\"86dddef7f486a7a05adf36904a1c980168387ca1\",\"bot_default\":\"9df0474e93a1930f958f685c18d037b49be76629\",\"d8_default\":\"b6ca0da077dbf4f8efc06ba50ff3ed123cd06156\",\"mjsunit\":\"db6390528bbb6d190332e91709dfcc6709b6f9eb\",\"mozilla\":\"9e323675110bef5dbe74c7fe7ea8e6059f1b245f\",\"optimize_for_size\":\"5284e42c5245886676b166c5e13ea3041148c170\",\"test262\":\"7a021ad217d921633d9b94e2161000fcc3291136\"}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Linux - debug",
"scheduler_invocation_id:9022204636374809376",
"scheduler_job_id:v8/ci.br.beta-V8 Linux - debug",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/18448093208e58e937501af6b1cec59a9cba2f44",
"gitiles_ref:refs/branch-heads/8.9",
"parent_buildername:V8 Linux - debug builder",
"parent_buildnumber:156",
"user_agent:recipe"
]
}
[11:09:49.605] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci.br.beta",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:v8",
"created_ts": "1611918585320283",
"id": "8856774573437684768",
"parameters_json": "{\"builder_name\": \"V8 Linux - debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"oldest_gitiles_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Linux - debug builder\", \"parent_got_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"parent_got_revision_cp\": \"refs/branch-heads/8.9@{#28}\", \"parent_got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"parent_test_spec\": {\"swarming_dimensions\": {\"cpu\": \"x86-64-avx2\", \"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"benchmarks\", 1.0, null, \"\", [], {}, {}], [\"benchmarks\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"benchmarks\", 1.0, \"extra\", \"extra\", [], {}, {}], [\"d8testing\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"mjsunit_sp_frame_access\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"mozilla\", 1.0, \"extra\", \"extra\", [], {}, {}], [\"optimize_for_size\", 1.0, null, \"\", [], {}, {}], [\"test262\", 6.0, null, \"\", [], {}, {}], [\"test262\", 2.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"test262\", 3.0, \"extra\", \"extra\", [], {}, {}], [\"v8testing\", 3.0, null, \"\", [], {}, {}], [\"v8testing\", 4.0, null, \"isolates\", [\"--isolates\"], {}, {}], [\"v8testing\", 2.0, \"extra\", \"extra\", [], {}, {}], [\"mozilla\", 1.0, null, \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"v8testing\", 3.0, null, \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"mozilla\", 1.0, null, \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"v8testing\", 3.0, null, \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"mozilla\", 1.0, null, \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}], [\"v8testing\", 2.0, null, \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}]]}, \"revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"swarm_hashes\": {\"benchmarks\": \"86dddef7f486a7a05adf36904a1c980168387ca1\", \"bot_default\": \"9df0474e93a1930f958f685c18d037b49be76629\", \"d8_default\": \"b6ca0da077dbf4f8efc06ba50ff3ed123cd06156\", \"mjsunit\": \"db6390528bbb6d190332e91709dfcc6709b6f9eb\", \"mozilla\": \"9e323675110bef5dbe74c7fe7ea8e6059f1b245f\", \"optimize_for_size\": \"5284e42c5245886676b166c5e13ea3041148c170\", \"test262\": \"7a021ad217d921633d9b94e2161000fcc3291136\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/18448093208e58e937501af6b1cec59a9cba2f44\", \"gitiles_ref:refs/branch-heads/8.9\", \"parent_buildername:V8 Linux - debug builder\", \"parent_buildnumber:156\", \"user_agent:recipe\"]}, \"id\": \"afa5de84-66c0-42ae-9f98-3f0ea59eb5c8\", \"title\": \"V8 Linux - debug builder/156\"}]}, \"newest_gitiles_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"oldest_gitiles_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Linux - debug builder\", \"parent_got_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"parent_got_revision_cp\": \"refs/branch-heads/8.9@{#28}\", \"parent_got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"parent_test_spec\": {\"swarming_dimensions\": {\"cpu\": \"x86-64-avx2\", \"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"benchmarks\", 1.0, null, \"\", [], {}, {}], [\"benchmarks\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"benchmarks\", 1.0, \"extra\", \"extra\", [], {}, {}], [\"d8testing\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"mjsunit_sp_frame_access\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"mozilla\", 1.0, \"extra\", \"extra\", [], {}, {}], [\"optimize_for_size\", 1.0, null, \"\", [], {}, {}], [\"test262\", 6.0, null, \"\", [], {}, {}], [\"test262\", 2.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"test262\", 3.0, \"extra\", \"extra\", [], {}, {}], [\"v8testing\", 3.0, null, \"\", [], {}, {}], [\"v8testing\", 4.0, null, \"isolates\", [\"--isolates\"], {}, {}], [\"v8testing\", 2.0, \"extra\", \"extra\", [], {}, {}], [\"mozilla\", 1.0, null, \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"v8testing\", 3.0, null, \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"mozilla\", 1.0, null, \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"v8testing\", 3.0, null, \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"mozilla\", 1.0, null, \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}], [\"v8testing\", 2.0, null, \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}]]}, \"revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"swarm_hashes\": {\"benchmarks\": \"86dddef7f486a7a05adf36904a1c980168387ca1\", \"bot_default\": \"9df0474e93a1930f958f685c18d037b49be76629\", \"d8_default\": \"b6ca0da077dbf4f8efc06ba50ff3ed123cd06156\", \"mjsunit\": \"db6390528bbb6d190332e91709dfcc6709b6f9eb\", \"mozilla\": \"9e323675110bef5dbe74c7fe7ea8e6059f1b245f\", \"optimize_for_size\": \"5284e42c5245886676b166c5e13ea3041148c170\", \"test262\": \"7a021ad217d921633d9b94e2161000fcc3291136\"}}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611918589371298",
"tags": [
"build_address:luci.v8.ci.br.beta/V8 Linux - debug/148",
"builder:V8 Linux - debug",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/18448093208e58e937501af6b1cec59a9cba2f44",
"gitiles_ref:refs/branch-heads/8.9",
"parent_buildername:V8 Linux - debug builder",
"parent_buildnumber:156",
"scheduler_invocation_id:9022204636374809376",
"scheduler_job_id:v8/ci.br.beta-V8 Linux - debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8856774573437684768/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:recipe_name:v8",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1611918589371407",
"url": "https://ci.chromium.org/b/8856774573437684768",
"utcnow_ts": "1611918589590473"
}
}
[11:09:49.605] Task URL: https://ci.chromium.org/b/8856774573437684768
[11:09:49.605] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:2:0) after 1m0s
[11:10:49.674] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:2:0)
[11:10:49.674] Timer tick, asking Buildbucket for the build status
[11:10:50.246] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:10:50.246] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:3:0) after 1m0s
[11:11:50.266] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:3:0)
[11:11:50.266] Timer tick, asking Buildbucket for the build status
[11:11:50.444] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:11:50.444] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:4:0) after 1m0s
[11:12:50.482] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:4:0)
[11:12:50.482] Timer tick, asking Buildbucket for the build status
[11:12:50.640] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:12:50.640] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:5:0) after 1m0s
[11:13:50.690] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:5:0)
[11:13:50.690] Timer tick, asking Buildbucket for the build status
[11:13:50.946] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:13:50.946] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:6:0) after 1m0s
[11:14:50.968] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:6:0)
[11:14:50.968] Timer tick, asking Buildbucket for the build status
[11:14:51.154] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:14:51.154] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:7:0) after 1m0s
[11:15:51.296] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:7:0)
[11:15:51.296] Timer tick, asking Buildbucket for the build status
[11:15:51.696] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:15:51.696] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:8:0) after 1m0s
[11:16:51.724] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:8:0)
[11:16:51.724] Timer tick, asking Buildbucket for the build status
[11:16:51.909] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:16:51.909] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:9:0) after 1m0s
[11:17:51.922] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:9:0)
[11:17:51.922] Timer tick, asking Buildbucket for the build status
[11:17:52.608] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:17:52.608] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:10:0) after 1m0s
[11:18:52.635] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:10:0)
[11:18:52.635] Timer tick, asking Buildbucket for the build status
[11:18:52.803] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:18:52.803] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:11:0) after 1m0s
[11:19:52.786] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:11:0)
[11:19:52.786] Timer tick, asking Buildbucket for the build status
[11:19:53.003] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:19:53.003] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:12:0) after 1m0s
[11:20:53.048] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:12:0)
[11:20:53.048] Timer tick, asking Buildbucket for the build status
[11:20:53.223] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:20:53.223] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:13:0) after 1m0s
[11:21:53.246] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:13:0)
[11:21:53.246] Timer tick, asking Buildbucket for the build status
[11:21:53.481] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:21:53.481] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:14:0) after 1m0s
[11:22:53.547] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:14:0)
[11:22:53.547] Timer tick, asking Buildbucket for the build status
[11:22:54.324] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:22:54.324] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:15:0) after 1m0s
[11:23:54.386] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:15:0)
[11:23:54.386] Timer tick, asking Buildbucket for the build status
[11:23:54.557] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:23:54.557] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:16:0) after 1m0s
[11:24:54.633] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:16:0)
[11:24:54.633] Timer tick, asking Buildbucket for the build status
[11:24:55.316] Build 8856774573437684768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:24:55.316] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:17:0) after 1m0s
[11:24:56.847] Received PubSub notification, asking Buildbucket for the build status
[11:24:57.036] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:55.314] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:17:0)
[11:25:55.314] Timer tick, asking Buildbucket for the build status
[11:25:56.929] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:56.929] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:19:0) after 1m0s
[11:26:56.957] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:19:0)
[11:26:56.957] Timer tick, asking Buildbucket for the build status
[11:26:57.177] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:57.177] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:20:0) after 1m0s
[11:27:57.243] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:20:0)
[11:27:57.243] Timer tick, asking Buildbucket for the build status
[11:27:57.886] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:57.886] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:21:0) after 1m0s
[11:28:57.907] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:21:0)
[11:28:57.907] Timer tick, asking Buildbucket for the build status
[11:28:59.603] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:59.603] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:22:0) after 1m0s
[11:29:59.645] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:22:0)
[11:29:59.645] Timer tick, asking Buildbucket for the build status
[11:30:00.217] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:00.217] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:23:0) after 1m0s
[11:31:00.334] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:23:0)
[11:31:00.334] Timer tick, asking Buildbucket for the build status
[11:31:00.761] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:00.761] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:24:0) after 1m0s
[11:32:01.323] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:24:0)
[11:32:01.323] Timer tick, asking Buildbucket for the build status
[11:32:01.752] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:01.752] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:25:0) after 1m0s
[11:33:01.923] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:25:0)
[11:33:01.923] Timer tick, asking Buildbucket for the build status
[11:33:02.805] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:02.805] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:26:0) after 1m0s
[11:34:02.847] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:26:0)
[11:34:02.847] Timer tick, asking Buildbucket for the build status
[11:34:03.163] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:03.163] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:27:0) after 1m0s
[11:35:03.194] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:27:0)
[11:35:03.194] Timer tick, asking Buildbucket for the build status
[11:35:03.648] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:03.648] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:28:0) after 1m0s
[11:36:03.683] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:28:0)
[11:36:03.684] Timer tick, asking Buildbucket for the build status
[11:36:03.938] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:03.939] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:29:0) after 1m0s
[11:37:04.061] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:29:0)
[11:37:04.061] Timer tick, asking Buildbucket for the build status
[11:37:04.316] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:04.316] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:30:0) after 1m0s
[11:38:04.444] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:30:0)
[11:38:04.444] Timer tick, asking Buildbucket for the build status
[11:38:06.216] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:06.216] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:31:0) after 1m0s
[11:39:06.322] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:31:0)
[11:39:06.322] Timer tick, asking Buildbucket for the build status
[11:39:08.283] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:08.283] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:32:0) after 1m0s
[11:40:08.472] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:32:0)
[11:40:08.472] Timer tick, asking Buildbucket for the build status
[11:40:09.458] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:09.458] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:33:0) after 1m0s
[11:41:09.531] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:33:0)
[11:41:09.531] Timer tick, asking Buildbucket for the build status
[11:41:10.013] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:10.013] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:34:0) after 1m0s
[11:42:10.053] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:34:0)
[11:42:10.053] Timer tick, asking Buildbucket for the build status
[11:42:10.299] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:10.299] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:35:0) after 1m0s
[11:43:10.351] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:35:0)
[11:43:10.351] Timer tick, asking Buildbucket for the build status
[11:43:10.759] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:10.759] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:36:0) after 1m0s
[11:44:10.825] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:36:0)
[11:44:10.825] Timer tick, asking Buildbucket for the build status
[11:44:12.236] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:12.236] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:37:0) after 1m0s
[11:45:12.302] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:37:0)
[11:45:12.302] Timer tick, asking Buildbucket for the build status
[11:45:14.396] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:14.396] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:38:0) after 1m0s
[11:46:14.494] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:38:0)
[11:46:14.494] Timer tick, asking Buildbucket for the build status
[11:46:16.450] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:16.450] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:39:0) after 1m0s
[11:47:16.628] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:39:0)
[11:47:16.628] Timer tick, asking Buildbucket for the build status
[11:47:16.943] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:16.943] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:40:0) after 1m0s
[11:48:17.162] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:40:0)
[11:48:17.162] Timer tick, asking Buildbucket for the build status
[11:48:20.121] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:20.121] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:41:0) after 1m0s
[11:49:20.182] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:41:0)
[11:49:20.182] Timer tick, asking Buildbucket for the build status
[11:49:20.413] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:20.413] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:42:0) after 1m0s
[11:50:20.472] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:42:0)
[11:50:20.472] Timer tick, asking Buildbucket for the build status
[11:50:20.931] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:20.931] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:43:0) after 1m0s
[11:51:21.001] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:43:0)
[11:51:21.001] Timer tick, asking Buildbucket for the build status
[11:51:21.237] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:21.237] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:44:0) after 1m0s
[11:52:21.310] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:44:0)
[11:52:21.310] Timer tick, asking Buildbucket for the build status
[11:52:21.759] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:21.759] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:45:0) after 1m0s
[11:53:21.845] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:45:0)
[11:53:21.845] Timer tick, asking Buildbucket for the build status
[11:53:22.929] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:22.929] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:46:0) after 1m0s
[11:54:22.979] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:46:0)
[11:54:22.979] Timer tick, asking Buildbucket for the build status
[11:54:25.742] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:25.742] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:47:0) after 1m0s
[11:55:25.867] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:47:0)
[11:55:25.867] Timer tick, asking Buildbucket for the build status
[11:55:26.403] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:26.403] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:48:0) after 1m0s
[11:56:26.470] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:48:0)
[11:56:26.470] Timer tick, asking Buildbucket for the build status
[11:56:26.723] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:26.723] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:49:0) after 1m0s
[11:57:26.874] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:49:0)
[11:57:26.874] Timer tick, asking Buildbucket for the build status
[11:57:28.022] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:28.022] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:50:0) after 1m0s
[11:58:28.138] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:50:0)
[11:58:28.138] Timer tick, asking Buildbucket for the build status
[11:58:29.807] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:29.807] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:51:0) after 1m0s
[11:59:30.077] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:51:0)
[11:59:30.077] Timer tick, asking Buildbucket for the build status
[11:59:30.304] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:30.304] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:52:0) after 1m0s
[12:00:30.375] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:52:0)
[12:00:30.375] Timer tick, asking Buildbucket for the build status
[12:00:31.855] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:31.855] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:53:0) after 1m0s
[12:01:31.953] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:53:0)
[12:01:31.953] Timer tick, asking Buildbucket for the build status
[12:01:32.291] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:32.291] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:54:0) after 1m0s
[12:02:32.472] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:54:0)
[12:02:32.472] Timer tick, asking Buildbucket for the build status
[12:02:33.544] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:33.544] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:55:0) after 1m0s
[12:03:33.723] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:55:0)
[12:03:33.723] Timer tick, asking Buildbucket for the build status
[12:03:33.957] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:33.957] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:56:0) after 1m0s
[12:04:34.019] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:56:0)
[12:04:34.019] Timer tick, asking Buildbucket for the build status
[12:04:35.237] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:35.237] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:57:0) after 1m0s
[12:05:35.322] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:57:0)
[12:05:35.322] Timer tick, asking Buildbucket for the build status
[12:05:37.587] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:37.587] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:58:0) after 1m0s
[12:06:37.719] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:58:0)
[12:06:37.719] Timer tick, asking Buildbucket for the build status
[12:06:38.232] Build 8856774573437684768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:38.232] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux - debug:9022204636374809376:59:0) after 1m0s
[12:07:13.447] Received PubSub notification, asking Buildbucket for the build status
[12:07:13.723] Build 8856774573437684768: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:07:13.723] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci.br.beta",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1611922028436828",
"created_by": "project:v8",
"created_ts": "1611918585320283",
"id": "8856774573437684768",
"parameters_json": "{\"builder_name\": \"V8 Linux - debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"oldest_gitiles_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Linux - debug builder\", \"parent_got_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"parent_got_revision_cp\": \"refs/branch-heads/8.9@{#28}\", \"parent_got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"parent_test_spec\": {\"swarming_dimensions\": {\"cpu\": \"x86-64-avx2\", \"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"benchmarks\", 1.0, null, \"\", [], {}, {}], [\"benchmarks\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"benchmarks\", 1.0, \"extra\", \"extra\", [], {}, {}], [\"d8testing\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"mjsunit_sp_frame_access\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"mozilla\", 1.0, \"extra\", \"extra\", [], {}, {}], [\"optimize_for_size\", 1.0, null, \"\", [], {}, {}], [\"test262\", 6.0, null, \"\", [], {}, {}], [\"test262\", 2.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"test262\", 3.0, \"extra\", \"extra\", [], {}, {}], [\"v8testing\", 3.0, null, \"\", [], {}, {}], [\"v8testing\", 4.0, null, \"isolates\", [\"--isolates\"], {}, {}], [\"v8testing\", 2.0, \"extra\", \"extra\", [], {}, {}], [\"mozilla\", 1.0, null, \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"v8testing\", 3.0, null, \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"mozilla\", 1.0, null, \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"v8testing\", 3.0, null, \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"mozilla\", 1.0, null, \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}], [\"v8testing\", 2.0, null, \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}]]}, \"revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"swarm_hashes\": {\"benchmarks\": \"86dddef7f486a7a05adf36904a1c980168387ca1\", \"bot_default\": \"9df0474e93a1930f958f685c18d037b49be76629\", \"d8_default\": \"b6ca0da077dbf4f8efc06ba50ff3ed123cd06156\", \"mjsunit\": \"db6390528bbb6d190332e91709dfcc6709b6f9eb\", \"mozilla\": \"9e323675110bef5dbe74c7fe7ea8e6059f1b245f\", \"optimize_for_size\": \"5284e42c5245886676b166c5e13ea3041148c170\", \"test262\": \"7a021ad217d921633d9b94e2161000fcc3291136\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/18448093208e58e937501af6b1cec59a9cba2f44\", \"gitiles_ref:refs/branch-heads/8.9\", \"parent_buildername:V8 Linux - debug builder\", \"parent_buildnumber:156\", \"user_agent:recipe\"]}, \"id\": \"afa5de84-66c0-42ae-9f98-3f0ea59eb5c8\", \"title\": \"V8 Linux - debug builder/156\"}]}, \"newest_gitiles_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"oldest_gitiles_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Linux - debug builder\", \"parent_got_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"parent_got_revision_cp\": \"refs/branch-heads/8.9@{#28}\", \"parent_got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"parent_test_spec\": {\"swarming_dimensions\": {\"cpu\": \"x86-64-avx2\", \"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"benchmarks\", 1.0, null, \"\", [], {}, {}], [\"benchmarks\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"benchmarks\", 1.0, \"extra\", \"extra\", [], {}, {}], [\"d8testing\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"mjsunit_sp_frame_access\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"mozilla\", 1.0, \"extra\", \"extra\", [], {}, {}], [\"optimize_for_size\", 1.0, null, \"\", [], {}, {}], [\"test262\", 6.0, null, \"\", [], {}, {}], [\"test262\", 2.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"test262\", 3.0, \"extra\", \"extra\", [], {}, {}], [\"v8testing\", 3.0, null, \"\", [], {}, {}], [\"v8testing\", 4.0, null, \"isolates\", [\"--isolates\"], {}, {}], [\"v8testing\", 2.0, \"extra\", \"extra\", [], {}, {}], [\"mozilla\", 1.0, null, \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"v8testing\", 3.0, null, \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"mozilla\", 1.0, null, \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"v8testing\", 3.0, null, \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"mozilla\", 1.0, null, \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}], [\"v8testing\", 2.0, null, \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}]]}, \"revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"swarm_hashes\": {\"benchmarks\": \"86dddef7f486a7a05adf36904a1c980168387ca1\", \"bot_default\": \"9df0474e93a1930f958f685c18d037b49be76629\", \"d8_default\": \"b6ca0da077dbf4f8efc06ba50ff3ed123cd06156\", \"mjsunit\": \"db6390528bbb6d190332e91709dfcc6709b6f9eb\", \"mozilla\": \"9e323675110bef5dbe74c7fe7ea8e6059f1b245f\", \"optimize_for_size\": \"5284e42c5245886676b166c5e13ea3041148c170\", \"test262\": \"7a021ad217d921633d9b94e2161000fcc3291136\"}}}",
"project": "v8",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com/\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"oldest_gitiles_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Linux - debug builder\", \"parent_got_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"parent_got_revision_cp\": \"refs/branch-heads/8.9@{#28}\", \"parent_got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"parent_test_spec\": {\"swarming_dimensions\": {\"cpu\": \"x86-64-avx2\", \"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"benchmarks\", 1.0, null, \"\", [], {}, {}], [\"benchmarks\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"benchmarks\", 1.0, \"extra\", \"extra\", [], {}, {}], [\"d8testing\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"mjsunit_sp_frame_access\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"mozilla\", 1.0, \"extra\", \"extra\", [], {}, {}], [\"optimize_for_size\", 1.0, null, \"\", [], {}, {}], [\"test262\", 6.0, null, \"\", [], {}, {}], [\"test262\", 2.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"test262\", 3.0, \"extra\", \"extra\", [], {}, {}], [\"v8testing\", 3.0, null, \"\", [], {}, {}], [\"v8testing\", 4.0, null, \"isolates\", [\"--isolates\"], {}, {}], [\"v8testing\", 2.0, \"extra\", \"extra\", [], {}, {}], [\"mozilla\", 1.0, null, \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"v8testing\", 3.0, null, \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"mozilla\", 1.0, null, \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"v8testing\", 3.0, null, \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"mozilla\", 1.0, null, \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}], [\"v8testing\", 2.0, null, \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}]]}, \"revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"swarm_hashes\": {\"benchmarks\": \"86dddef7f486a7a05adf36904a1c980168387ca1\", \"bot_default\": \"9df0474e93a1930f958f685c18d037b49be76629\", \"d8_default\": \"b6ca0da077dbf4f8efc06ba50ff3ed123cd06156\", \"mjsunit\": \"db6390528bbb6d190332e91709dfcc6709b6f9eb\", \"mozilla\": \"9e323675110bef5dbe74c7fe7ea8e6059f1b245f\", \"optimize_for_size\": \"5284e42c5245886676b166c5e13ea3041148c170\", \"test262\": \"7a021ad217d921633d9b94e2161000fcc3291136\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/18448093208e58e937501af6b1cec59a9cba2f44\", \"gitiles_ref:refs/branch-heads/8.9\", \"parent_buildername:V8 Linux - debug builder\", \"parent_buildnumber:156\", \"user_agent:recipe\"]}, \"id\": \"afa5de84-66c0-42ae-9f98-3f0ea59eb5c8\", \"title\": \"V8 Linux - debug builder/156\"}]}, \"bot_id\": \"luci-v8-ci-slim-13-tjn8\", \"builder_group\": \"client.v8\", \"buildername\": \"V8 Linux - debug\", \"buildnumber\": 148, \"got_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"got_revision_cp\": \"refs/branch-heads/8.9@{#28}\", \"newest_gitiles_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"oldest_gitiles_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Linux - debug builder\", \"parent_got_revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"parent_got_revision_cp\": \"refs/branch-heads/8.9@{#28}\", \"parent_got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"parent_test_spec\": {\"swarming_dimensions\": {\"cpu\": \"x86-64-avx2\", \"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"benchmarks\", 1.0, null, \"\", [], {}, {}], [\"benchmarks\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"benchmarks\", 1.0, \"extra\", \"extra\", [], {}, {}], [\"d8testing\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"mjsunit_sp_frame_access\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"mozilla\", 1.0, \"extra\", \"extra\", [], {}, {}], [\"optimize_for_size\", 1.0, null, \"\", [], {}, {}], [\"test262\", 6.0, null, \"\", [], {}, {}], [\"test262\", 2.0, \"code_serializer\", \"code_serializer\", [], {}, {}], [\"test262\", 3.0, \"extra\", \"extra\", [], {}, {}], [\"v8testing\", 3.0, null, \"\", [], {}, {}], [\"v8testing\", 4.0, null, \"isolates\", [\"--isolates\"], {}, {}], [\"v8testing\", 2.0, \"extra\", \"extra\", [], {}, {}], [\"mozilla\", 1.0, null, \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"v8testing\", 3.0, null, \"nosse3\", [\"--extra-flags\", \"--noenable-sse3 --noenable-ssse3 --noenable-sse4-1 --noenable-avx\"], {}, {}], [\"mozilla\", 1.0, null, \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"v8testing\", 3.0, null, \"nosse4\", [\"--extra-flags\", \"--noenable-sse4-1 --noenable-avx\"], {}, {}], [\"mozilla\", 1.0, null, \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}], [\"test262\", 1.0, \"default\", \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}], [\"v8testing\", 2.0, null, \"noavx\", [\"--extra-flags\", \"--noenable-avx\"], {}, {}]]}, \"path_config\": \"generic\", \"recipe\": \"v8\", \"revision\": \"18448093208e58e937501af6b1cec59a9cba2f44\", \"swarm_hashes\": {\"benchmarks\": \"86dddef7f486a7a05adf36904a1c980168387ca1\", \"bot_default\": \"9df0474e93a1930f958f685c18d037b49be76629\", \"d8_default\": \"b6ca0da077dbf4f8efc06ba50ff3ed123cd06156\", \"mjsunit\": \"db6390528bbb6d190332e91709dfcc6709b6f9eb\", \"mozilla\": \"9e323675110bef5dbe74c7fe7ea8e6059f1b245f\", \"optimize_for_size\": \"5284e42c5245886676b166c5e13ea3041148c170\", \"test262\": \"7a021ad217d921633d9b94e2161000fcc3291136\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"git\", \"goma_v2\", \"v8_builder_cache_nowait\", \"vpython\"], \"cores\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"host_class\": [\"multibot\"], \"id\": [\"luci-v8-ci-slim-13-tjn8\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"g1-small\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.v8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611919493716706",
"status": "COMPLETED",
"status_changed_ts": "1611922028922070",
"tags": [
"build_address:luci.v8.ci.br.beta/V8 Linux - debug/148",
"builder:V8 Linux - debug",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/18448093208e58e937501af6b1cec59a9cba2f44",
"gitiles_ref:refs/branch-heads/8.9",
"parent_buildername:V8 Linux - debug builder",
"parent_buildnumber:156",
"scheduler_invocation_id:9022204636374809376",
"scheduler_job_id:v8/ci.br.beta-V8 Linux - debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8856774573437684768/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:v8",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:5166a74f56715110",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1611922032666682",
"url": "https://ci.chromium.org/b/8856774573437684768",
"utcnow_ts": "1611922033706460"
}
}
[12:07:13.723] Invocation finished in 57m30.588190266s with status SUCCEEDED