[12:58:43.418] New invocation is queued and will start shortly
[12:58:43.418] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[12:58:44.564] Starting the invocation (attempt 1)
[12:58:44.603] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:58:44.603] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:58:44.603] Buildbucket request:
{
"bucket": "luci.v8.ci.br.beta",
"client_operation_id": "9018664496716925104",
"parameters_json": "{\"builder_name\":\"V8 Linux64 - custom snapshot - debug\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"newest_gitiles_revision\":\"92be48b817eb17f89b8e36d8124b8c9e96852519\",\"oldest_gitiles_revision\":\"92be48b817eb17f89b8e36d8124b8c9e96852519\",\"parent_build_environment\":{\"gn_args\":\"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_embed_script = \\\"test/mjsunit/mjsunit.js\\\" v8_enable_backtrace = true v8_enable_slow_dchecks = true\"},\"parent_buildername\":\"V8 Linux64 - custom snapshot - debug builder\",\"parent_got_revision\":\"92be48b817eb17f89b8e36d8124b8c9e96852519\",\"parent_got_revision_cp\":\"refs/branch-heads/9.0@{#15}\",\"parent_got_swarming_client_revision\":\"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\",\"parent_test_spec\":{\"swarming_dimensions\":{\"os\":\"Ubuntu-16.04\"},\"swarming_task_attrs\":{},\"tests\":[[\"mjsunit\",1,null,\"\",[\"--no-harness\"],{},{}]]},\"revision\":\"92be48b817eb17f89b8e36d8124b8c9e96852519\",\"swarm_hashes\":{\"mjsunit\":\"63b356a9ad6ed83fb90224e8f7c011a7def26a71667c8059d7e2e882233199b6/318\"}},\"tags\":[\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/92be48b817eb17f89b8e36d8124b8c9e96852519\",\"gitiles_ref:refs/branch-heads/9.0\",\"parent_buildername:V8 Linux64 - custom snapshot - debug builder\",\"parent_buildnumber:185\",\"user_agent:recipe\"]},\"id\":\"b5c00b44-ccce-4bf3-9117-3075cb8ee97a\",\"title\":\"V8 Linux64 - custom snapshot - debug builder/185\"}]},\"newest_gitiles_revision\":\"92be48b817eb17f89b8e36d8124b8c9e96852519\",\"oldest_gitiles_revision\":\"92be48b817eb17f89b8e36d8124b8c9e96852519\",\"parent_build_environment\":{\"gn_args\":\"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_embed_script = \\\"test/mjsunit/mjsunit.js\\\" v8_enable_backtrace = true v8_enable_slow_dchecks = true\"},\"parent_buildername\":\"V8 Linux64 - custom snapshot - debug builder\",\"parent_got_revision\":\"92be48b817eb17f89b8e36d8124b8c9e96852519\",\"parent_got_revision_cp\":\"refs/branch-heads/9.0@{#15}\",\"parent_got_swarming_client_revision\":\"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\",\"parent_test_spec\":{\"swarming_dimensions\":{\"os\":\"Ubuntu-16.04\"},\"swarming_task_attrs\":{},\"tests\":[[\"mjsunit\",1,null,\"\",[\"--no-harness\"],{},{}]]},\"revision\":\"92be48b817eb17f89b8e36d8124b8c9e96852519\",\"swarm_hashes\":{\"mjsunit\":\"63b356a9ad6ed83fb90224e8f7c011a7def26a71667c8059d7e2e882233199b6/318\"}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Linux64 - custom snapshot - debug",
"scheduler_invocation_id:9018664496716925104",
"scheduler_job_id:v8/ci.br.beta-V8 Linux64 - custom snapshot - debug",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/92be48b817eb17f89b8e36d8124b8c9e96852519",
"gitiles_ref:refs/branch-heads/9.0",
"parent_buildername:V8 Linux64 - custom snapshot - debug builder",
"parent_buildnumber:185",
"user_agent:recipe"
]
}
[12:58:46.596] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci.br.beta",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:v8",
"created_ts": "1615294724749361",
"id": "8853234434659552848",
"parameters_json": "{\"builder_name\": \"V8 Linux64 - custom snapshot - debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"oldest_gitiles_revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_embed_script = \\\"test/mjsunit/mjsunit.js\\\" v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Linux64 - custom snapshot - debug builder\", \"parent_got_revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"parent_got_revision_cp\": \"refs/branch-heads/9.0@{#15}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"mjsunit\", 1.0, null, \"\", [\"--no-harness\"], {}, {}]]}, \"revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"swarm_hashes\": {\"mjsunit\": \"63b356a9ad6ed83fb90224e8f7c011a7def26a71667c8059d7e2e882233199b6/318\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/92be48b817eb17f89b8e36d8124b8c9e96852519\", \"gitiles_ref:refs/branch-heads/9.0\", \"parent_buildername:V8 Linux64 - custom snapshot - debug builder\", \"parent_buildnumber:185\", \"user_agent:recipe\"]}, \"id\": \"b5c00b44-ccce-4bf3-9117-3075cb8ee97a\", \"title\": \"V8 Linux64 - custom snapshot - debug builder/185\"}]}, \"newest_gitiles_revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"oldest_gitiles_revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_embed_script = \\\"test/mjsunit/mjsunit.js\\\" v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Linux64 - custom snapshot - debug builder\", \"parent_got_revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"parent_got_revision_cp\": \"refs/branch-heads/9.0@{#15}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"mjsunit\", 1.0, null, \"\", [\"--no-harness\"], {}, {}]]}, \"revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"swarm_hashes\": {\"mjsunit\": \"63b356a9ad6ed83fb90224e8f7c011a7def26a71667c8059d7e2e882233199b6/318\"}}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615294726295343",
"tags": [
"build_address:luci.v8.ci.br.beta/V8 Linux64 - custom snapshot - debug/178",
"builder:V8 Linux64 - custom snapshot - debug",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/92be48b817eb17f89b8e36d8124b8c9e96852519",
"gitiles_ref:refs/branch-heads/9.0",
"parent_buildername:V8 Linux64 - custom snapshot - debug builder",
"parent_buildnumber:185",
"scheduler_invocation_id:9018664496716925104",
"scheduler_job_id:v8/ci.br.beta-V8 Linux64 - custom snapshot - debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8853234434659552848/+/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": "1615294726295476",
"url": "https://ci.chromium.org/b/8853234434659552848",
"utcnow_ts": "1615294726553419"
}
}
[12:58:46.596] Task URL: https://ci.chromium.org/b/8853234434659552848
[12:58:46.596] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:2:0) after 1m0s
[12:59:46.654] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:2:0)
[12:59:46.654] Timer tick, asking Buildbucket for the build status
[12:59:46.769] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:59:46.769] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:3:0) after 1m0s
[13:00:46.771] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:3:0)
[13:00:46.771] Timer tick, asking Buildbucket for the build status
[13:00:47.029] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:00:47.029] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:4:0) after 1m0s
[13:01:47.039] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:4:0)
[13:01:47.039] Timer tick, asking Buildbucket for the build status
[13:01:47.120] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:01:47.121] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:5:0) after 1m0s
[13:02:47.144] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:5:0)
[13:02:47.144] Timer tick, asking Buildbucket for the build status
[13:02:47.232] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:02:47.232] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:6:0) after 1m0s
[13:03:47.209] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:6:0)
[13:03:47.209] Timer tick, asking Buildbucket for the build status
[13:03:47.277] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:03:47.277] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:7:0) after 1m0s
[13:04:47.286] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:7:0)
[13:04:47.286] Timer tick, asking Buildbucket for the build status
[13:04:47.496] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:04:47.496] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:8:0) after 1m0s
[13:05:47.512] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:8:0)
[13:05:47.512] Timer tick, asking Buildbucket for the build status
[13:05:47.683] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:05:47.683] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:9:0) after 1m0s
[13:06:47.734] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:9:0)
[13:06:47.734] Timer tick, asking Buildbucket for the build status
[13:06:47.799] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:06:47.799] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:10:0) after 1m0s
[13:07:47.860] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:10:0)
[13:07:47.860] Timer tick, asking Buildbucket for the build status
[13:07:47.952] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:07:47.952] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:11:0) after 1m0s
[13:08:47.966] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:11:0)
[13:08:47.966] Timer tick, asking Buildbucket for the build status
[13:08:48.064] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:08:48.064] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:12:0) after 1m0s
[13:09:48.100] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:12:0)
[13:09:48.100] Timer tick, asking Buildbucket for the build status
[13:09:48.173] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:09:48.173] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:13:0) after 1m0s
[13:10:48.240] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:13:0)
[13:10:48.240] Timer tick, asking Buildbucket for the build status
[13:10:48.331] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:10:48.331] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:14:0) after 1m0s
[13:11:48.312] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:14:0)
[13:11:48.312] Timer tick, asking Buildbucket for the build status
[13:11:48.914] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:11:48.914] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:15:0) after 1m0s
[13:12:48.958] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:15:0)
[13:12:48.958] Timer tick, asking Buildbucket for the build status
[13:12:49.600] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:12:49.600] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:16:0) after 1m0s
[13:13:49.630] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:16:0)
[13:13:49.630] Timer tick, asking Buildbucket for the build status
[13:13:49.708] Build 8853234434659552848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:13:49.708] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:17:0) after 1m0s
[13:14:37.564] Received PubSub notification, asking Buildbucket for the build status
[13:14:37.676] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:49.727] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:17:0)
[13:14:49.727] Timer tick, asking Buildbucket for the build status
[13:14:49.831] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:49.831] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:19:0) after 1m0s
[13:15:49.836] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:19:0)
[13:15:49.836] Timer tick, asking Buildbucket for the build status
[13:15:50.050] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:50.050] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:20:0) after 1m0s
[13:16:50.183] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:20:0)
[13:16:50.183] Timer tick, asking Buildbucket for the build status
[13:16:50.261] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:50.261] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:21:0) after 1m0s
[13:17:50.295] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:21:0)
[13:17:50.295] Timer tick, asking Buildbucket for the build status
[13:17:50.436] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:50.436] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:22:0) after 1m0s
[13:18:50.538] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:22:0)
[13:18:50.538] Timer tick, asking Buildbucket for the build status
[13:18:50.622] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:50.622] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:23:0) after 1m0s
[13:19:50.727] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:23:0)
[13:19:50.727] Timer tick, asking Buildbucket for the build status
[13:19:51.035] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:51.035] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:24:0) after 1m0s
[13:20:51.142] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:24:0)
[13:20:51.142] Timer tick, asking Buildbucket for the build status
[13:20:51.222] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:51.222] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:25:0) after 1m0s
[13:21:51.247] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:25:0)
[13:21:51.247] Timer tick, asking Buildbucket for the build status
[13:21:51.329] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:51.329] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:26:0) after 1m0s
[13:22:51.412] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:26:0)
[13:22:51.412] Timer tick, asking Buildbucket for the build status
[13:22:51.492] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:51.492] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:27:0) after 1m0s
[13:23:51.497] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:27:0)
[13:23:51.497] Timer tick, asking Buildbucket for the build status
[13:23:52.066] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:52.066] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:28:0) after 1m0s
[13:24:52.079] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:28:0)
[13:24:52.079] Timer tick, asking Buildbucket for the build status
[13:24:52.147] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:52.147] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:29:0) after 1m0s
[13:25:52.224] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:29:0)
[13:25:52.224] Timer tick, asking Buildbucket for the build status
[13:25:53.076] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:53.076] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:30:0) after 1m0s
[13:26:53.116] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:30:0)
[13:26:53.116] Timer tick, asking Buildbucket for the build status
[13:26:53.207] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:53.207] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:31:0) after 1m0s
[13:27:53.254] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:31:0)
[13:27:53.254] Timer tick, asking Buildbucket for the build status
[13:27:53.331] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:53.331] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:32:0) after 1m0s
[13:28:53.391] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:32:0)
[13:28:53.391] Timer tick, asking Buildbucket for the build status
[13:28:55.082] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:55.082] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:33:0) after 1m0s
[13:29:55.495] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:33:0)
[13:29:55.495] Timer tick, asking Buildbucket for the build status
[13:29:55.592] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:55.592] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:34:0) after 1m0s
[13:30:55.781] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:34:0)
[13:30:55.781] Timer tick, asking Buildbucket for the build status
[13:30:55.872] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:55.872] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:35:0) after 1m0s
[13:31:55.895] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:35:0)
[13:31:55.895] Timer tick, asking Buildbucket for the build status
[13:31:56.230] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:56.230] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:36:0) after 1m0s
[13:32:56.266] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:36:0)
[13:32:56.266] Timer tick, asking Buildbucket for the build status
[13:32:56.339] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:56.339] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:37:0) after 1m0s
[13:33:56.377] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:37:0)
[13:33:56.377] Timer tick, asking Buildbucket for the build status
[13:33:56.708] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:56.708] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:38:0) after 1m0s
[13:34:56.704] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:38:0)
[13:34:56.704] Timer tick, asking Buildbucket for the build status
[13:34:57.550] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:57.550] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:39:0) after 1m0s
[13:35:57.537] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:39:0)
[13:35:57.537] Timer tick, asking Buildbucket for the build status
[13:35:58.199] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:58.199] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:40:0) after 1m0s
[13:36:58.315] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:40:0)
[13:36:58.315] Timer tick, asking Buildbucket for the build status
[13:36:58.418] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:58.418] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:41:0) after 1m0s
[13:37:58.471] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:41:0)
[13:37:58.471] Timer tick, asking Buildbucket for the build status
[13:37:58.560] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:58.560] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:42:0) after 1m0s
[13:38:58.627] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:42:0)
[13:38:58.627] Timer tick, asking Buildbucket for the build status
[13:38:58.702] Build 8853234434659552848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:58.702] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - custom snapshot - debug:9018664496716925104:43:0) after 1m0s
[13:39:51.874] Received PubSub notification, asking Buildbucket for the build status
[13:39:51.956] Build 8853234434659552848: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:39:51.956] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci.br.beta",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1615297191589468",
"created_by": "project:v8",
"created_ts": "1615294724749361",
"id": "8853234434659552848",
"parameters_json": "{\"builder_name\": \"V8 Linux64 - custom snapshot - debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"oldest_gitiles_revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_embed_script = \\\"test/mjsunit/mjsunit.js\\\" v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Linux64 - custom snapshot - debug builder\", \"parent_got_revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"parent_got_revision_cp\": \"refs/branch-heads/9.0@{#15}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"mjsunit\", 1.0, null, \"\", [\"--no-harness\"], {}, {}]]}, \"revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"swarm_hashes\": {\"mjsunit\": \"63b356a9ad6ed83fb90224e8f7c011a7def26a71667c8059d7e2e882233199b6/318\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/92be48b817eb17f89b8e36d8124b8c9e96852519\", \"gitiles_ref:refs/branch-heads/9.0\", \"parent_buildername:V8 Linux64 - custom snapshot - debug builder\", \"parent_buildnumber:185\", \"user_agent:recipe\"]}, \"id\": \"b5c00b44-ccce-4bf3-9117-3075cb8ee97a\", \"title\": \"V8 Linux64 - custom snapshot - debug builder/185\"}]}, \"newest_gitiles_revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"oldest_gitiles_revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_embed_script = \\\"test/mjsunit/mjsunit.js\\\" v8_enable_backtrace = true v8_enable_slow_dchecks = true\"}, \"parent_buildername\": \"V8 Linux64 - custom snapshot - debug builder\", \"parent_got_revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"parent_got_revision_cp\": \"refs/branch-heads/9.0@{#15}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {}, \"tests\": [[\"mjsunit\", 1.0, null, \"\", [\"--no-harness\"], {}, {}]]}, \"revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"swarm_hashes\": {\"mjsunit\": \"63b356a9ad6ed83fb90224e8f7c011a7def26a71667c8059d7e2e882233199b6/318\"}}}",
"project": "v8",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"92be48b817eb17f89b8e36d8124b8c9e96852519\", \"got_revision_cp\": \"refs/branch-heads/9.0@{#15}\"}, \"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-28-qika\"], \"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\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615295675698019",
"status": "COMPLETED",
"status_changed_ts": "1615295676242716",
"tags": [
"build_address:luci.v8.ci.br.beta/V8 Linux64 - custom snapshot - debug/178",
"builder:V8 Linux64 - custom snapshot - debug",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/92be48b817eb17f89b8e36d8124b8c9e96852519",
"gitiles_ref:refs/branch-heads/9.0",
"parent_buildername:V8 Linux64 - custom snapshot - debug builder",
"parent_buildnumber:185",
"scheduler_invocation_id:9018664496716925104",
"scheduler_job_id:v8/ci.br.beta-V8 Linux64 - custom snapshot - debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8853234434659552848/+/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:522fe30cf87ede10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1615297191589902",
"url": "https://ci.chromium.org/b/8853234434659552848",
"utcnow_ts": "1615297191949336"
}
}
[13:39:51.956] Invocation finished in 41m8.55212489s with status SUCCEEDED