[04:02:54.534] New invocation is queued and will start shortly
[04:02:54.534] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[04:02:56.005] Starting the invocation (attempt 1)
[04:02:56.044] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:02:56.044] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:02:56.045] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9058470275518083984",
"parameters_json": "{\"builder_name\":\"V8 Linux64 - debug - perfetto\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"newest_gitiles_revision\":\"75a26837387a614c64d23e6b23c22180f1ef3c89\",\"oldest_gitiles_revision\":\"75a26837387a614c64d23e6b23c22180f1ef3c89\",\"parent_build_config\":\"Debug\",\"parent_build_environment\":{\"gn_args\":\"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true v8_use_perfetto = true\"},\"parent_buildername\":\"V8 Linux64 - debug - perfetto - builder\",\"parent_got_revision\":\"75a26837387a614c64d23e6b23c22180f1ef3c89\",\"parent_got_revision_cp\":\"refs/heads/master@{#65557}\",\"parent_got_swarming_client_revision\":\"885b3febcc170a60f25795304e60927b77d1e92d\",\"parent_test_spec\":{\"swarming_dimensions\":{\"os\":\"Ubuntu-16.04\"},\"swarming_task_attrs\":{\"expiration\":14400,\"hard_timeout\":3600,\"priority\":35},\"tests\":[[\"v8testing\",2,null,\"\",[],{},{}]]},\"revision\":\"75a26837387a614c64d23e6b23c22180f1ef3c89\",\"swarm_hashes\":{\"bot_default\":\"cd04ccff53f1d3bb1f8a44f4f15519c744f0d6ee\"}},\"tags\":[\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/75a26837387a614c64d23e6b23c22180f1ef3c89\",\"gitiles_ref:refs/heads/master\",\"parent_buildername:V8 Linux64 - debug - perfetto - builder\",\"parent_buildnumber:4376\",\"user_agent:recipe\"]},\"id\":\"bad310a3-8cf8-427e-837d-b02b4015f23e\",\"title\":\"V8 Linux64 - debug - perfetto - builder/4376\"}]},\"newest_gitiles_revision\":\"75a26837387a614c64d23e6b23c22180f1ef3c89\",\"oldest_gitiles_revision\":\"75a26837387a614c64d23e6b23c22180f1ef3c89\",\"parent_build_config\":\"Debug\",\"parent_build_environment\":{\"gn_args\":\"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true v8_use_perfetto = true\"},\"parent_buildername\":\"V8 Linux64 - debug - perfetto - builder\",\"parent_got_revision\":\"75a26837387a614c64d23e6b23c22180f1ef3c89\",\"parent_got_revision_cp\":\"refs/heads/master@{#65557}\",\"parent_got_swarming_client_revision\":\"885b3febcc170a60f25795304e60927b77d1e92d\",\"parent_test_spec\":{\"swarming_dimensions\":{\"os\":\"Ubuntu-16.04\"},\"swarming_task_attrs\":{\"expiration\":14400,\"hard_timeout\":3600,\"priority\":35},\"tests\":[[\"v8testing\",2,null,\"\",[],{},{}]]},\"revision\":\"75a26837387a614c64d23e6b23c22180f1ef3c89\",\"swarm_hashes\":{\"bot_default\":\"cd04ccff53f1d3bb1f8a44f4f15519c744f0d6ee\"}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Linux64 - debug - perfetto",
"scheduler_invocation_id:9058470275518083984",
"scheduler_job_id:v8/V8 Linux64 - debug - perfetto",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/75a26837387a614c64d23e6b23c22180f1ef3c89",
"gitiles_ref:refs/heads/master",
"parent_buildername:V8 Linux64 - debug - perfetto - builder",
"parent_buildnumber:4376",
"user_agent:recipe"
]
}
[04:02:57.538] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1577332976386463",
"id": "8893040212911840288",
"parameters_json": "{\"builder_name\": \"V8 Linux64 - debug - perfetto\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"oldest_gitiles_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"parent_build_config\": \"Debug\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true v8_use_perfetto = true\"}, \"parent_buildername\": \"V8 Linux64 - debug - perfetto - builder\", \"parent_got_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"parent_got_revision_cp\": \"refs/heads/master@{#65557}\", \"parent_got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {\"expiration\": 14400.0, \"hard_timeout\": 3600.0, \"priority\": 35.0}, \"tests\": [[\"v8testing\", 2.0, null, \"\", [], {}, {}]]}, \"revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"swarm_hashes\": {\"bot_default\": \"cd04ccff53f1d3bb1f8a44f4f15519c744f0d6ee\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/75a26837387a614c64d23e6b23c22180f1ef3c89\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux64 - debug - perfetto - builder\", \"parent_buildnumber:4376\", \"user_agent:recipe\"]}, \"id\": \"bad310a3-8cf8-427e-837d-b02b4015f23e\", \"title\": \"V8 Linux64 - debug - perfetto - builder/4376\"}]}, \"newest_gitiles_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"oldest_gitiles_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"parent_build_config\": \"Debug\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true v8_use_perfetto = true\"}, \"parent_buildername\": \"V8 Linux64 - debug - perfetto - builder\", \"parent_got_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"parent_got_revision_cp\": \"refs/heads/master@{#65557}\", \"parent_got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {\"expiration\": 14400.0, \"hard_timeout\": 3600.0, \"priority\": 35.0}, \"tests\": [[\"v8testing\", 2.0, null, \"\", [], {}, {}]]}, \"revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"swarm_hashes\": {\"bot_default\": \"cd04ccff53f1d3bb1f8a44f4f15519c744f0d6ee\"}}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1577332977355250",
"tags": [
"build_address:luci.v8.ci/V8 Linux64 - debug - perfetto/3291",
"builder:V8 Linux64 - debug - perfetto",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/75a26837387a614c64d23e6b23c22180f1ef3c89",
"gitiles_ref:refs/heads/master",
"parent_buildername:V8 Linux64 - debug - perfetto - builder",
"parent_buildnumber:4376",
"scheduler_invocation_id:9058470275518083984",
"scheduler_job_id:v8/V8 Linux64 - debug - perfetto",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8893040212911840288/+/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": "1577332977355356",
"url": "https://ci.chromium.org/b/8893040212911840288",
"utcnow_ts": "1577332977529802"
}
}
[04:02:57.538] Task URL: https://ci.chromium.org/b/8893040212911840288
[04:02:57.538] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:2:0) after 1m0s
[04:03:12.231] Received PubSub notification, asking Buildbucket for the build status
[04:03:12.396] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:57.807] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:2:0)
[04:03:57.807] Timer tick, asking Buildbucket for the build status
[04:03:58.094] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:58.094] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:4:0) after 1m0s
[04:04:58.124] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:4:0)
[04:04:58.124] Timer tick, asking Buildbucket for the build status
[04:04:59.009] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:59.009] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:5:0) after 1m0s
[04:05:59.045] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:5:0)
[04:05:59.045] Timer tick, asking Buildbucket for the build status
[04:05:59.316] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:59.316] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:6:0) after 1m0s
[04:06:59.395] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:6:0)
[04:06:59.395] Timer tick, asking Buildbucket for the build status
[04:06:59.602] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:59.602] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:7:0) after 1m0s
[04:07:59.764] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:7:0)
[04:07:59.764] Timer tick, asking Buildbucket for the build status
[04:07:59.943] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:59.943] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:8:0) after 1m0s
[04:09:00.039] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:8:0)
[04:09:00.039] Timer tick, asking Buildbucket for the build status
[04:09:00.462] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:00.462] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:9:0) after 1m0s
[04:10:01.890] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:9:0)
[04:10:01.890] Timer tick, asking Buildbucket for the build status
[04:10:02.062] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:02.062] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:10:0) after 1m0s
[04:11:02.101] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:10:0)
[04:11:02.102] Timer tick, asking Buildbucket for the build status
[04:11:02.294] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:02.294] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:11:0) after 1m0s
[04:12:02.366] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:11:0)
[04:12:02.366] Timer tick, asking Buildbucket for the build status
[04:12:02.505] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:02.505] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:12:0) after 1m0s
[04:13:02.523] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:12:0)
[04:13:02.523] Timer tick, asking Buildbucket for the build status
[04:13:02.823] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:02.823] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:13:0) after 1m0s
[04:14:02.869] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:13:0)
[04:14:02.869] Timer tick, asking Buildbucket for the build status
[04:14:03.489] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:03.489] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:14:0) after 1m0s
[04:15:03.554] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:14:0)
[04:15:03.555] Timer tick, asking Buildbucket for the build status
[04:15:03.759] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:03.759] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:15:0) after 1m0s
[04:16:03.891] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:15:0)
[04:16:03.891] Timer tick, asking Buildbucket for the build status
[04:16:04.172] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:04.172] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:16:0) after 1m0s
[04:17:04.240] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:16:0)
[04:17:04.240] Timer tick, asking Buildbucket for the build status
[04:17:04.950] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:04.950] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:17:0) after 1m0s
[04:18:04.978] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:17:0)
[04:18:04.978] Timer tick, asking Buildbucket for the build status
[04:18:05.272] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:05.272] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:18:0) after 1m0s
[04:19:05.290] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:18:0)
[04:19:05.290] Timer tick, asking Buildbucket for the build status
[04:19:05.437] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:05.437] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:19:0) after 1m0s
[04:20:05.511] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:19:0)
[04:20:05.511] Timer tick, asking Buildbucket for the build status
[04:20:05.715] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:05.715] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:20:0) after 1m0s
[04:21:05.747] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:20:0)
[04:21:05.747] Timer tick, asking Buildbucket for the build status
[04:21:05.979] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:05.979] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:21:0) after 1m0s
[04:22:06.006] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:21:0)
[04:22:06.006] Timer tick, asking Buildbucket for the build status
[04:22:06.189] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:06.189] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:22:0) after 1m0s
[04:23:06.264] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:22:0)
[04:23:06.264] Timer tick, asking Buildbucket for the build status
[04:23:06.397] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:06.397] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:23:0) after 1m0s
[04:24:06.476] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:23:0)
[04:24:06.476] Timer tick, asking Buildbucket for the build status
[04:24:07.496] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:07.496] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:24:0) after 1m0s
[04:25:07.546] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:24:0)
[04:25:07.546] Timer tick, asking Buildbucket for the build status
[04:25:08.072] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:08.072] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:25:0) after 1m0s
[04:26:08.146] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:25:0)
[04:26:08.146] Timer tick, asking Buildbucket for the build status
[04:26:08.459] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:08.459] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:26:0) after 1m0s
[04:27:08.481] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:26:0)
[04:27:08.481] Timer tick, asking Buildbucket for the build status
[04:27:08.648] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:08.648] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:27:0) after 1m0s
[04:28:08.672] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:27:0)
[04:28:08.672] Timer tick, asking Buildbucket for the build status
[04:28:09.055] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:09.055] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:28:0) after 1m0s
[04:29:09.075] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:28:0)
[04:29:09.075] Timer tick, asking Buildbucket for the build status
[04:29:09.322] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:09.322] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:29:0) after 1m0s
[04:30:09.344] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:29:0)
[04:30:09.344] Timer tick, asking Buildbucket for the build status
[04:30:09.490] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:09.490] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:30:0) after 1m0s
[04:31:09.530] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:30:0)
[04:31:09.530] Timer tick, asking Buildbucket for the build status
[04:31:09.870] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:09.870] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:31:0) after 1m0s
[04:32:09.890] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:31:0)
[04:32:09.890] Timer tick, asking Buildbucket for the build status
[04:32:10.021] Build 8893040212911840288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:10.021] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9058470275518083984:32:0) after 1m0s
[04:32:34.390] Received PubSub notification, asking Buildbucket for the build status
[04:32:34.516] Build 8893040212911840288: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:32:34.516] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"completed_ts": "1577334753330048",
"created_by": "project:v8",
"created_ts": "1577332976386463",
"id": "8893040212911840288",
"parameters_json": "{\"builder_name\": \"V8 Linux64 - debug - perfetto\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"oldest_gitiles_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"parent_build_config\": \"Debug\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true v8_use_perfetto = true\"}, \"parent_buildername\": \"V8 Linux64 - debug - perfetto - builder\", \"parent_got_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"parent_got_revision_cp\": \"refs/heads/master@{#65557}\", \"parent_got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {\"expiration\": 14400.0, \"hard_timeout\": 3600.0, \"priority\": 35.0}, \"tests\": [[\"v8testing\", 2.0, null, \"\", [], {}, {}]]}, \"revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"swarm_hashes\": {\"bot_default\": \"cd04ccff53f1d3bb1f8a44f4f15519c744f0d6ee\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/75a26837387a614c64d23e6b23c22180f1ef3c89\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux64 - debug - perfetto - builder\", \"parent_buildnumber:4376\", \"user_agent:recipe\"]}, \"id\": \"bad310a3-8cf8-427e-837d-b02b4015f23e\", \"title\": \"V8 Linux64 - debug - perfetto - builder/4376\"}]}, \"newest_gitiles_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"oldest_gitiles_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"parent_build_config\": \"Debug\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true v8_use_perfetto = true\"}, \"parent_buildername\": \"V8 Linux64 - debug - perfetto - builder\", \"parent_got_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"parent_got_revision_cp\": \"refs/heads/master@{#65557}\", \"parent_got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {\"expiration\": 14400.0, \"hard_timeout\": 3600.0, \"priority\": 35.0}, \"tests\": [[\"v8testing\", 2.0, null, \"\", [], {}, {}]]}, \"revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"swarm_hashes\": {\"bot_default\": \"cd04ccff53f1d3bb1f8a44f4f15519c744f0d6ee\"}}}",
"project": "v8",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"oldest_gitiles_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"parent_build_config\": \"Debug\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true v8_use_perfetto = true\"}, \"parent_buildername\": \"V8 Linux64 - debug - perfetto - builder\", \"parent_got_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"parent_got_revision_cp\": \"refs/heads/master@{#65557}\", \"parent_got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {\"expiration\": 14400.0, \"hard_timeout\": 3600.0, \"priority\": 35.0}, \"tests\": [[\"v8testing\", 2.0, null, \"\", [], {}, {}]]}, \"revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"swarm_hashes\": {\"bot_default\": \"cd04ccff53f1d3bb1f8a44f4f15519c744f0d6ee\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/75a26837387a614c64d23e6b23c22180f1ef3c89\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux64 - debug - perfetto - builder\", \"parent_buildnumber:4376\", \"user_agent:recipe\"]}, \"id\": \"bad310a3-8cf8-427e-837d-b02b4015f23e\", \"title\": \"V8 Linux64 - debug - perfetto - builder/4376\"}]}, \"bot_id\": \"luci-v8-ci-slim-11-qhoy\", \"buildername\": \"V8 Linux64 - debug - perfetto\", \"buildnumber\": 3291, \"got_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"got_revision_cp\": \"refs/heads/master@{#65557}\", \"mastername\": \"client.v8\", \"newest_gitiles_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"oldest_gitiles_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"parent_build_config\": \"Debug\", \"parent_build_environment\": {\"gn_args\": \"is_component_build = true is_debug = true target_cpu = \\\"x64\\\" use_goma = true v8_enable_backtrace = true v8_enable_slow_dchecks = true v8_use_perfetto = true\"}, \"parent_buildername\": \"V8 Linux64 - debug - perfetto - builder\", \"parent_got_revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"parent_got_revision_cp\": \"refs/heads/master@{#65557}\", \"parent_got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"parent_test_spec\": {\"swarming_dimensions\": {\"os\": \"Ubuntu-16.04\"}, \"swarming_task_attrs\": {\"expiration\": 14400.0, \"hard_timeout\": 3600.0, \"priority\": 35.0}, \"tests\": [[\"v8testing\", 2.0, null, \"\", [], {}, {}]]}, \"path_config\": \"generic\", \"recipe\": \"v8\", \"revision\": \"75a26837387a614c64d23e6b23c22180f1ef3c89\", \"swarm_hashes\": {\"bot_default\": \"cd04ccff53f1d3bb1f8a44f4f15519c744f0d6ee\"}}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"host_class\": [\"multibot\"], \"id\": [\"luci-v8-ci-slim-11-qhoy\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"g1-small\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.v8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4733-6bd8c41\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1577332990860064",
"status": "COMPLETED",
"status_changed_ts": "1577334753759692",
"tags": [
"build_address:luci.v8.ci/V8 Linux64 - debug - perfetto/3291",
"builder:V8 Linux64 - debug - perfetto",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/75a26837387a614c64d23e6b23c22180f1ef3c89",
"gitiles_ref:refs/heads/master",
"parent_buildername:V8 Linux64 - debug - perfetto - builder",
"parent_buildnumber:4376",
"scheduler_invocation_id:9058470275518083984",
"scheduler_job_id:v8/V8 Linux64 - debug - perfetto",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8893040212911840288/+/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:495930b89a098f10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1577334753944103",
"url": "https://ci.chromium.org/b/8893040212911840288",
"utcnow_ts": "1577334754504284"
}
}
[04:32:34.516] Invocation finished in 29m40.00018254s with status SUCCEEDED