[17:42:06.190] New invocation is queued and will start shortly
[17:42:06.190] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[17:42:07.352] Starting the invocation (attempt 1)
[17:42:07.415] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:42:07.415] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:42:07.415] Buildbucket request:
{
"bucket": "luci.v8.ci.br.beta",
"client_operation_id": "9018012489262619888",
"parameters_json": "{\"builder_name\":\"V8 Linux64 TSAN\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"newest_gitiles_revision\":\"21b892c549fa26cdb6e816b9acbf5e93a9607558\",\"oldest_gitiles_revision\":\"21b892c549fa26cdb6e816b9acbf5e93a9607558\",\"parent_build_environment\":{\"gn_args\":\"is_component_build = false is_debug = false is_tsan = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_test_features = true\"},\"parent_buildername\":\"V8 Linux64 TSAN - builder\",\"parent_got_revision\":\"21b892c549fa26cdb6e816b9acbf5e93a9607558\",\"parent_got_revision_cp\":\"refs/branch-heads/9.0@{#24}\",\"parent_got_swarming_client_revision\":\"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\",\"parent_test_spec\":{\"swarming_dimensions\":{\"os\":\"Ubuntu-16.04\"},\"swarming_task_attrs\":{},\"tests\":[[\"benchmarks\",1,null,\"\",[],{},{}],[\"mozilla\",1,null,\"\",[],{},{}],[\"test262\",3,\"default\",\"default\",[],{},{}],[\"v8testing\",5,null,\"\",[],{},{}],[\"v8testing\",3,\"extra\",\"extra\",[],{},{}],[\"v8testing\",1,\"slow_path\",\"slow_path\",[],{},{}],[\"v8testing\",1,\"stress_concurrent_allocation\",\"stress_concurrent_allocation\",[],{},{}]]},\"revision\":\"21b892c549fa26cdb6e816b9acbf5e93a9607558\",\"swarm_hashes\":{\"benchmarks\":\"f677eebd5807d066780c7dcb79b012d0c1c67eb2ac527a9dc0a3bc682705a991/403\",\"bot_default\":\"178cee2609248d16515f23eaf996db731c07fff71290ee5075d4267680da7261/404\",\"mozilla\":\"12aeb05090e7b6f9394499e153118e4a70f3ecb58bcbed8739e301bf77808ea3/403\",\"test262\":\"2ba09d8d4a42b646c7d90fe4417d89c667e2911dffa7df307e29f42b2ee70866/403\"}},\"tags\":[\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/21b892c549fa26cdb6e816b9acbf5e93a9607558\",\"gitiles_ref:refs/branch-heads/9.0\",\"parent_buildername:V8 Linux64 TSAN - builder\",\"parent_buildnumber:193\",\"user_agent:recipe\"]},\"id\":\"0d572524-f8ae-4090-8183-3e2464623eb9\",\"title\":\"V8 Linux64 TSAN - builder/193\"}]},\"newest_gitiles_revision\":\"21b892c549fa26cdb6e816b9acbf5e93a9607558\",\"oldest_gitiles_revision\":\"21b892c549fa26cdb6e816b9acbf5e93a9607558\",\"parent_build_environment\":{\"gn_args\":\"is_component_build = false is_debug = false is_tsan = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_test_features = true\"},\"parent_buildername\":\"V8 Linux64 TSAN - builder\",\"parent_got_revision\":\"21b892c549fa26cdb6e816b9acbf5e93a9607558\",\"parent_got_revision_cp\":\"refs/branch-heads/9.0@{#24}\",\"parent_got_swarming_client_revision\":\"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\",\"parent_test_spec\":{\"swarming_dimensions\":{\"os\":\"Ubuntu-16.04\"},\"swarming_task_attrs\":{},\"tests\":[[\"benchmarks\",1,null,\"\",[],{},{}],[\"mozilla\",1,null,\"\",[],{},{}],[\"test262\",3,\"default\",\"default\",[],{},{}],[\"v8testing\",5,null,\"\",[],{},{}],[\"v8testing\",3,\"extra\",\"extra\",[],{},{}],[\"v8testing\",1,\"slow_path\",\"slow_path\",[],{},{}],[\"v8testing\",1,\"stress_concurrent_allocation\",\"stress_concurrent_allocation\",[],{},{}]]},\"revision\":\"21b892c549fa26cdb6e816b9acbf5e93a9607558\",\"swarm_hashes\":{\"benchmarks\":\"f677eebd5807d066780c7dcb79b012d0c1c67eb2ac527a9dc0a3bc682705a991/403\",\"bot_default\":\"178cee2609248d16515f23eaf996db731c07fff71290ee5075d4267680da7261/404\",\"mozilla\":\"12aeb05090e7b6f9394499e153118e4a70f3ecb58bcbed8739e301bf77808ea3/403\",\"test262\":\"2ba09d8d4a42b646c7d90fe4417d89c667e2911dffa7df307e29f42b2ee70866/403\"}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Linux64 TSAN",
"scheduler_invocation_id:9018012489262619888",
"scheduler_job_id:v8/ci.br.beta-V8 Linux64 TSAN",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/21b892c549fa26cdb6e816b9acbf5e93a9607558",
"gitiles_ref:refs/branch-heads/9.0",
"parent_buildername:V8 Linux64 TSAN - builder",
"parent_buildnumber:193",
"user_agent:recipe"
]
}
[17:42:11.746] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci.br.beta",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1615916527705783",
"id": "8852582427003645728",
"parameters_json": "{\"builder_name\": \"V8 Linux64 TSAN\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"oldest_gitiles_revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = false is_debug = false is_tsan = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_test_features = true\"}, \"parent_buildername\": \"V8 Linux64 TSAN - builder\", \"parent_got_revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"parent_got_revision_cp\": \"refs/branch-heads/9.0@{#24}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"benchmarks\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"test262\", 3.0, \"default\", \"default\", [], {}, {}], [\"v8testing\", 5.0, null, \"\", [], {}, {}], [\"v8testing\", 3.0, \"extra\", \"extra\", [], {}, {}], [\"v8testing\", 1.0, \"slow_path\", \"slow_path\", [], {}, {}], [\"v8testing\", 1.0, \"stress_concurrent_allocation\", \"stress_concurrent_allocation\", [], {}, {}]]}, \"revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"swarm_hashes\": {\"benchmarks\": \"f677eebd5807d066780c7dcb79b012d0c1c67eb2ac527a9dc0a3bc682705a991/403\", \"bot_default\": \"178cee2609248d16515f23eaf996db731c07fff71290ee5075d4267680da7261/404\", \"mozilla\": \"12aeb05090e7b6f9394499e153118e4a70f3ecb58bcbed8739e301bf77808ea3/403\", \"test262\": \"2ba09d8d4a42b646c7d90fe4417d89c667e2911dffa7df307e29f42b2ee70866/403\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"gitiles_ref:refs/branch-heads/9.0\", \"parent_buildername:V8 Linux64 TSAN - builder\", \"parent_buildnumber:193\", \"user_agent:recipe\"]}, \"id\": \"0d572524-f8ae-4090-8183-3e2464623eb9\", \"title\": \"V8 Linux64 TSAN - builder/193\"}]}, \"newest_gitiles_revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"oldest_gitiles_revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = false is_debug = false is_tsan = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_test_features = true\"}, \"parent_buildername\": \"V8 Linux64 TSAN - builder\", \"parent_got_revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"parent_got_revision_cp\": \"refs/branch-heads/9.0@{#24}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"benchmarks\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"test262\", 3.0, \"default\", \"default\", [], {}, {}], [\"v8testing\", 5.0, null, \"\", [], {}, {}], [\"v8testing\", 3.0, \"extra\", \"extra\", [], {}, {}], [\"v8testing\", 1.0, \"slow_path\", \"slow_path\", [], {}, {}], [\"v8testing\", 1.0, \"stress_concurrent_allocation\", \"stress_concurrent_allocation\", [], {}, {}]]}, \"revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"swarm_hashes\": {\"benchmarks\": \"f677eebd5807d066780c7dcb79b012d0c1c67eb2ac527a9dc0a3bc682705a991/403\", \"bot_default\": \"178cee2609248d16515f23eaf996db731c07fff71290ee5075d4267680da7261/404\", \"mozilla\": \"12aeb05090e7b6f9394499e153118e4a70f3ecb58bcbed8739e301bf77808ea3/403\", \"test262\": \"2ba09d8d4a42b646c7d90fe4417d89c667e2911dffa7df307e29f42b2ee70866/403\"}}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615916531501046",
"tags": [
"build_address:luci.v8.ci.br.beta/V8 Linux64 TSAN/186",
"builder:V8 Linux64 TSAN",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/21b892c549fa26cdb6e816b9acbf5e93a9607558",
"gitiles_ref:refs/branch-heads/9.0",
"parent_buildername:V8 Linux64 TSAN - builder",
"parent_buildnumber:193",
"scheduler_invocation_id:9018012489262619888",
"scheduler_job_id:v8/ci.br.beta-V8 Linux64 TSAN",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8852582427003645728/+/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": "1615916531501214",
"url": "https://ci.chromium.org/b/8852582427003645728",
"utcnow_ts": "1615916531726989"
}
}
[17:42:11.746] Task URL: https://ci.chromium.org/b/8852582427003645728
[17:42:11.746] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:2:0) after 1m0s
[17:43:11.720] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:2:0)
[17:43:11.720] Timer tick, asking Buildbucket for the build status
[17:43:12.175] Build 8852582427003645728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:43:12.175] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:3:0) after 1m0s
[17:44:12.207] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:3:0)
[17:44:12.207] Timer tick, asking Buildbucket for the build status
[17:44:12.738] Build 8852582427003645728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:44:12.738] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:4:0) after 1m0s
[17:45:12.728] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:4:0)
[17:45:12.728] Timer tick, asking Buildbucket for the build status
[17:45:13.504] Build 8852582427003645728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:45:13.504] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:5:0) after 1m0s
[17:46:13.560] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:5:0)
[17:46:13.560] Timer tick, asking Buildbucket for the build status
[17:46:14.323] Build 8852582427003645728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:46:14.323] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:6:0) after 1m0s
[17:47:14.397] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:6:0)
[17:47:14.397] Timer tick, asking Buildbucket for the build status
[17:47:14.919] Build 8852582427003645728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:47:14.919] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:7:0) after 1m0s
[17:48:14.974] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:7:0)
[17:48:14.974] Timer tick, asking Buildbucket for the build status
[17:48:15.221] Build 8852582427003645728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:48:15.221] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:8:0) after 1m0s
[17:49:15.198] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:8:0)
[17:49:15.198] Timer tick, asking Buildbucket for the build status
[17:49:15.370] Build 8852582427003645728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:49:15.370] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:9:0) after 1m0s
[17:50:15.401] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:9:0)
[17:50:15.401] Timer tick, asking Buildbucket for the build status
[17:50:15.890] Build 8852582427003645728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:50:15.890] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:10:0) after 1m0s
[17:51:15.943] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:10:0)
[17:51:15.943] Timer tick, asking Buildbucket for the build status
[17:51:16.077] Build 8852582427003645728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:51:16.077] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:11:0) after 1m0s
[17:52:16.154] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:11:0)
[17:52:16.154] Timer tick, asking Buildbucket for the build status
[17:52:16.246] Build 8852582427003645728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:52:16.246] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:12:0) after 1m0s
[17:53:16.260] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:12:0)
[17:53:16.261] Timer tick, asking Buildbucket for the build status
[17:53:16.737] Build 8852582427003645728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:53:16.738] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:13:0) after 1m0s
[17:54:16.775] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:13:0)
[17:54:16.775] Timer tick, asking Buildbucket for the build status
[17:54:17.984] Build 8852582427003645728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:54:17.984] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:14:0) after 1m0s
[17:55:18.002] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:14:0)
[17:55:18.002] Timer tick, asking Buildbucket for the build status
[17:55:18.129] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:18.129] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:15:0) after 1m0s
[17:55:18.476] Received PubSub notification, asking Buildbucket for the build status
[17:55:18.591] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:18.147] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:15:0)
[17:56:18.147] Timer tick, asking Buildbucket for the build status
[17:56:18.290] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:18.290] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:17:0) after 1m0s
[17:57:18.348] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:17:0)
[17:57:18.348] Timer tick, asking Buildbucket for the build status
[17:57:18.518] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:18.518] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:18:0) after 1m0s
[17:58:18.553] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:18:0)
[17:58:18.554] Timer tick, asking Buildbucket for the build status
[17:58:18.685] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:18.685] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:19:0) after 1m0s
[17:59:18.699] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:19:0)
[17:59:18.699] Timer tick, asking Buildbucket for the build status
[17:59:18.884] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:18.884] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:20:0) after 1m0s
[18:00:18.955] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:20:0)
[18:00:18.955] Timer tick, asking Buildbucket for the build status
[18:00:19.660] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:19.660] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:21:0) after 1m0s
[18:01:19.696] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:21:0)
[18:01:19.696] Timer tick, asking Buildbucket for the build status
[18:01:19.816] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:19.816] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:22:0) after 1m0s
[18:02:19.863] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:22:0)
[18:02:19.863] Timer tick, asking Buildbucket for the build status
[18:02:20.250] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:20.250] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:23:0) after 1m0s
[18:03:20.329] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:23:0)
[18:03:20.329] Timer tick, asking Buildbucket for the build status
[18:03:20.467] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:20.467] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:24:0) after 1m0s
[18:04:20.486] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:24:0)
[18:04:20.486] Timer tick, asking Buildbucket for the build status
[18:04:20.587] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:20.587] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:25:0) after 1m0s
[18:05:20.704] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:25:0)
[18:05:20.704] Timer tick, asking Buildbucket for the build status
[18:05:20.821] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:20.821] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:26:0) after 1m0s
[18:06:20.868] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:26:0)
[18:06:20.868] Timer tick, asking Buildbucket for the build status
[18:06:21.019] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:21.019] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:27:0) after 1m0s
[18:07:21.075] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:27:0)
[18:07:21.075] Timer tick, asking Buildbucket for the build status
[18:07:21.198] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:21.198] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:28:0) after 1m0s
[18:08:21.205] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:28:0)
[18:08:21.205] Timer tick, asking Buildbucket for the build status
[18:08:21.553] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:21.553] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:29:0) after 1m0s
[18:09:21.630] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:29:0)
[18:09:21.630] Timer tick, asking Buildbucket for the build status
[18:09:22.450] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:22.450] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:30:0) after 1m0s
[18:10:22.500] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:30:0)
[18:10:22.500] Timer tick, asking Buildbucket for the build status
[18:10:23.213] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:23.213] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:31:0) after 1m0s
[18:11:23.232] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:31:0)
[18:11:23.232] Timer tick, asking Buildbucket for the build status
[18:11:23.396] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:23.396] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:32:0) after 1m0s
[18:12:23.579] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:32:0)
[18:12:23.579] Timer tick, asking Buildbucket for the build status
[18:12:23.804] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:23.804] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:33:0) after 1m0s
[18:13:23.888] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:33:0)
[18:13:23.888] Timer tick, asking Buildbucket for the build status
[18:13:24.024] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:24.024] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:34:0) after 1m0s
[18:14:24.744] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:34:0)
[18:14:24.744] Timer tick, asking Buildbucket for the build status
[18:14:25.232] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:25.232] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:35:0) after 1m0s
[18:15:25.299] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:35:0)
[18:15:25.299] Timer tick, asking Buildbucket for the build status
[18:15:25.431] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:25.431] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:36:0) after 1m0s
[18:16:25.905] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:36:0)
[18:16:25.905] Timer tick, asking Buildbucket for the build status
[18:16:26.230] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:26.230] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:37:0) after 1m0s
[18:17:26.287] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:37:0)
[18:17:26.287] Timer tick, asking Buildbucket for the build status
[18:17:26.768] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:26.768] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:38:0) after 1m0s
[18:18:27.035] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:38:0)
[18:18:27.035] Timer tick, asking Buildbucket for the build status
[18:18:27.232] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:27.232] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:39:0) after 1m0s
[18:19:27.825] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:39:0)
[18:19:27.825] Timer tick, asking Buildbucket for the build status
[18:19:27.944] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:27.944] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:40:0) after 1m0s
[18:20:28.252] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:40:0)
[18:20:28.252] Timer tick, asking Buildbucket for the build status
[18:20:28.718] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:28.718] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:41:0) after 1m0s
[18:21:29.442] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:41:0)
[18:21:29.442] Timer tick, asking Buildbucket for the build status
[18:21:29.626] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:29.627] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:42:0) after 1m0s
[18:22:29.797] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:42:0)
[18:22:29.797] Timer tick, asking Buildbucket for the build status
[18:22:32.672] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:32.672] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:43:0) after 1m0s
[18:23:33.469] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:43:0)
[18:23:33.469] Timer tick, asking Buildbucket for the build status
[18:23:33.617] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:33.617] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:44:0) after 1m0s
[18:24:34.201] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:44:0)
[18:24:34.201] Timer tick, asking Buildbucket for the build status
[18:24:34.313] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:34.313] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:45:0) after 1m0s
[18:25:34.411] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:45:0)
[18:25:34.411] Timer tick, asking Buildbucket for the build status
[18:25:34.514] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:34.514] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:46:0) after 1m0s
[18:26:35.942] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:46:0)
[18:26:35.943] Timer tick, asking Buildbucket for the build status
[18:26:36.412] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:36.412] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:47:0) after 1m0s
[18:27:36.683] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:47:0)
[18:27:36.683] Timer tick, asking Buildbucket for the build status
[18:27:39.351] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:39.351] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:48:0) after 1m0s
[18:28:39.384] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:48:0)
[18:28:39.384] Timer tick, asking Buildbucket for the build status
[18:28:39.509] Build 8852582427003645728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:39.509] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 TSAN:9018012489262619888:49:0) after 1m0s
[18:29:24.795] Received PubSub notification, asking Buildbucket for the build status
[18:29:25.136] Build 8852582427003645728: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:29:25.136] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci.br.beta",
"canary_preference": "PROD",
"completed_ts": "1615919364200348",
"created_by": "project:v8",
"created_ts": "1615916527705783",
"id": "8852582427003645728",
"parameters_json": "{\"builder_name\": \"V8 Linux64 TSAN\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"oldest_gitiles_revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = false is_debug = false is_tsan = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_test_features = true\"}, \"parent_buildername\": \"V8 Linux64 TSAN - builder\", \"parent_got_revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"parent_got_revision_cp\": \"refs/branch-heads/9.0@{#24}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"benchmarks\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"test262\", 3.0, \"default\", \"default\", [], {}, {}], [\"v8testing\", 5.0, null, \"\", [], {}, {}], [\"v8testing\", 3.0, \"extra\", \"extra\", [], {}, {}], [\"v8testing\", 1.0, \"slow_path\", \"slow_path\", [], {}, {}], [\"v8testing\", 1.0, \"stress_concurrent_allocation\", \"stress_concurrent_allocation\", [], {}, {}]]}, \"revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"swarm_hashes\": {\"benchmarks\": \"f677eebd5807d066780c7dcb79b012d0c1c67eb2ac527a9dc0a3bc682705a991/403\", \"bot_default\": \"178cee2609248d16515f23eaf996db731c07fff71290ee5075d4267680da7261/404\", \"mozilla\": \"12aeb05090e7b6f9394499e153118e4a70f3ecb58bcbed8739e301bf77808ea3/403\", \"test262\": \"2ba09d8d4a42b646c7d90fe4417d89c667e2911dffa7df307e29f42b2ee70866/403\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"gitiles_ref:refs/branch-heads/9.0\", \"parent_buildername:V8 Linux64 TSAN - builder\", \"parent_buildnumber:193\", \"user_agent:recipe\"]}, \"id\": \"0d572524-f8ae-4090-8183-3e2464623eb9\", \"title\": \"V8 Linux64 TSAN - builder/193\"}]}, \"newest_gitiles_revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"oldest_gitiles_revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = false is_debug = false is_tsan = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_test_features = true\"}, \"parent_buildername\": \"V8 Linux64 TSAN - builder\", \"parent_got_revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"parent_got_revision_cp\": \"refs/branch-heads/9.0@{#24}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"benchmarks\", 1.0, null, \"\", [], {}, {}], [\"mozilla\", 1.0, null, \"\", [], {}, {}], [\"test262\", 3.0, \"default\", \"default\", [], {}, {}], [\"v8testing\", 5.0, null, \"\", [], {}, {}], [\"v8testing\", 3.0, \"extra\", \"extra\", [], {}, {}], [\"v8testing\", 1.0, \"slow_path\", \"slow_path\", [], {}, {}], [\"v8testing\", 1.0, \"stress_concurrent_allocation\", \"stress_concurrent_allocation\", [], {}, {}]]}, \"revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"swarm_hashes\": {\"benchmarks\": \"f677eebd5807d066780c7dcb79b012d0c1c67eb2ac527a9dc0a3bc682705a991/403\", \"bot_default\": \"178cee2609248d16515f23eaf996db731c07fff71290ee5075d4267680da7261/404\", \"mozilla\": \"12aeb05090e7b6f9394499e153118e4a70f3ecb58bcbed8739e301bf77808ea3/403\", \"test262\": \"2ba09d8d4a42b646c7d90fe4417d89c667e2911dffa7df307e29f42b2ee70866/403\"}}}",
"project": "v8",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"21b892c549fa26cdb6e816b9acbf5e93a9607558\", \"got_revision_cp\": \"refs/branch-heads/9.0@{#24}\"}, \"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-23-mqat\"], \"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": "1615917311036135",
"status": "COMPLETED",
"status_changed_ts": "1615917311433993",
"tags": [
"build_address:luci.v8.ci.br.beta/V8 Linux64 TSAN/186",
"builder:V8 Linux64 TSAN",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/21b892c549fa26cdb6e816b9acbf5e93a9607558",
"gitiles_ref:refs/branch-heads/9.0",
"parent_buildername:V8 Linux64 TSAN - builder",
"parent_buildnumber:193",
"scheduler_invocation_id:9018012489262619888",
"scheduler_job_id:v8/ci.br.beta-V8 Linux64 TSAN",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8852582427003645728/+/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:5254f312547adc10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1615919364200989",
"url": "https://ci.chromium.org/b/8852582427003645728",
"utcnow_ts": "1615919365123075"
}
}
[18:29:25.136] Invocation finished in 47m18.968987719s with status SUCCEEDED