[12:08:47.795] New invocation is queued and will start shortly
[12:08:47.795] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[12:08:49.045] Starting the invocation (attempt 1)
[12:08:49.092] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:08:49.094] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:08:49.094] Buildbucket request:
{
"bucket": "luci.v8.ci.br.beta",
"client_operation_id": "9018033459090058928",
"parameters_json": "{\"builder_name\":\"V8 Win32 - debug\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"newest_gitiles_revision\":\"cebddff6f5b0baa0d6b434ab560e22280c5297fc\",\"oldest_gitiles_revision\":\"cebddff6f5b0baa0d6b434ab560e22280c5297fc\",\"parent_build_environment\":{\"gn_args\":\"is_component_build = true is_debug = true symbol_level = 1 target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"},\"parent_buildername\":\"V8 Win32 - debug builder\",\"parent_got_revision\":\"cebddff6f5b0baa0d6b434ab560e22280c5297fc\",\"parent_got_revision_cp\":\"refs/branch-heads/9.0@{#23}\",\"parent_got_swarming_client_revision\":\"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\",\"parent_test_spec\":{\"swarming_dimensions\":{\"cpu\":\"x86-64\",\"os\":\"Windows-7-SP1\"},\"swarming_task_attrs\":{},\"tests\":[[\"mozilla\",1,null,\"\",[],{},{}],[\"test262\",1,\"default\",\"default\",[],{},{}],[\"v8testing\",5,null,\"\",[],{},{}]]},\"revision\":\"cebddff6f5b0baa0d6b434ab560e22280c5297fc\",\"swarm_hashes\":{\"bot_default\":\"3ac328a8f31658bfe762d9c5802d8f88686c4ad1858855d13a2574ffa8dc9bba/319\",\"mozilla\":\"7a78331636b1d1107c3c36a48746e56c6f59bb2508e27ae58849a1add874e4e4/318\",\"test262\":\"3508de9a7483336585d6ad6eeee26057a1c0d4094a933b65523829cff1e2bec3/318\"}},\"tags\":[\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/cebddff6f5b0baa0d6b434ab560e22280c5297fc\",\"gitiles_ref:refs/branch-heads/9.0\",\"parent_buildername:V8 Win32 - debug builder\",\"parent_buildnumber:190\",\"user_agent:recipe\"]},\"id\":\"2b957f76-2108-4b94-8235-cdd637dc9c17\",\"title\":\"V8 Win32 - debug builder/190\"}]},\"newest_gitiles_revision\":\"cebddff6f5b0baa0d6b434ab560e22280c5297fc\",\"oldest_gitiles_revision\":\"cebddff6f5b0baa0d6b434ab560e22280c5297fc\",\"parent_build_environment\":{\"gn_args\":\"is_component_build = true is_debug = true symbol_level = 1 target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"},\"parent_buildername\":\"V8 Win32 - debug builder\",\"parent_got_revision\":\"cebddff6f5b0baa0d6b434ab560e22280c5297fc\",\"parent_got_revision_cp\":\"refs/branch-heads/9.0@{#23}\",\"parent_got_swarming_client_revision\":\"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\",\"parent_test_spec\":{\"swarming_dimensions\":{\"cpu\":\"x86-64\",\"os\":\"Windows-7-SP1\"},\"swarming_task_attrs\":{},\"tests\":[[\"mozilla\",1,null,\"\",[],{},{}],[\"test262\",1,\"default\",\"default\",[],{},{}],[\"v8testing\",5,null,\"\",[],{},{}]]},\"revision\":\"cebddff6f5b0baa0d6b434ab560e22280c5297fc\",\"swarm_hashes\":{\"bot_default\":\"3ac328a8f31658bfe762d9c5802d8f88686c4ad1858855d13a2574ffa8dc9bba/319\",\"mozilla\":\"7a78331636b1d1107c3c36a48746e56c6f59bb2508e27ae58849a1add874e4e4/318\",\"test262\":\"3508de9a7483336585d6ad6eeee26057a1c0d4094a933b65523829cff1e2bec3/318\"}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Win32 - debug",
"scheduler_invocation_id:9018033459090058928",
"scheduler_job_id:v8/ci.br.beta-V8 Win32 - debug",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/cebddff6f5b0baa0d6b434ab560e22280c5297fc",
"gitiles_ref:refs/branch-heads/9.0",
"parent_buildername:V8 Win32 - debug builder",
"parent_buildnumber:190",
"user_agent:recipe"
]
}
[12:08:50.382] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci.br.beta",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1615896529215079",
"id": "8852603396940009776",
"parameters_json": "{\"builder_name\": \"V8 Win32 - debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"oldest_gitiles_revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true symbol_level = 1 target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Win32 - debug builder\", \"parent_got_revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"parent_got_revision_cp\": \"refs/branch-heads/9.0@{#23}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"parent_test_spec\": {\"swarming_dimensions\": {\"cpu\": \"x86-64\", \"os\": \"Windows-7-SP1\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"test262\", 1.0, \"default\", \"default\", [], {}, {}], [\"v8testing\", 5.0, null, \"\", [], {}, {}]]}, \"revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"swarm_hashes\": {\"bot_default\": \"3ac328a8f31658bfe762d9c5802d8f88686c4ad1858855d13a2574ffa8dc9bba/319\", \"mozilla\": \"7a78331636b1d1107c3c36a48746e56c6f59bb2508e27ae58849a1add874e4e4/318\", \"test262\": \"3508de9a7483336585d6ad6eeee26057a1c0d4094a933b65523829cff1e2bec3/318\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"gitiles_ref:refs/branch-heads/9.0\", \"parent_buildername:V8 Win32 - debug builder\", \"parent_buildnumber:190\", \"user_agent:recipe\"]}, \"id\": \"2b957f76-2108-4b94-8235-cdd637dc9c17\", \"title\": \"V8 Win32 - debug builder/190\"}]}, \"newest_gitiles_revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"oldest_gitiles_revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true symbol_level = 1 target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Win32 - debug builder\", \"parent_got_revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"parent_got_revision_cp\": \"refs/branch-heads/9.0@{#23}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"parent_test_spec\": {\"swarming_dimensions\": {\"cpu\": \"x86-64\", \"os\": \"Windows-7-SP1\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"test262\", 1.0, \"default\", \"default\", [], {}, {}], [\"v8testing\", 5.0, null, \"\", [], {}, {}]]}, \"revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"swarm_hashes\": {\"bot_default\": \"3ac328a8f31658bfe762d9c5802d8f88686c4ad1858855d13a2574ffa8dc9bba/319\", \"mozilla\": \"7a78331636b1d1107c3c36a48746e56c6f59bb2508e27ae58849a1add874e4e4/318\", \"test262\": \"3508de9a7483336585d6ad6eeee26057a1c0d4094a933b65523829cff1e2bec3/318\"}}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615896530127358",
"tags": [
"build_address:luci.v8.ci.br.beta/V8 Win32 - debug/186",
"builder:V8 Win32 - debug",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/cebddff6f5b0baa0d6b434ab560e22280c5297fc",
"gitiles_ref:refs/branch-heads/9.0",
"parent_buildername:V8 Win32 - debug builder",
"parent_buildnumber:190",
"scheduler_invocation_id:9018033459090058928",
"scheduler_job_id:v8/ci.br.beta-V8 Win32 - debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8852603396940009776/+/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": "1615896530127478",
"url": "https://ci.chromium.org/b/8852603396940009776",
"utcnow_ts": "1615896530374398"
}
}
[12:08:50.382] Task URL: https://ci.chromium.org/b/8852603396940009776
[12:08:50.382] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:2:0) after 1m0s
[12:09:50.452] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:2:0)
[12:09:50.452] Timer tick, asking Buildbucket for the build status
[12:09:51.030] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:09:51.030] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:3:0) after 1m0s
[12:10:51.020] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:3:0)
[12:10:51.020] Timer tick, asking Buildbucket for the build status
[12:10:51.553] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:10:51.553] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:4:0) after 1m0s
[12:11:51.594] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:4:0)
[12:11:51.594] Timer tick, asking Buildbucket for the build status
[12:11:51.682] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:11:51.682] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:5:0) after 1m0s
[12:12:51.708] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:5:0)
[12:12:51.708] Timer tick, asking Buildbucket for the build status
[12:12:52.191] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:12:52.192] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:6:0) after 1m0s
[12:13:52.242] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:6:0)
[12:13:52.242] Timer tick, asking Buildbucket for the build status
[12:13:52.517] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:13:52.517] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:7:0) after 1m0s
[12:14:52.559] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:7:0)
[12:14:52.559] Timer tick, asking Buildbucket for the build status
[12:14:52.661] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:14:52.661] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:8:0) after 1m0s
[12:15:52.762] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:8:0)
[12:15:52.762] Timer tick, asking Buildbucket for the build status
[12:15:52.852] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:15:52.852] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:9:0) after 1m0s
[12:16:52.856] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:9:0)
[12:16:52.856] Timer tick, asking Buildbucket for the build status
[12:16:52.990] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:16:52.990] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:10:0) after 1m0s
[12:17:53.064] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:10:0)
[12:17:53.064] Timer tick, asking Buildbucket for the build status
[12:17:53.146] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:17:53.146] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:11:0) after 1m0s
[12:18:53.242] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:11:0)
[12:18:53.242] Timer tick, asking Buildbucket for the build status
[12:18:53.347] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:18:53.347] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:12:0) after 1m0s
[12:19:53.451] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:12:0)
[12:19:53.451] Timer tick, asking Buildbucket for the build status
[12:19:53.847] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:19:53.847] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:13:0) after 1m0s
[12:20:53.816] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:13:0)
[12:20:53.816] Timer tick, asking Buildbucket for the build status
[12:20:53.963] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:20:53.963] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:14:0) after 1m0s
[12:21:53.986] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:14:0)
[12:21:53.986] Timer tick, asking Buildbucket for the build status
[12:21:54.072] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:21:54.072] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:15:0) after 1m0s
[12:22:54.191] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:15:0)
[12:22:54.192] Timer tick, asking Buildbucket for the build status
[12:22:54.292] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:22:54.292] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:16:0) after 1m0s
[12:23:54.337] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:16:0)
[12:23:54.337] Timer tick, asking Buildbucket for the build status
[12:23:54.421] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:23:54.421] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:17:0) after 1m0s
[12:24:54.503] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:17:0)
[12:24:54.503] Timer tick, asking Buildbucket for the build status
[12:24:54.715] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:24:54.715] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:18:0) after 1m0s
[12:25:54.782] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:18:0)
[12:25:54.782] Timer tick, asking Buildbucket for the build status
[12:25:54.870] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:25:54.870] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:19:0) after 1m0s
[12:26:54.917] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:19:0)
[12:26:54.917] Timer tick, asking Buildbucket for the build status
[12:26:55.828] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:26:55.828] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:20:0) after 1m0s
[12:27:56.165] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:20:0)
[12:27:56.165] Timer tick, asking Buildbucket for the build status
[12:27:56.267] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:27:56.267] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:21:0) after 1m0s
[12:28:56.373] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:21:0)
[12:28:56.373] Timer tick, asking Buildbucket for the build status
[12:28:56.484] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:28:56.484] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:22:0) after 1m0s
[12:29:56.633] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:22:0)
[12:29:56.634] Timer tick, asking Buildbucket for the build status
[12:29:56.713] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:29:56.713] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:23:0) after 1m0s
[12:30:56.889] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:23:0)
[12:30:56.889] Timer tick, asking Buildbucket for the build status
[12:30:57.442] Build 8852603396940009776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:30:57.442] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:24:0) after 1m0s
[12:31:07.932] Received PubSub notification, asking Buildbucket for the build status
[12:31:08.080] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:57.508] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:24:0)
[12:31:57.508] Timer tick, asking Buildbucket for the build status
[12:31:57.592] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:57.592] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:26:0) after 1m0s
[12:32:58.042] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:26:0)
[12:32:58.042] Timer tick, asking Buildbucket for the build status
[12:32:58.141] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:58.141] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:27:0) after 1m0s
[12:33:58.167] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:27:0)
[12:33:58.167] Timer tick, asking Buildbucket for the build status
[12:33:58.278] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:58.278] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:28:0) after 1m0s
[12:34:58.390] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:28:0)
[12:34:58.390] Timer tick, asking Buildbucket for the build status
[12:34:58.486] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:58.486] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:29:0) after 1m0s
[12:35:58.478] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:29:0)
[12:35:58.478] Timer tick, asking Buildbucket for the build status
[12:35:58.566] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:58.566] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:30:0) after 1m0s
[12:36:58.617] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:30:0)
[12:36:58.617] Timer tick, asking Buildbucket for the build status
[12:36:58.921] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:58.921] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:31:0) after 1m0s
[12:37:58.935] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:31:0)
[12:37:58.935] Timer tick, asking Buildbucket for the build status
[12:37:59.446] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:59.446] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:32:0) after 1m0s
[12:38:59.426] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:32:0)
[12:38:59.427] Timer tick, asking Buildbucket for the build status
[12:38:59.641] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:59.642] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:33:0) after 1m0s
[12:39:59.703] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:33:0)
[12:39:59.703] Timer tick, asking Buildbucket for the build status
[12:39:59.925] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:59.925] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:34:0) after 1m0s
[12:41:00.031] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:34:0)
[12:41:00.031] Timer tick, asking Buildbucket for the build status
[12:41:00.457] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:00.457] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:35:0) after 1m0s
[12:42:00.530] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:35:0)
[12:42:00.530] Timer tick, asking Buildbucket for the build status
[12:42:00.621] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:00.621] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:36:0) after 1m0s
[12:43:00.618] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:36:0)
[12:43:00.618] Timer tick, asking Buildbucket for the build status
[12:43:00.706] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:00.706] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:37:0) after 1m0s
[12:44:00.717] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:37:0)
[12:44:00.717] Timer tick, asking Buildbucket for the build status
[12:44:00.827] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:00.827] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:38:0) after 1m0s
[12:45:00.808] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:38:0)
[12:45:00.808] Timer tick, asking Buildbucket for the build status
[12:45:00.910] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:00.910] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:39:0) after 1m0s
[12:46:01.379] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:39:0)
[12:46:01.379] Timer tick, asking Buildbucket for the build status
[12:46:01.475] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:01.476] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:40:0) after 1m0s
[12:47:01.505] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:40:0)
[12:47:01.505] Timer tick, asking Buildbucket for the build status
[12:47:01.688] Build 8852603396940009776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:01.688] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win32 - debug:9018033459090058928:41:0) after 1m0s
[12:47:18.911] Received PubSub notification, asking Buildbucket for the build status
[12:47:19.028] Build 8852603396940009776: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:47:19.028] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci.br.beta",
"canary_preference": "PROD",
"completed_ts": "1615898838379887",
"created_by": "project:v8",
"created_ts": "1615896529215079",
"id": "8852603396940009776",
"parameters_json": "{\"builder_name\": \"V8 Win32 - debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"oldest_gitiles_revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true symbol_level = 1 target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Win32 - debug builder\", \"parent_got_revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"parent_got_revision_cp\": \"refs/branch-heads/9.0@{#23}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"parent_test_spec\": {\"swarming_dimensions\": {\"cpu\": \"x86-64\", \"os\": \"Windows-7-SP1\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"test262\", 1.0, \"default\", \"default\", [], {}, {}], [\"v8testing\", 5.0, null, \"\", [], {}, {}]]}, \"revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"swarm_hashes\": {\"bot_default\": \"3ac328a8f31658bfe762d9c5802d8f88686c4ad1858855d13a2574ffa8dc9bba/319\", \"mozilla\": \"7a78331636b1d1107c3c36a48746e56c6f59bb2508e27ae58849a1add874e4e4/318\", \"test262\": \"3508de9a7483336585d6ad6eeee26057a1c0d4094a933b65523829cff1e2bec3/318\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"gitiles_ref:refs/branch-heads/9.0\", \"parent_buildername:V8 Win32 - debug builder\", \"parent_buildnumber:190\", \"user_agent:recipe\"]}, \"id\": \"2b957f76-2108-4b94-8235-cdd637dc9c17\", \"title\": \"V8 Win32 - debug builder/190\"}]}, \"newest_gitiles_revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"oldest_gitiles_revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true symbol_level = 1 target_cpu = \\\"x86\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Win32 - debug builder\", \"parent_got_revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"parent_got_revision_cp\": \"refs/branch-heads/9.0@{#23}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"parent_test_spec\": {\"swarming_dimensions\": {\"cpu\": \"x86-64\", \"os\": \"Windows-7-SP1\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"test262\", 1.0, \"default\", \"default\", [], {}, {}], [\"v8testing\", 5.0, null, \"\", [], {}, {}]]}, \"revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"swarm_hashes\": {\"bot_default\": \"3ac328a8f31658bfe762d9c5802d8f88686c4ad1858855d13a2574ffa8dc9bba/319\", \"mozilla\": \"7a78331636b1d1107c3c36a48746e56c6f59bb2508e27ae58849a1add874e4e4/318\", \"test262\": \"3508de9a7483336585d6ad6eeee26057a1c0d4094a933b65523829cff1e2bec3/318\"}}}",
"project": "v8",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"cebddff6f5b0baa0d6b434ab560e22280c5297fc\", \"got_revision_cp\": \"refs/branch-heads/9.0@{#23}\"}, \"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-26-4kka\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615897865741136",
"status": "COMPLETED",
"status_changed_ts": "1615897866414063",
"tags": [
"build_address:luci.v8.ci.br.beta/V8 Win32 - debug/186",
"builder:V8 Win32 - debug",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/cebddff6f5b0baa0d6b434ab560e22280c5297fc",
"gitiles_ref:refs/branch-heads/9.0",
"parent_buildername:V8 Win32 - debug builder",
"parent_buildnumber:190",
"scheduler_invocation_id:9018033459090058928",
"scheduler_job_id:v8/ci.br.beta-V8 Win32 - debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8852603396940009776/+/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:5253c1ddf282aa10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1615898838380216",
"url": "https://ci.chromium.org/b/8852603396940009776",
"utcnow_ts": "1615898839020616"
}
}
[12:47:19.028] Invocation finished in 38m31.247291225s with status SUCCEEDED