Status: FAILED
Triggered by: v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
Duration: 2 hours
Actions:

Definition (rev 050cfc084599b5c68d83ec458c5e42ee5900cd6e)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.v8.ci"
  builder: "V8 Linux64 - debug - perfetto"
>

Incoming triggers

  • V8 Linux64 - debug - perfetto - builder/12105 (5 years ago by v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com)
  • V8 Linux64 - debug - perfetto - builder/12106 (5 years ago by v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com)
  • V8 Linux64 - debug - perfetto - builder/12107 (5 years ago by v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com)
  • V8 Linux64 - debug - perfetto - builder/12108 (5 years ago by v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com)

Incoming properties

{
  "newest_gitiles_revision": "f187d0a13f9d849a6c0b5f7052bab1d785a02c53",
  "oldest_gitiles_revision": "f187d0a13f9d849a6c0b5f7052bab1d785a02c53",
  "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": "f187d0a13f9d849a6c0b5f7052bab1d785a02c53",
  "parent_got_revision_cp": "refs/heads/master@{#73514}",
  "parent_got_swarming_client_revision": "a32a1607f6093d338f756c7e7c7b4333b0c50c9c",
  "parent_test_spec": {
    "swarming_dimensions": {
      "os": "Ubuntu-16.04"
    },
    "swarming_task_attrs": {
      "expiration": 14400,
      "hard_timeout": 3600,
      "priority": 35
    },
    "tests": [
      [
        "v8testing",
        2,
        null,
        "",
        [],
        {},
        {}
      ]
    ]
  },
  "revision": "f187d0a13f9d849a6c0b5f7052bab1d785a02c53",
  "swarm_hashes": {
    "bot_default": "3203b9777ce35debde986bb867d1ec1acdcd648922c1d525a997692a3de1f6e9/319"
  }
}

Incoming tags

  • buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/f187d0a13f9d849a6c0b5f7052bab1d785a02c53
  • gitiles_ref:refs/heads/master
  • parent_buildername:V8 Linux64 - debug - perfetto - builder
  • parent_buildnumber:12108
  • user_agent:recipe

Debug log (UTC)

[15:27:24.441] New invocation is queued and will start shortly
[15:27:24.441] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[15:27:25.492] Starting the invocation (attempt 1)
[15:27:25.538] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:27:25.538] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:27:25.539] Buildbucket request:
{
  "bucket": "luci.v8.ci",
  "client_operation_id": "9017839769655030784",
  "parameters_json": "{\"builder_name\":\"V8 Linux64 - debug - perfetto\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"newest_gitiles_revision\":\"c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\",\"oldest_gitiles_revision\":\"c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\",\"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\":\"c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\",\"parent_got_revision_cp\":\"refs/heads/master@{#73511}\",\"parent_got_swarming_client_revision\":\"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\",\"parent_test_spec\":{\"swarming_dimensions\":{\"os\":\"Ubuntu-16.04\"},\"swarming_task_attrs\":{\"expiration\":14400,\"hard_timeout\":3600,\"priority\":35},\"tests\":[[\"v8testing\",2,null,\"\",[],{},{}]]},\"revision\":\"c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\",\"swarm_hashes\":{\"bot_default\":\"20a48d8756772066c59d3ec7d42dbb1fda719b6e8c4e46ea9c753c8f468ae261/319\"}},\"tags\":[\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\",\"gitiles_ref:refs/heads/master\",\"parent_buildername:V8 Linux64 - debug - perfetto - builder\",\"parent_buildnumber:12105\",\"user_agent:recipe\"]},\"id\":\"5d01ea9e-525e-444e-9c3c-f60578bbd73e\",\"title\":\"V8 Linux64 - debug - perfetto - builder/12105\"},{\"buildbucket\":{\"properties\":{\"newest_gitiles_revision\":\"d95b1645a78cb1cd6fa638e3230df929324c136a\",\"oldest_gitiles_revision\":\"d95b1645a78cb1cd6fa638e3230df929324c136a\",\"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\":\"d95b1645a78cb1cd6fa638e3230df929324c136a\",\"parent_got_revision_cp\":\"refs/heads/master@{#73512}\",\"parent_got_swarming_client_revision\":\"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\",\"parent_test_spec\":{\"swarming_dimensions\":{\"os\":\"Ubuntu-16.04\"},\"swarming_task_attrs\":{\"expiration\":14400,\"hard_timeout\":3600,\"priority\":35},\"tests\":[[\"v8testing\",2,null,\"\",[],{},{}]]},\"revision\":\"d95b1645a78cb1cd6fa638e3230df929324c136a\",\"swarm_hashes\":{\"bot_default\":\"20a48d8756772066c59d3ec7d42dbb1fda719b6e8c4e46ea9c753c8f468ae261/319\"}},\"tags\":[\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/d95b1645a78cb1cd6fa638e3230df929324c136a\",\"gitiles_ref:refs/heads/master\",\"parent_buildername:V8 Linux64 - debug - perfetto - builder\",\"parent_buildnumber:12106\",\"user_agent:recipe\"]},\"id\":\"bda7b822-96da-465f-b8df-805135f49322\",\"title\":\"V8 Linux64 - debug - perfetto - builder/12106\"},{\"buildbucket\":{\"properties\":{\"newest_gitiles_revision\":\"dd8a12499e0032963f719fe862e83e69b687399f\",\"oldest_gitiles_revision\":\"dd8a12499e0032963f719fe862e83e69b687399f\",\"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\":\"dd8a12499e0032963f719fe862e83e69b687399f\",\"parent_got_revision_cp\":\"refs/heads/master@{#73513}\",\"parent_got_swarming_client_revision\":\"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\",\"parent_test_spec\":{\"swarming_dimensions\":{\"os\":\"Ubuntu-16.04\"},\"swarming_task_attrs\":{\"expiration\":14400,\"hard_timeout\":3600,\"priority\":35},\"tests\":[[\"v8testing\",2,null,\"\",[],{},{}]]},\"revision\":\"dd8a12499e0032963f719fe862e83e69b687399f\",\"swarm_hashes\":{\"bot_default\":\"3203b9777ce35debde986bb867d1ec1acdcd648922c1d525a997692a3de1f6e9/319\"}},\"tags\":[\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/dd8a12499e0032963f719fe862e83e69b687399f\",\"gitiles_ref:refs/heads/master\",\"parent_buildername:V8 Linux64 - debug - perfetto - builder\",\"parent_buildnumber:12107\",\"user_agent:recipe\"]},\"id\":\"7ee02e79-460c-477c-8fe1-74f4dc709bd0\",\"title\":\"V8 Linux64 - debug - perfetto - builder/12107\"},{\"buildbucket\":{\"properties\":{\"newest_gitiles_revision\":\"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\",\"oldest_gitiles_revision\":\"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\",\"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\":\"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\",\"parent_got_revision_cp\":\"refs/heads/master@{#73514}\",\"parent_got_swarming_client_revision\":\"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\",\"parent_test_spec\":{\"swarming_dimensions\":{\"os\":\"Ubuntu-16.04\"},\"swarming_task_attrs\":{\"expiration\":14400,\"hard_timeout\":3600,\"priority\":35},\"tests\":[[\"v8testing\",2,null,\"\",[],{},{}]]},\"revision\":\"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\",\"swarm_hashes\":{\"bot_default\":\"3203b9777ce35debde986bb867d1ec1acdcd648922c1d525a997692a3de1f6e9/319\"}},\"tags\":[\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/f187d0a13f9d849a6c0b5f7052bab1d785a02c53\",\"gitiles_ref:refs/heads/master\",\"parent_buildername:V8 Linux64 - debug - perfetto - builder\",\"parent_buildnumber:12108\",\"user_agent:recipe\"]},\"id\":\"c4e0ff2e-2240-4346-aa6c-124049973f4f\",\"title\":\"V8 Linux64 - debug - perfetto - builder/12108\"}]},\"newest_gitiles_revision\":\"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\",\"oldest_gitiles_revision\":\"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\",\"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\":\"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\",\"parent_got_revision_cp\":\"refs/heads/master@{#73514}\",\"parent_got_swarming_client_revision\":\"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\",\"parent_test_spec\":{\"swarming_dimensions\":{\"os\":\"Ubuntu-16.04\"},\"swarming_task_attrs\":{\"expiration\":14400,\"hard_timeout\":3600,\"priority\":35},\"tests\":[[\"v8testing\",2,null,\"\",[],{},{}]]},\"revision\":\"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\",\"swarm_hashes\":{\"bot_default\":\"3203b9777ce35debde986bb867d1ec1acdcd648922c1d525a997692a3de1f6e9/319\"}}}",
  "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:9017839769655030784",
    "scheduler_job_id:v8/V8 Linux64 - debug - perfetto",
    "user_agent:luci-scheduler",
    "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/f187d0a13f9d849a6c0b5f7052bab1d785a02c53",
    "gitiles_ref:refs/heads/master",
    "parent_buildername:V8 Linux64 - debug - perfetto - builder",
    "parent_buildnumber:12108",
    "user_agent:recipe"
  ]
}
[15:27:27.045] Buildbucket response:
{
  "build": {
    "bucket": "luci.v8.ci",
    "canary": true,
    "canary_preference": "CANARY",
    "created_by": "project:v8",
    "created_ts": "1616081245680642",
    "id": "8852409707687675760",
    "parameters_json": "{\"builder_name\": \"V8 Linux64 - debug - perfetto\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\", \"oldest_gitiles_revision\": \"c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\", \"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\": \"c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\", \"parent_got_revision_cp\": \"refs/heads/master@{#73511}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\", \"swarm_hashes\": {\"bot_default\": \"20a48d8756772066c59d3ec7d42dbb1fda719b6e8c4e46ea9c753c8f468ae261/319\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux64 - debug - perfetto - builder\", \"parent_buildnumber:12105\", \"user_agent:recipe\"]}, \"id\": \"5d01ea9e-525e-444e-9c3c-f60578bbd73e\", \"title\": \"V8 Linux64 - debug - perfetto - builder/12105\"}, {\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"d95b1645a78cb1cd6fa638e3230df929324c136a\", \"oldest_gitiles_revision\": \"d95b1645a78cb1cd6fa638e3230df929324c136a\", \"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\": \"d95b1645a78cb1cd6fa638e3230df929324c136a\", \"parent_got_revision_cp\": \"refs/heads/master@{#73512}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"d95b1645a78cb1cd6fa638e3230df929324c136a\", \"swarm_hashes\": {\"bot_default\": \"20a48d8756772066c59d3ec7d42dbb1fda719b6e8c4e46ea9c753c8f468ae261/319\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/d95b1645a78cb1cd6fa638e3230df929324c136a\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux64 - debug - perfetto - builder\", \"parent_buildnumber:12106\", \"user_agent:recipe\"]}, \"id\": \"bda7b822-96da-465f-b8df-805135f49322\", \"title\": \"V8 Linux64 - debug - perfetto - builder/12106\"}, {\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"dd8a12499e0032963f719fe862e83e69b687399f\", \"oldest_gitiles_revision\": \"dd8a12499e0032963f719fe862e83e69b687399f\", \"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\": \"dd8a12499e0032963f719fe862e83e69b687399f\", \"parent_got_revision_cp\": \"refs/heads/master@{#73513}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"dd8a12499e0032963f719fe862e83e69b687399f\", \"swarm_hashes\": {\"bot_default\": \"3203b9777ce35debde986bb867d1ec1acdcd648922c1d525a997692a3de1f6e9/319\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/dd8a12499e0032963f719fe862e83e69b687399f\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux64 - debug - perfetto - builder\", \"parent_buildnumber:12107\", \"user_agent:recipe\"]}, \"id\": \"7ee02e79-460c-477c-8fe1-74f4dc709bd0\", \"title\": \"V8 Linux64 - debug - perfetto - builder/12107\"}, {\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"oldest_gitiles_revision\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"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\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"parent_got_revision_cp\": \"refs/heads/master@{#73514}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"swarm_hashes\": {\"bot_default\": \"3203b9777ce35debde986bb867d1ec1acdcd648922c1d525a997692a3de1f6e9/319\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux64 - debug - perfetto - builder\", \"parent_buildnumber:12108\", \"user_agent:recipe\"]}, \"id\": \"c4e0ff2e-2240-4346-aa6c-124049973f4f\", \"title\": \"V8 Linux64 - debug - perfetto - builder/12108\"}]}, \"newest_gitiles_revision\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"oldest_gitiles_revision\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"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\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"parent_got_revision_cp\": \"refs/heads/master@{#73514}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"swarm_hashes\": {\"bot_default\": \"3203b9777ce35debde986bb867d1ec1acdcd648922c1d525a997692a3de1f6e9/319\"}}}",
    "project": "v8",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1616081246765094",
    "tags": [
      "build_address:luci.v8.ci/V8 Linux64 - debug - perfetto/8737",
      "builder:V8 Linux64 - debug - perfetto",
      "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/f187d0a13f9d849a6c0b5f7052bab1d785a02c53",
      "gitiles_ref:refs/heads/master",
      "parent_buildername:V8 Linux64 - debug - perfetto - builder",
      "parent_buildnumber:12108",
      "scheduler_invocation_id:9017839769655030784",
      "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/8852409707687675760/+/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": "1616081246765215",
    "url": "https://ci.chromium.org/b/8852409707687675760",
    "utcnow_ts": "1616081247036818"
  }
}
[15:27:27.045] Task URL: https://ci.chromium.org/b/8852409707687675760
[15:27:27.045] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:2:0) after 1m0s
[15:27:51.065] Received PubSub notification, asking Buildbucket for the build status
[15:27:51.353] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:27.133] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:2:0)
[15:28:27.133] Timer tick, asking Buildbucket for the build status
[15:28:27.460] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:27.460] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:4:0) after 1m0s
[15:29:27.497] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:4:0)
[15:29:27.497] Timer tick, asking Buildbucket for the build status
[15:29:27.646] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:27.646] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:5:0) after 1m0s
[15:30:27.908] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:5:0)
[15:30:27.908] Timer tick, asking Buildbucket for the build status
[15:30:28.026] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:28.026] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:6:0) after 1m0s
[15:31:28.064] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:6:0)
[15:31:28.064] Timer tick, asking Buildbucket for the build status
[15:31:28.501] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:28.501] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:7:0) after 1m0s
[15:32:28.532] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:7:0)
[15:32:28.532] Timer tick, asking Buildbucket for the build status
[15:32:28.637] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:28.637] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:8:0) after 1m0s
[15:33:28.665] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:8:0)
[15:33:28.665] Timer tick, asking Buildbucket for the build status
[15:33:28.798] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:28.798] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:9:0) after 1m0s
[15:34:28.827] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:9:0)
[15:34:28.827] Timer tick, asking Buildbucket for the build status
[15:34:28.932] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:28.932] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:10:0) after 1m0s
[15:35:28.962] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:10:0)
[15:35:28.962] Timer tick, asking Buildbucket for the build status
[15:35:29.649] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:29.649] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:11:0) after 1m0s
[15:36:29.728] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:11:0)
[15:36:29.728] Timer tick, asking Buildbucket for the build status
[15:36:31.010] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:31.010] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:12:0) after 1m0s
[15:37:31.023] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:12:0)
[15:37:31.023] Timer tick, asking Buildbucket for the build status
[15:37:31.735] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:31.735] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:13:0) after 1m0s
[15:38:31.735] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:13:0)
[15:38:31.735] Timer tick, asking Buildbucket for the build status
[15:38:31.852] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:31.852] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:14:0) after 1m0s
[15:39:31.846] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:14:0)
[15:39:31.846] Timer tick, asking Buildbucket for the build status
[15:39:31.982] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:31.982] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:15:0) after 1m0s
[15:40:31.961] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:15:0)
[15:40:31.961] Timer tick, asking Buildbucket for the build status
[15:40:32.864] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:32.864] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:16:0) after 1m0s
[15:41:32.884] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:16:0)
[15:41:32.884] Timer tick, asking Buildbucket for the build status
[15:41:33.455] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:33.455] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:17:0) after 1m0s
[15:42:33.474] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:17:0)
[15:42:33.474] Timer tick, asking Buildbucket for the build status
[15:42:34.237] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:34.237] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:18:0) after 1m0s
[15:43:34.254] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:18:0)
[15:43:34.254] Timer tick, asking Buildbucket for the build status
[15:43:34.804] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:34.805] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:19:0) after 1m0s
[15:44:34.902] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:19:0)
[15:44:34.902] Timer tick, asking Buildbucket for the build status
[15:44:35.081] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:35.081] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:20:0) after 1m0s
[15:45:35.116] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:20:0)
[15:45:35.116] Timer tick, asking Buildbucket for the build status
[15:45:35.428] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:35.428] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:21:0) after 1m0s
[15:46:35.426] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:21:0)
[15:46:35.426] Timer tick, asking Buildbucket for the build status
[15:46:36.015] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:36.015] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:22:0) after 1m0s
[15:47:36.039] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:22:0)
[15:47:36.039] Timer tick, asking Buildbucket for the build status
[15:47:36.198] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:36.198] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:23:0) after 1m0s
[15:48:36.216] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:23:0)
[15:48:36.217] Timer tick, asking Buildbucket for the build status
[15:48:36.523] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:36.523] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:24:0) after 1m0s
[15:49:36.551] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:24:0)
[15:49:36.551] Timer tick, asking Buildbucket for the build status
[15:49:37.102] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:37.102] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:25:0) after 1m0s
[15:50:37.188] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:25:0)
[15:50:37.188] Timer tick, asking Buildbucket for the build status
[15:50:37.439] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:37.439] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:26:0) after 1m0s
[15:51:37.438] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:26:0)
[15:51:37.438] Timer tick, asking Buildbucket for the build status
[15:51:37.578] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:37.578] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:27:0) after 1m0s
[15:52:37.623] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:27:0)
[15:52:37.624] Timer tick, asking Buildbucket for the build status
[15:52:37.967] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:37.967] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:28:0) after 1m0s
[15:53:38.068] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:28:0)
[15:53:38.068] Timer tick, asking Buildbucket for the build status
[15:53:38.848] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:38.848] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:29:0) after 1m0s
[15:54:38.925] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:29:0)
[15:54:38.925] Timer tick, asking Buildbucket for the build status
[15:54:39.408] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:39.408] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:30:0) after 1m0s
[15:55:39.443] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:30:0)
[15:55:39.443] Timer tick, asking Buildbucket for the build status
[15:55:39.872] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:39.872] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:31:0) after 1m0s
[15:56:40.049] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:31:0)
[15:56:40.049] Timer tick, asking Buildbucket for the build status
[15:56:40.432] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:40.432] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:32:0) after 1m0s
[15:57:40.750] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:32:0)
[15:57:40.750] Timer tick, asking Buildbucket for the build status
[15:57:40.863] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:40.863] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:33:0) after 1m0s
[15:58:41.417] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:33:0)
[15:58:41.417] Timer tick, asking Buildbucket for the build status
[15:58:41.867] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:41.867] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:34:0) after 1m0s
[15:59:42.033] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:34:0)
[15:59:42.035] Timer tick, asking Buildbucket for the build status
[15:59:42.601] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:42.601] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:35:0) after 1m0s
[16:00:42.859] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:35:0)
[16:00:42.859] Timer tick, asking Buildbucket for the build status
[16:00:43.032] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:43.032] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:36:0) after 1m0s
[16:01:43.137] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:36:0)
[16:01:43.137] Timer tick, asking Buildbucket for the build status
[16:01:43.265] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:43.265] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:37:0) after 1m0s
[16:02:43.464] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:37:0)
[16:02:43.464] Timer tick, asking Buildbucket for the build status
[16:02:44.220] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:44.220] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:38:0) after 1m0s
[16:03:44.234] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:38:0)
[16:03:44.234] Timer tick, asking Buildbucket for the build status
[16:03:44.396] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:44.396] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:39:0) after 1m0s
[16:04:44.410] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:39:0)
[16:04:44.410] Timer tick, asking Buildbucket for the build status
[16:04:45.234] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:45.234] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:40:0) after 1m0s
[16:05:45.300] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:40:0)
[16:05:45.300] Timer tick, asking Buildbucket for the build status
[16:05:45.407] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:45.407] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:41:0) after 1m0s
[16:06:45.385] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:41:0)
[16:06:45.385] Timer tick, asking Buildbucket for the build status
[16:06:46.457] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:46.457] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:42:0) after 1m0s
[16:07:46.515] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:42:0)
[16:07:46.515] Timer tick, asking Buildbucket for the build status
[16:07:47.009] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:47.009] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:43:0) after 1m0s
[16:08:47.051] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:43:0)
[16:08:47.051] Timer tick, asking Buildbucket for the build status
[16:08:47.425] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:47.425] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:44:0) after 1m0s
[16:09:47.446] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:44:0)
[16:09:47.446] Timer tick, asking Buildbucket for the build status
[16:09:47.558] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:47.558] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:45:0) after 1m0s
[16:10:47.585] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:45:0)
[16:10:47.585] Timer tick, asking Buildbucket for the build status
[16:10:47.696] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:47.696] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:46:0) after 1m0s
[16:11:47.696] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:46:0)
[16:11:47.696] Timer tick, asking Buildbucket for the build status
[16:11:47.804] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:47.804] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:47:0) after 1m0s
[16:12:47.942] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:47:0)
[16:12:47.942] Timer tick, asking Buildbucket for the build status
[16:12:48.053] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:48.053] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:48:0) after 1m0s
[16:13:48.201] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:48:0)
[16:13:48.201] Timer tick, asking Buildbucket for the build status
[16:13:48.327] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:48.327] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:49:0) after 1m0s
[16:14:48.339] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:49:0)
[16:14:48.339] Timer tick, asking Buildbucket for the build status
[16:14:48.453] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:48.453] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:50:0) after 1m0s
[16:15:48.578] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:50:0)
[16:15:48.578] Timer tick, asking Buildbucket for the build status
[16:15:48.694] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:48.694] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:51:0) after 1m0s
[16:16:48.760] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:51:0)
[16:16:48.760] Timer tick, asking Buildbucket for the build status
[16:16:48.914] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:48.914] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:52:0) after 1m0s
[16:17:49.005] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:52:0)
[16:17:49.005] Timer tick, asking Buildbucket for the build status
[16:17:49.143] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:49.143] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:53:0) after 1m0s
[16:18:49.160] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:53:0)
[16:18:49.160] Timer tick, asking Buildbucket for the build status
[16:18:51.527] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:51.527] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:54:0) after 1m0s
[16:19:52.533] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:54:0)
[16:19:52.533] Timer tick, asking Buildbucket for the build status
[16:19:53.089] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:53.089] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:55:0) after 1m0s
[16:20:53.236] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:55:0)
[16:20:53.236] Timer tick, asking Buildbucket for the build status
[16:20:53.337] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:53.337] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:56:0) after 1m0s
[16:21:53.403] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:56:0)
[16:21:53.403] Timer tick, asking Buildbucket for the build status
[16:21:53.622] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:53.622] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:57:0) after 1m0s
[16:22:53.668] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:57:0)
[16:22:53.668] Timer tick, asking Buildbucket for the build status
[16:22:53.800] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:53.800] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:58:0) after 1m0s
[16:23:53.819] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:58:0)
[16:23:53.819] Timer tick, asking Buildbucket for the build status
[16:23:54.029] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:54.029] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:59:0) after 1m0s
[16:24:54.069] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:59:0)
[16:24:54.069] Timer tick, asking Buildbucket for the build status
[16:24:54.617] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:54.617] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:60:0) after 1m0s
[16:25:54.661] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:60:0)
[16:25:54.661] Timer tick, asking Buildbucket for the build status
[16:25:55.125] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:55.125] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:61:0) after 1m0s
[16:26:55.142] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:61:0)
[16:26:55.142] Timer tick, asking Buildbucket for the build status
[16:26:55.429] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:55.429] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:62:0) after 1m0s
[16:27:55.463] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:62:0)
[16:27:55.463] Timer tick, asking Buildbucket for the build status
[16:27:56.074] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:56.074] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:63:0) after 1m0s
[16:28:56.103] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:63:0)
[16:28:56.103] Timer tick, asking Buildbucket for the build status
[16:28:56.221] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:56.221] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:64:0) after 1m0s
[16:29:56.251] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:64:0)
[16:29:56.251] Timer tick, asking Buildbucket for the build status
[16:29:56.409] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:56.409] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:65:0) after 1m0s
[16:30:56.536] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:65:0)
[16:30:56.536] Timer tick, asking Buildbucket for the build status
[16:30:56.673] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:56.673] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:66:0) after 1m0s
[16:31:56.723] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:66:0)
[16:31:56.723] Timer tick, asking Buildbucket for the build status
[16:31:58.053] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:58.053] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:67:0) after 1m0s
[16:32:58.138] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:67:0)
[16:32:58.138] Timer tick, asking Buildbucket for the build status
[16:32:58.896] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:58.896] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:68:0) after 1m0s
[16:33:58.934] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:68:0)
[16:33:58.934] Timer tick, asking Buildbucket for the build status
[16:33:59.038] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:59.038] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:69:0) after 1m0s
[16:34:59.041] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:69:0)
[16:34:59.041] Timer tick, asking Buildbucket for the build status
[16:34:59.500] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:59.500] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:70:0) after 1m0s
[16:35:59.528] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:70:0)
[16:35:59.528] Timer tick, asking Buildbucket for the build status
[16:35:59.635] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:59.635] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:71:0) after 1m0s
[16:36:59.719] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:71:0)
[16:36:59.719] Timer tick, asking Buildbucket for the build status
[16:36:59.841] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:59.841] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:72:0) after 1m0s
[16:37:59.875] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:72:0)
[16:37:59.875] Timer tick, asking Buildbucket for the build status
[16:38:00.097] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:00.097] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:73:0) after 1m0s
[16:39:00.121] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:73:0)
[16:39:00.121] Timer tick, asking Buildbucket for the build status
[16:39:00.857] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:00.857] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:74:0) after 1m0s
[16:40:00.913] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:74:0)
[16:40:00.913] Timer tick, asking Buildbucket for the build status
[16:40:01.049] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:01.049] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:75:0) after 1m0s
[16:41:01.108] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:75:0)
[16:41:01.108] Timer tick, asking Buildbucket for the build status
[16:41:01.224] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:01.224] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:76:0) after 1m0s
[16:42:01.267] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:76:0)
[16:42:01.267] Timer tick, asking Buildbucket for the build status
[16:42:01.646] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:01.646] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:77:0) after 1m0s
[16:43:01.697] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:77:0)
[16:43:01.697] Timer tick, asking Buildbucket for the build status
[16:43:01.852] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:01.852] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:78:0) after 1m0s
[16:44:01.847] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:78:0)
[16:44:01.847] Timer tick, asking Buildbucket for the build status
[16:44:03.061] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:03.061] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:79:0) after 1m0s
[16:45:03.083] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:79:0)
[16:45:03.083] Timer tick, asking Buildbucket for the build status
[16:45:03.225] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:03.225] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:80:0) after 1m0s
[16:46:03.269] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:80:0)
[16:46:03.269] Timer tick, asking Buildbucket for the build status
[16:46:03.841] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:03.841] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:81:0) after 1m0s
[16:47:04.091] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:81:0)
[16:47:04.091] Timer tick, asking Buildbucket for the build status
[16:47:04.221] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:04.221] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:82:0) after 1m0s
[16:48:04.346] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:82:0)
[16:48:04.346] Timer tick, asking Buildbucket for the build status
[16:48:04.554] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:04.554] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:83:0) after 1m0s
[16:49:04.875] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:83:0)
[16:49:04.875] Timer tick, asking Buildbucket for the build status
[16:49:05.211] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:05.211] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:84:0) after 1m0s
[16:50:05.367] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:84:0)
[16:50:05.367] Timer tick, asking Buildbucket for the build status
[16:50:05.537] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:05.537] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:85:0) after 1m0s
[16:51:05.759] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:85:0)
[16:51:05.759] Timer tick, asking Buildbucket for the build status
[16:51:05.865] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:05.865] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:86:0) after 1m0s
[16:52:06.085] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:86:0)
[16:52:06.085] Timer tick, asking Buildbucket for the build status
[16:52:06.755] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:06.755] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:87:0) after 1m0s
[16:53:06.757] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:87:0)
[16:53:06.757] Timer tick, asking Buildbucket for the build status
[16:53:06.889] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:06.889] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:88:0) after 1m0s
[16:54:06.966] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:88:0)
[16:54:06.966] Timer tick, asking Buildbucket for the build status
[16:54:07.520] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:07.520] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:89:0) after 1m0s
[16:55:07.549] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:89:0)
[16:55:07.549] Timer tick, asking Buildbucket for the build status
[16:55:07.676] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:07.676] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:90:0) after 1m0s
[16:56:07.705] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:90:0)
[16:56:07.705] Timer tick, asking Buildbucket for the build status
[16:56:08.204] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:08.204] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:91:0) after 1m0s
[16:57:08.234] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:91:0)
[16:57:08.234] Timer tick, asking Buildbucket for the build status
[16:57:08.468] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:08.468] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:92:0) after 1m0s
[16:58:08.529] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:92:0)
[16:58:08.529] Timer tick, asking Buildbucket for the build status
[16:58:08.656] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:08.656] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:93:0) after 1m0s
[16:59:08.634] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:93:0)
[16:59:08.634] Timer tick, asking Buildbucket for the build status
[16:59:08.998] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:08.998] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:94:0) after 1m0s
[17:00:09.082] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:94:0)
[17:00:09.082] Timer tick, asking Buildbucket for the build status
[17:00:09.211] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:09.211] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:95:0) after 1m0s
[17:01:09.247] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:95:0)
[17:01:09.247] Timer tick, asking Buildbucket for the build status
[17:01:09.379] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:09.379] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:96:0) after 1m0s
[17:02:09.423] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:96:0)
[17:02:09.424] Timer tick, asking Buildbucket for the build status
[17:02:09.537] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:09.537] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:97:0) after 1m0s
[17:03:09.595] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:97:0)
[17:03:09.595] Timer tick, asking Buildbucket for the build status
[17:03:10.750] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:10.750] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:98:0) after 1m0s
[17:04:10.816] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:98:0)
[17:04:10.816] Timer tick, asking Buildbucket for the build status
[17:04:11.166] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:11.166] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:99:0) after 1m0s
[17:05:11.197] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:99:0)
[17:05:11.197] Timer tick, asking Buildbucket for the build status
[17:05:11.913] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:11.913] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:100:0) after 1m0s
[17:06:11.942] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:100:0)
[17:06:11.942] Timer tick, asking Buildbucket for the build status
[17:06:12.813] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:12.813] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:101:0) after 1m0s
[17:07:12.920] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:101:0)
[17:07:12.920] Timer tick, asking Buildbucket for the build status
[17:07:13.044] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:13.044] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:102:0) after 1m0s
[17:08:13.192] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:102:0)
[17:08:13.192] Timer tick, asking Buildbucket for the build status
[17:08:13.747] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:13.747] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:103:0) after 1m0s
[17:09:13.910] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:103:0)
[17:09:13.910] Timer tick, asking Buildbucket for the build status
[17:09:14.940] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:14.940] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:104:0) after 1m0s
[17:10:15.062] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:104:0)
[17:10:15.062] Timer tick, asking Buildbucket for the build status
[17:10:15.171] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:15.171] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:105:0) after 1m0s
[17:11:15.241] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:105:0)
[17:11:15.241] Timer tick, asking Buildbucket for the build status
[17:11:15.349] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:15.349] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:106:0) after 1m0s
[17:12:15.372] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:106:0)
[17:12:15.372] Timer tick, asking Buildbucket for the build status
[17:12:15.524] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:15.524] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:107:0) after 1m0s
[17:13:15.667] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:107:0)
[17:13:15.667] Timer tick, asking Buildbucket for the build status
[17:13:16.455] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:16.455] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:108:0) after 1m0s
[17:14:16.560] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:108:0)
[17:14:16.560] Timer tick, asking Buildbucket for the build status
[17:14:16.813] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:16.813] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:109:0) after 1m0s
[17:15:17.049] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:109:0)
[17:15:17.049] Timer tick, asking Buildbucket for the build status
[17:15:17.246] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:17.246] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:110:0) after 1m0s
[17:16:17.342] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:110:0)
[17:16:17.342] Timer tick, asking Buildbucket for the build status
[17:16:17.541] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:17.541] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:111:0) after 1m0s
[17:17:17.610] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:111:0)
[17:17:17.610] Timer tick, asking Buildbucket for the build status
[17:17:17.738] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:17.738] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:112:0) after 1m0s
[17:18:17.761] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:112:0)
[17:18:17.761] Timer tick, asking Buildbucket for the build status
[17:18:18.200] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:18.200] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:113:0) after 1m0s
[17:19:18.302] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:113:0)
[17:19:18.302] Timer tick, asking Buildbucket for the build status
[17:19:19.025] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:19.026] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:114:0) after 1m0s
[17:20:19.108] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:114:0)
[17:20:19.108] Timer tick, asking Buildbucket for the build status
[17:20:19.940] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:19.940] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:115:0) after 1m0s
[17:21:20.035] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:115:0)
[17:21:20.035] Timer tick, asking Buildbucket for the build status
[17:21:21.258] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:21.258] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:116:0) after 1m0s
[17:22:21.350] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:116:0)
[17:22:21.350] Timer tick, asking Buildbucket for the build status
[17:22:21.448] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:21.448] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:117:0) after 1m0s
[17:23:21.530] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:117:0)
[17:23:21.530] Timer tick, asking Buildbucket for the build status
[17:23:21.884] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:21.884] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:118:0) after 1m0s
[17:24:21.984] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:118:0)
[17:24:21.984] Timer tick, asking Buildbucket for the build status
[17:24:22.827] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:22.827] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:119:0) after 1m0s
[17:25:22.938] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:119:0)
[17:25:22.938] Timer tick, asking Buildbucket for the build status
[17:25:23.086] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:23.086] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:120:0) after 1m0s
[17:26:23.144] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:120:0)
[17:26:23.144] Timer tick, asking Buildbucket for the build status
[17:26:23.636] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:23.636] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:121:0) after 1m0s
[17:27:23.680] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:121:0)
[17:27:23.680] Timer tick, asking Buildbucket for the build status
[17:27:23.792] Build 8852409707687675760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:23.792] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - debug - perfetto:9017839769655030784:122:0) after 1m0s
[17:28:14.686] Received PubSub notification, asking Buildbucket for the build status
[17:28:14.789] Build 8852409707687675760: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "TIMEOUT"
[17:28:14.789] Buildbucket build:
{
  "build": {
    "bucket": "luci.v8.ci",
    "canary": true,
    "canary_preference": "CANARY",
    "cancelation_reason": "TIMEOUT",
    "completed_ts": "1616088494139472",
    "created_by": "project:v8",
    "created_ts": "1616081245680642",
    "id": "8852409707687675760",
    "parameters_json": "{\"builder_name\": \"V8 Linux64 - debug - perfetto\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\", \"oldest_gitiles_revision\": \"c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\", \"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\": \"c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\", \"parent_got_revision_cp\": \"refs/heads/master@{#73511}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\", \"swarm_hashes\": {\"bot_default\": \"20a48d8756772066c59d3ec7d42dbb1fda719b6e8c4e46ea9c753c8f468ae261/319\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/c4b44d5d480b42e4c9a0330f7d7d74055a7c214a\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux64 - debug - perfetto - builder\", \"parent_buildnumber:12105\", \"user_agent:recipe\"]}, \"id\": \"5d01ea9e-525e-444e-9c3c-f60578bbd73e\", \"title\": \"V8 Linux64 - debug - perfetto - builder/12105\"}, {\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"d95b1645a78cb1cd6fa638e3230df929324c136a\", \"oldest_gitiles_revision\": \"d95b1645a78cb1cd6fa638e3230df929324c136a\", \"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\": \"d95b1645a78cb1cd6fa638e3230df929324c136a\", \"parent_got_revision_cp\": \"refs/heads/master@{#73512}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"d95b1645a78cb1cd6fa638e3230df929324c136a\", \"swarm_hashes\": {\"bot_default\": \"20a48d8756772066c59d3ec7d42dbb1fda719b6e8c4e46ea9c753c8f468ae261/319\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/d95b1645a78cb1cd6fa638e3230df929324c136a\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux64 - debug - perfetto - builder\", \"parent_buildnumber:12106\", \"user_agent:recipe\"]}, \"id\": \"bda7b822-96da-465f-b8df-805135f49322\", \"title\": \"V8 Linux64 - debug - perfetto - builder/12106\"}, {\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"dd8a12499e0032963f719fe862e83e69b687399f\", \"oldest_gitiles_revision\": \"dd8a12499e0032963f719fe862e83e69b687399f\", \"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\": \"dd8a12499e0032963f719fe862e83e69b687399f\", \"parent_got_revision_cp\": \"refs/heads/master@{#73513}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"dd8a12499e0032963f719fe862e83e69b687399f\", \"swarm_hashes\": {\"bot_default\": \"3203b9777ce35debde986bb867d1ec1acdcd648922c1d525a997692a3de1f6e9/319\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/dd8a12499e0032963f719fe862e83e69b687399f\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux64 - debug - perfetto - builder\", \"parent_buildnumber:12107\", \"user_agent:recipe\"]}, \"id\": \"7ee02e79-460c-477c-8fe1-74f4dc709bd0\", \"title\": \"V8 Linux64 - debug - perfetto - builder/12107\"}, {\"buildbucket\": {\"properties\": {\"newest_gitiles_revision\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"oldest_gitiles_revision\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"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\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"parent_got_revision_cp\": \"refs/heads/master@{#73514}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"swarm_hashes\": {\"bot_default\": \"3203b9777ce35debde986bb867d1ec1acdcd648922c1d525a997692a3de1f6e9/319\"}}, \"tags\": [\"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"gitiles_ref:refs/heads/master\", \"parent_buildername:V8 Linux64 - debug - perfetto - builder\", \"parent_buildnumber:12108\", \"user_agent:recipe\"]}, \"id\": \"c4e0ff2e-2240-4346-aa6c-124049973f4f\", \"title\": \"V8 Linux64 - debug - perfetto - builder/12108\"}]}, \"newest_gitiles_revision\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"oldest_gitiles_revision\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"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\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"parent_got_revision_cp\": \"refs/heads/master@{#73514}\", \"parent_got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"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\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"swarm_hashes\": {\"bot_default\": \"3203b9777ce35debde986bb867d1ec1acdcd648922c1d525a997692a3de1f6e9/319\"}}}",
    "project": "v8",
    "result": "CANCELED",
    "result_details_json": "{\"error\": {\"message\": \"Uncaught Exception: AssertionError()\"}, \"properties\": {\"got_revision\": \"f187d0a13f9d849a6c0b5f7052bab1d785a02c53\", \"got_revision_cp\": \"refs/heads/master@{#73514}\"}, \"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-30-6hcu\"], \"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\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"Uncaught Exception: AssertionError()\"}}",
    "service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1616081267452352",
    "status": "COMPLETED",
    "status_changed_ts": "1616081268024695",
    "tags": [
      "build_address:luci.v8.ci/V8 Linux64 - debug - perfetto/8737",
      "builder:V8 Linux64 - debug - perfetto",
      "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/f187d0a13f9d849a6c0b5f7052bab1d785a02c53",
      "gitiles_ref:refs/heads/master",
      "parent_buildername:V8 Linux64 - debug - perfetto - builder",
      "parent_buildnumber:12108",
      "scheduler_invocation_id:9017839769655030784",
      "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/8852409707687675760/+/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:525ec473d6488810",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1616088494140506",
    "url": "https://ci.chromium.org/b/8852409707687675760",
    "utcnow_ts": "1616088494781922"
  }
}
[17:28:14.789] Invocation finished in 2h0m50.36868317s with status FAILED