[13:41:23.627] New invocation is queued and will start shortly
[13:41:23.627] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[13:41:24.828] Starting the invocation (attempt 1)
[13:41:24.864] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:41:24.864] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:41:24.864] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9021651512056819584",
"parameters_json": "{\"builder_name\":\"V8 Linux - debug\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"newest_gitiles_revision\":\"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\",\"oldest_gitiles_revision\":\"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\",\"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\":\"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\",\"parent_got_revision_cp\":\"refs/heads/master@{#72526}\",\"parent_got_swarming_client_revision\":\"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\",\"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\":\"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\",\"swarm_hashes\":{\"benchmarks\":\"81bdd5594dad6961afc9f9692e2185a24f862fe2\",\"bot_default\":\"c26650e99767972c9b2ccc3abde330e957138799\",\"d8_default\":\"77cccaf5c6af8f1b1b37b63de7800f95a2757ca2\",\"mjsunit\":\"ef06c2a898d9cf899aeec4e7acfdade7e8c43254\",\"mozilla\":\"b8e3a2649179e027f4e7c21519e2084ce4ac3561\",\"optimize_for_size\":\"af6179ce11800f43b51d34ee93a0f921a0dc09ff\",\"test262\":\"9300bfddfaf624fb2385cc92f537a682c3156215\"}},\"tags\":[\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\",\"gitiles_ref:refs/heads/master\",\"parent_buildername:V8 Linux - debug builder\",\"parent_buildnumber:48025\",\"user_agent:recipe\"]},\"id\":\"f22ff43c-02c1-428d-8319-6a0554746cd2\",\"title\":\"V8 Linux - debug builder/48025\"}]},\"newest_gitiles_revision\":\"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\",\"oldest_gitiles_revision\":\"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\",\"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\":\"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\",\"parent_got_revision_cp\":\"refs/heads/master@{#72526}\",\"parent_got_swarming_client_revision\":\"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\",\"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\":\"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\",\"swarm_hashes\":{\"benchmarks\":\"81bdd5594dad6961afc9f9692e2185a24f862fe2\",\"bot_default\":\"c26650e99767972c9b2ccc3abde330e957138799\",\"d8_default\":\"77cccaf5c6af8f1b1b37b63de7800f95a2757ca2\",\"mjsunit\":\"ef06c2a898d9cf899aeec4e7acfdade7e8c43254\",\"mozilla\":\"b8e3a2649179e027f4e7c21519e2084ce4ac3561\",\"optimize_for_size\":\"af6179ce11800f43b51d34ee93a0f921a0dc09ff\",\"test262\":\"9300bfddfaf624fb2385cc92f537a682c3156215\"}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Linux - debug",
"scheduler_invocation_id:9021651512056819584",
"scheduler_job_id:v8/ci-V8 Linux - debug",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da",
"gitiles_ref:refs/heads/master",
"parent_buildername:V8 Linux - debug builder",
"parent_buildnumber:48025",
"user_agent:recipe"
]
}
[13:41:28.881] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1612446085006280",
"id": "8856221449927407072",
"parameters_json": "{\"builder_name\": \"V8 Linux - debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"oldest_gitiles_revision\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"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\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"parent_got_revision_cp\": \"refs/heads/master@{#72526}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"swarm_hashes\": {\"benchmarks\": \"81bdd5594dad6961afc9f9692e2185a24f862fe2\", \"bot_default\": \"c26650e99767972c9b2ccc3abde330e957138799\", \"d8_default\": \"77cccaf5c6af8f1b1b37b63de7800f95a2757ca2\", \"mjsunit\": \"ef06c2a898d9cf899aeec4e7acfdade7e8c43254\", \"mozilla\": \"b8e3a2649179e027f4e7c21519e2084ce4ac3561\", \"optimize_for_size\": \"af6179ce11800f43b51d34ee93a0f921a0dc09ff\", \"test262\": \"9300bfddfaf624fb2385cc92f537a682c3156215\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux - debug builder\", \"parent_buildnumber:48025\", \"user_agent:recipe\"]}, \"id\": \"f22ff43c-02c1-428d-8319-6a0554746cd2\", \"title\": \"V8 Linux - debug builder/48025\"}]}, \"newest_gitiles_revision\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"oldest_gitiles_revision\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"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\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"parent_got_revision_cp\": \"refs/heads/master@{#72526}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"swarm_hashes\": {\"benchmarks\": \"81bdd5594dad6961afc9f9692e2185a24f862fe2\", \"bot_default\": \"c26650e99767972c9b2ccc3abde330e957138799\", \"d8_default\": \"77cccaf5c6af8f1b1b37b63de7800f95a2757ca2\", \"mjsunit\": \"ef06c2a898d9cf899aeec4e7acfdade7e8c43254\", \"mozilla\": \"b8e3a2649179e027f4e7c21519e2084ce4ac3561\", \"optimize_for_size\": \"af6179ce11800f43b51d34ee93a0f921a0dc09ff\", \"test262\": \"9300bfddfaf624fb2385cc92f537a682c3156215\"}}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612446088640447",
"tags": [
"build_address:luci.v8.ci/V8 Linux - debug/33792",
"builder:V8 Linux - debug",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da",
"gitiles_ref:refs/heads/master",
"parent_buildername:V8 Linux - debug builder",
"parent_buildnumber:48025",
"scheduler_invocation_id:9021651512056819584",
"scheduler_job_id:v8/ci-V8 Linux - debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8856221449927407072/+/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": "1612446088640557",
"url": "https://ci.chromium.org/b/8856221449927407072",
"utcnow_ts": "1612446088867181"
}
}
[13:41:28.881] Task URL: https://ci.chromium.org/b/8856221449927407072
[13:41:28.881] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:2:0) after 1m0s
[13:42:28.913] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:2:0)
[13:42:28.913] Timer tick, asking Buildbucket for the build status
[13:42:30.827] Build 8856221449927407072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:42:30.827] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:3:0) after 1m0s
[13:43:30.968] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:3:0)
[13:43:30.968] Timer tick, asking Buildbucket for the build status
[13:43:33.222] Build 8856221449927407072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:43:33.222] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:4:0) after 1m0s
[13:44:33.285] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:4:0)
[13:44:33.285] Timer tick, asking Buildbucket for the build status
[13:44:33.661] Build 8856221449927407072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:44:33.661] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:5:0) after 1m0s
[13:45:33.742] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:5:0)
[13:45:33.742] Timer tick, asking Buildbucket for the build status
[13:45:35.830] Build 8856221449927407072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:45:35.830] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:6:0) after 1m0s
[13:46:35.873] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:6:0)
[13:46:35.873] Timer tick, asking Buildbucket for the build status
[13:46:36.156] Build 8856221449927407072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:46:36.156] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:7:0) after 1m0s
[13:47:36.177] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:7:0)
[13:47:36.177] Timer tick, asking Buildbucket for the build status
[13:47:37.651] Build 8856221449927407072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:47:37.651] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:8:0) after 1m0s
[13:48:37.658] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:8:0)
[13:48:37.658] Timer tick, asking Buildbucket for the build status
[13:48:38.013] Build 8856221449927407072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:48:38.013] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:9:0) after 1m0s
[13:49:38.101] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:9:0)
[13:49:38.101] Timer tick, asking Buildbucket for the build status
[13:49:39.003] Build 8856221449927407072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:49:39.003] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:10:0) after 1m0s
[13:50:39.035] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:10:0)
[13:50:39.035] Timer tick, asking Buildbucket for the build status
[13:50:39.318] Build 8856221449927407072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:50:39.318] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:11:0) after 1m0s
[13:51:39.397] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:11:0)
[13:51:39.397] Timer tick, asking Buildbucket for the build status
[13:51:39.736] Build 8856221449927407072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:51:39.736] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:12:0) after 1m0s
[13:52:39.765] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:12:0)
[13:52:39.765] Timer tick, asking Buildbucket for the build status
[13:52:39.955] Build 8856221449927407072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:52:39.955] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:13:0) after 1m0s
[13:53:05.977] Received PubSub notification, asking Buildbucket for the build status
[13:53:06.404] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:40.025] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:13:0)
[13:53:40.025] Timer tick, asking Buildbucket for the build status
[13:53:40.821] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:40.821] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:15:0) after 1m0s
[13:54:40.867] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:15:0)
[13:54:40.867] Timer tick, asking Buildbucket for the build status
[13:54:41.324] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:41.324] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:16:0) after 1m0s
[13:55:41.355] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:16:0)
[13:55:41.355] Timer tick, asking Buildbucket for the build status
[13:55:41.768] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:41.768] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:17:0) after 1m0s
[13:56:41.788] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:17:0)
[13:56:41.788] Timer tick, asking Buildbucket for the build status
[13:56:43.800] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:43.800] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:18:0) after 1m0s
[13:57:43.822] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:18:0)
[13:57:43.822] Timer tick, asking Buildbucket for the build status
[13:57:44.603] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:44.603] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:19:0) after 1m0s
[13:58:44.789] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:19:0)
[13:58:44.789] Timer tick, asking Buildbucket for the build status
[13:58:45.599] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:45.599] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:20:0) after 1m0s
[13:59:45.712] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:20:0)
[13:59:45.712] Timer tick, asking Buildbucket for the build status
[13:59:45.968] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:45.968] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:21:0) after 1m0s
[14:00:46.031] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:21:0)
[14:00:46.031] Timer tick, asking Buildbucket for the build status
[14:00:46.943] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:46.943] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:22:0) after 1m0s
[14:01:46.981] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:22:0)
[14:01:46.981] Timer tick, asking Buildbucket for the build status
[14:01:47.296] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:47.296] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:23:0) after 1m0s
[14:02:47.322] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:23:0)
[14:02:47.322] Timer tick, asking Buildbucket for the build status
[14:02:47.819] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:47.819] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:24:0) after 1m0s
[14:03:47.886] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:24:0)
[14:03:47.886] Timer tick, asking Buildbucket for the build status
[14:03:50.086] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:50.086] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:25:0) after 1m0s
[14:04:50.245] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:25:0)
[14:04:50.245] Timer tick, asking Buildbucket for the build status
[14:04:50.999] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:50.999] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:26:0) after 1m0s
[14:05:51.158] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:26:0)
[14:05:51.159] Timer tick, asking Buildbucket for the build status
[14:05:52.814] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:52.814] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:27:0) after 1m0s
[14:06:52.851] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:27:0)
[14:06:52.851] Timer tick, asking Buildbucket for the build status
[14:06:53.262] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:53.262] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:28:0) after 1m0s
[14:07:53.371] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:28:0)
[14:07:53.371] Timer tick, asking Buildbucket for the build status
[14:07:53.639] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:53.639] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:29:0) after 1m0s
[14:08:53.679] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:29:0)
[14:08:53.679] Timer tick, asking Buildbucket for the build status
[14:08:54.118] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:54.118] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:30:0) after 1m0s
[14:09:54.233] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:30:0)
[14:09:54.233] Timer tick, asking Buildbucket for the build status
[14:09:54.449] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:54.449] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:31:0) after 1m0s
[14:10:54.552] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:31:0)
[14:10:54.552] Timer tick, asking Buildbucket for the build status
[14:10:54.771] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:54.772] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:32:0) after 1m0s
[14:11:54.945] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:32:0)
[14:11:54.945] Timer tick, asking Buildbucket for the build status
[14:11:55.694] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:55.694] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:33:0) after 1m0s
[14:12:55.719] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:33:0)
[14:12:55.719] Timer tick, asking Buildbucket for the build status
[14:12:58.907] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:58.907] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:34:0) after 1m0s
[14:13:58.923] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:34:0)
[14:13:58.923] Timer tick, asking Buildbucket for the build status
[14:13:59.952] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:59.952] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:35:0) after 1m0s
[14:15:00.024] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:35:0)
[14:15:00.024] Timer tick, asking Buildbucket for the build status
[14:15:00.298] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:00.298] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:36:0) after 1m0s
[14:16:00.426] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:36:0)
[14:16:00.426] Timer tick, asking Buildbucket for the build status
[14:16:00.681] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:00.681] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:37:0) after 1m0s
[14:17:00.793] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:37:0)
[14:17:00.793] Timer tick, asking Buildbucket for the build status
[14:17:01.054] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:01.054] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:38:0) after 1m0s
[14:18:01.260] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:38:0)
[14:18:01.260] Timer tick, asking Buildbucket for the build status
[14:18:03.125] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:03.125] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:39:0) after 1m0s
[14:19:03.215] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:39:0)
[14:19:03.215] Timer tick, asking Buildbucket for the build status
[14:19:04.191] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:04.191] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:40:0) after 1m0s
[14:20:04.321] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:40:0)
[14:20:04.321] Timer tick, asking Buildbucket for the build status
[14:20:06.218] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:06.219] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:41:0) after 1m0s
[14:21:06.362] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:41:0)
[14:21:06.362] Timer tick, asking Buildbucket for the build status
[14:21:07.417] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:07.417] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:42:0) after 1m0s
[14:22:07.600] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:42:0)
[14:22:07.600] Timer tick, asking Buildbucket for the build status
[14:22:07.918] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:07.918] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:43:0) after 1m0s
[14:23:07.996] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:43:0)
[14:23:07.996] Timer tick, asking Buildbucket for the build status
[14:23:08.190] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:08.190] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:44:0) after 1m0s
[14:24:08.312] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:44:0)
[14:24:08.312] Timer tick, asking Buildbucket for the build status
[14:24:08.929] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:08.929] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:45:0) after 1m0s
[14:25:08.950] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:45:0)
[14:25:08.950] Timer tick, asking Buildbucket for the build status
[14:25:09.231] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:09.231] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:46:0) after 1m0s
[14:26:09.386] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:46:0)
[14:26:09.386] Timer tick, asking Buildbucket for the build status
[14:26:09.678] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:09.678] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:47:0) after 1m0s
[14:27:09.727] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:47:0)
[14:27:09.727] Timer tick, asking Buildbucket for the build status
[14:27:11.020] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:11.020] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:48:0) after 1m0s
[14:28:11.041] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:48:0)
[14:28:11.041] Timer tick, asking Buildbucket for the build status
[14:28:11.723] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:11.723] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:49:0) after 1m0s
[14:29:11.715] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:49:0)
[14:29:11.715] Timer tick, asking Buildbucket for the build status
[14:29:12.051] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:12.051] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:50:0) after 1m0s
[14:30:12.134] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:50:0)
[14:30:12.134] Timer tick, asking Buildbucket for the build status
[14:30:12.412] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:12.412] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:51:0) after 1m0s
[14:31:12.461] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:51:0)
[14:31:12.461] Timer tick, asking Buildbucket for the build status
[14:31:12.863] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:12.863] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:52:0) after 1m0s
[14:32:12.893] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:52:0)
[14:32:12.893] Timer tick, asking Buildbucket for the build status
[14:32:13.122] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:13.122] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:53:0) after 1m0s
[14:33:13.202] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:53:0)
[14:33:13.202] Timer tick, asking Buildbucket for the build status
[14:33:15.416] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:15.416] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:54:0) after 1m0s
[14:34:15.477] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:54:0)
[14:34:15.477] Timer tick, asking Buildbucket for the build status
[14:34:15.700] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:15.700] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:55:0) after 1m0s
[14:35:15.733] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:55:0)
[14:35:15.733] Timer tick, asking Buildbucket for the build status
[14:35:17.497] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:17.497] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:56:0) after 1m0s
[14:36:17.535] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:56:0)
[14:36:17.535] Timer tick, asking Buildbucket for the build status
[14:36:20.027] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:20.027] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:57:0) after 1m0s
[14:37:20.043] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:57:0)
[14:37:20.043] Timer tick, asking Buildbucket for the build status
[14:37:20.528] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:20.528] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:58:0) after 1m0s
[14:38:20.526] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:58:0)
[14:38:20.526] Timer tick, asking Buildbucket for the build status
[14:38:20.957] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:20.957] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:59:0) after 1m0s
[14:39:21.062] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:59:0)
[14:39:21.062] Timer tick, asking Buildbucket for the build status
[14:39:21.853] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:21.853] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:60:0) after 1m0s
[14:40:21.837] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:60:0)
[14:40:21.837] Timer tick, asking Buildbucket for the build status
[14:40:24.430] Build 8856221449927407072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:24.430] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux - debug:9021651512056819584:61:0) after 1m0s
[14:40:41.732] Received PubSub notification, asking Buildbucket for the build status
[14:40:42.197] Build 8856221449927407072: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:40:42.197] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"completed_ts": "1612449635455608",
"created_by": "project:v8",
"created_ts": "1612446085006280",
"id": "8856221449927407072",
"parameters_json": "{\"builder_name\": \"V8 Linux - debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"oldest_gitiles_revision\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"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\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"parent_got_revision_cp\": \"refs/heads/master@{#72526}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"swarm_hashes\": {\"benchmarks\": \"81bdd5594dad6961afc9f9692e2185a24f862fe2\", \"bot_default\": \"c26650e99767972c9b2ccc3abde330e957138799\", \"d8_default\": \"77cccaf5c6af8f1b1b37b63de7800f95a2757ca2\", \"mjsunit\": \"ef06c2a898d9cf899aeec4e7acfdade7e8c43254\", \"mozilla\": \"b8e3a2649179e027f4e7c21519e2084ce4ac3561\", \"optimize_for_size\": \"af6179ce11800f43b51d34ee93a0f921a0dc09ff\", \"test262\": \"9300bfddfaf624fb2385cc92f537a682c3156215\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux - debug builder\", \"parent_buildnumber:48025\", \"user_agent:recipe\"]}, \"id\": \"f22ff43c-02c1-428d-8319-6a0554746cd2\", \"title\": \"V8 Linux - debug builder/48025\"}]}, \"newest_gitiles_revision\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"oldest_gitiles_revision\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"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\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"parent_got_revision_cp\": \"refs/heads/master@{#72526}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"swarm_hashes\": {\"benchmarks\": \"81bdd5594dad6961afc9f9692e2185a24f862fe2\", \"bot_default\": \"c26650e99767972c9b2ccc3abde330e957138799\", \"d8_default\": \"77cccaf5c6af8f1b1b37b63de7800f95a2757ca2\", \"mjsunit\": \"ef06c2a898d9cf899aeec4e7acfdade7e8c43254\", \"mozilla\": \"b8e3a2649179e027f4e7c21519e2084ce4ac3561\", \"optimize_for_size\": \"af6179ce11800f43b51d34ee93a0f921a0dc09ff\", \"test262\": \"9300bfddfaf624fb2385cc92f537a682c3156215\"}}}",
"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\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"oldest_gitiles_revision\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"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\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"parent_got_revision_cp\": \"refs/heads/master@{#72526}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"swarm_hashes\": {\"benchmarks\": \"81bdd5594dad6961afc9f9692e2185a24f862fe2\", \"bot_default\": \"c26650e99767972c9b2ccc3abde330e957138799\", \"d8_default\": \"77cccaf5c6af8f1b1b37b63de7800f95a2757ca2\", \"mjsunit\": \"ef06c2a898d9cf899aeec4e7acfdade7e8c43254\", \"mozilla\": \"b8e3a2649179e027f4e7c21519e2084ce4ac3561\", \"optimize_for_size\": \"af6179ce11800f43b51d34ee93a0f921a0dc09ff\", \"test262\": \"9300bfddfaf624fb2385cc92f537a682c3156215\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux - debug builder\", \"parent_buildnumber:48025\", \"user_agent:recipe\"]}, \"id\": \"f22ff43c-02c1-428d-8319-6a0554746cd2\", \"title\": \"V8 Linux - debug builder/48025\"}]}, \"bot_id\": \"luci-v8-ci-slim-18-bv0x\", \"builder_group\": \"client.v8\", \"buildername\": \"V8 Linux - debug\", \"buildnumber\": 33792, \"got_revision\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"got_revision_cp\": \"refs/heads/master@{#72526}\", \"newest_gitiles_revision\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"oldest_gitiles_revision\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"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\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"parent_got_revision_cp\": \"refs/heads/master@{#72526}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da\", \"swarm_hashes\": {\"benchmarks\": \"81bdd5594dad6961afc9f9692e2185a24f862fe2\", \"bot_default\": \"c26650e99767972c9b2ccc3abde330e957138799\", \"d8_default\": \"77cccaf5c6af8f1b1b37b63de7800f95a2757ca2\", \"mjsunit\": \"ef06c2a898d9cf899aeec4e7acfdade7e8c43254\", \"mozilla\": \"b8e3a2649179e027f4e7c21519e2084ce4ac3561\", \"optimize_for_size\": \"af6179ce11800f43b51d34ee93a0f921a0dc09ff\", \"test262\": \"9300bfddfaf624fb2385cc92f537a682c3156215\"}}, \"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-18-bv0x\"], \"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\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612446776089146",
"status": "COMPLETED",
"status_changed_ts": "1612449635854780",
"tags": [
"build_address:luci.v8.ci/V8 Linux - debug/33792",
"builder:V8 Linux - debug",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/8aadf7c5cbf10c67ac21e18ce1b1ba38bf6df1da",
"gitiles_ref:refs/heads/master",
"parent_buildername:V8 Linux - debug builder",
"parent_buildnumber:48025",
"scheduler_invocation_id:9021651512056819584",
"scheduler_job_id:v8/ci-V8 Linux - debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8856221449927407072/+/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:5186184fe6375710",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1612449638977699",
"url": "https://ci.chromium.org/b/8856221449927407072",
"utcnow_ts": "1612449642185518"
}
}
[14:40:42.197] Invocation finished in 59m18.606218182s with status SUCCEEDED