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

Definition (rev 105a3b9974bcdff66f3d4203be2b773c499dd8d5)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.v8.ci.br.extended"
  builder: "V8 Win32 - debug"
>

Incoming triggers

  • V8 Win32 - debug builder/20 (3 years ago by v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com)

Incoming properties

{
  "newest_gitiles_revision": "014e1f857c335ce403447b4aca84f21243ad091b",
  "oldest_gitiles_revision": "014e1f857c335ce403447b4aca84f21243ad091b",
  "parent_build": "https://cr-buildbucket.appspot.com/build/8832406379190165457",
  "parent_build_environment": {
    "gn_args": "is_component_build = true is_debug = true symbol_level = 1 target_cpu = \"x86\" use_goma = true v8_enable_backtrace = true v8_enable_google_benchmark = true v8_enable_slow_dchecks = true"
  },
  "parent_buildername": "V8 Win32 - debug builder",
  "parent_gn_args": [
    "is_component_build = true",
    "is_debug = true",
    "symbol_level = 1",
    "target_cpu = \"x86\"",
    "use_goma = true",
    "v8_enable_backtrace = true",
    "v8_enable_google_benchmark = true",
    "v8_enable_slow_dchecks = true"
  ],
  "parent_got_revision": "014e1f857c335ce403447b4aca84f21243ad091b",
  "parent_got_revision_cp": "refs/branch-heads/9.4@{#48}",
  "parent_test_spec": {
    "swarming_dimensions": {
      "cpu": "x86-64",
      "os": "Windows-7-SP1"
    },
    "swarming_task_attrs": {},
    "tests": [
      [
        "mozilla",
        1,
        null,
        "",
        [],
        {},
        {}
      ],
      [
        "test262",
        1,
        "default",
        "default",
        [],
        {},
        {}
      ],
      [
        "v8testing",
        5,
        null,
        "",
        [],
        {},
        {}
      ]
    ]
  },
  "revision": "014e1f857c335ce403447b4aca84f21243ad091b",
  "swarm_hashes": {
    "bot_default": "38d7ae00cbd98850b1dd60cdec21f9a5841de8c41f8b2e8daf9b1a07afe28219/319",
    "mozilla": "5f324931aa3827a5ea5f5f53f4062802a45f5de12b750142871cad5c5e480c84/318",
    "test262": "2c38e65ea64089fb52870ed3cb80ae6c7716f6668bf2bdeca351201a55887f4c/318"
  }
}

Incoming tags

  • buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/014e1f857c335ce403447b4aca84f21243ad091b
  • gitiles_ref:refs/branch-heads/9.4
  • parent_buildername:V8 Win32 - debug builder
  • parent_buildnumber:20
  • user_agent:recipe

Debug log (UTC)

[10:41:42.355] New invocation is queued and will start shortly
[10:41:42.355] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[10:41:43.387] Starting the invocation (attempt 1)
[10:41:43.420] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/014e1f857c335ce403447b4aca84f21243ad091b"
[10:41:43.420] Reconstructed gitiles commit from tags
[10:41:43.420] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:41:43.420] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:41:43.421] Buildbucket request:
{
  "requestId": "8997835814856249616",
  "builder": {
    "project": "v8",
    "bucket": "ci.br.extended",
    "builder": "V8 Win32 - debug"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "triggers": [
                  {
                        "buildbucket": {
                              "properties": {
                                    "newest_gitiles_revision": "014e1f857c335ce403447b4aca84f21243ad091b",
                                    "oldest_gitiles_revision": "014e1f857c335ce403447b4aca84f21243ad091b",
                                    "parent_build": "https://cr-buildbucket.appspot.com/build/8832406379190165457",
                                    "parent_build_environment": {
                                          "gn_args": "is_component_build = true is_debug = true symbol_level = 1 target_cpu = \"x86\" use_goma = true v8_enable_backtrace = true v8_enable_google_benchmark = true v8_enable_slow_dchecks = true"
                                        },
                                    "parent_buildername": "V8 Win32 - debug builder",
                                    "parent_gn_args": [
                                          "is_component_build = true",
                                          "is_debug = true",
                                          "symbol_level = 1",
                                          "target_cpu = \"x86\"",
                                          "use_goma = true",
                                          "v8_enable_backtrace = true",
                                          "v8_enable_google_benchmark = true",
                                          "v8_enable_slow_dchecks = true"
                                        ],
                                    "parent_got_revision": "014e1f857c335ce403447b4aca84f21243ad091b",
                                    "parent_got_revision_cp": "refs/branch-heads/9.4@{#48}",
                                    "parent_test_spec": {
                                          "swarming_dimensions": {
                                                "cpu": "x86-64",
                                                "os": "Windows-7-SP1"
                                              },
                                          "swarming_task_attrs": {
                                              },
                                          "tests": [
                                                [
                                                      "mozilla",
                                                      1,
                                                      null,
                                                      "",
                                                      [
                                                          ],
                                                      {
                                                          },
                                                      {
                                                          }
                                                    ],
                                                [
                                                      "test262",
                                                      1,
                                                      "default",
                                                      "default",
                                                      [
                                                          ],
                                                      {
                                                          },
                                                      {
                                                          }
                                                    ],
                                                [
                                                      "v8testing",
                                                      5,
                                                      null,
                                                      "",
                                                      [
                                                          ],
                                                      {
                                                          },
                                                      {
                                                          }
                                                    ]
                                              ]
                                        },
                                    "revision": "014e1f857c335ce403447b4aca84f21243ad091b",
                                    "swarm_hashes": {
                                          "bot_default": "38d7ae00cbd98850b1dd60cdec21f9a5841de8c41f8b2e8daf9b1a07afe28219/319",
                                          "mozilla": "5f324931aa3827a5ea5f5f53f4062802a45f5de12b750142871cad5c5e480c84/318",
                                          "test262": "2c38e65ea64089fb52870ed3cb80ae6c7716f6668bf2bdeca351201a55887f4c/318"
                                        }
                                  },
                              "tags": [
                                    "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/014e1f857c335ce403447b4aca84f21243ad091b",
                                    "gitiles_ref:refs/branch-heads/9.4",
                                    "parent_buildername:V8 Win32 - debug builder",
                                    "parent_buildnumber:20",
                                    "user_agent:recipe"
                                  ]
                            },
                        "id": "20ae7046-8f8e-4c51-bf70-80c505ec321a",
                        "title": "V8 Win32 - debug builder/20"
                      }
                ]
          },
      "newest_gitiles_revision": "014e1f857c335ce403447b4aca84f21243ad091b",
      "oldest_gitiles_revision": "014e1f857c335ce403447b4aca84f21243ad091b",
      "parent_build": "https://cr-buildbucket.appspot.com/build/8832406379190165457",
      "parent_build_environment": {
            "gn_args": "is_component_build = true is_debug = true symbol_level = 1 target_cpu = \"x86\" use_goma = true v8_enable_backtrace = true v8_enable_google_benchmark = true v8_enable_slow_dchecks = true"
          },
      "parent_buildername": "V8 Win32 - debug builder",
      "parent_gn_args": [
            "is_component_build = true",
            "is_debug = true",
            "symbol_level = 1",
            "target_cpu = \"x86\"",
            "use_goma = true",
            "v8_enable_backtrace = true",
            "v8_enable_google_benchmark = true",
            "v8_enable_slow_dchecks = true"
          ],
      "parent_got_revision": "014e1f857c335ce403447b4aca84f21243ad091b",
      "parent_got_revision_cp": "refs/branch-heads/9.4@{#48}",
      "parent_test_spec": {
            "swarming_dimensions": {
                  "cpu": "x86-64",
                  "os": "Windows-7-SP1"
                },
            "swarming_task_attrs": {
                },
            "tests": [
                  [
                        "mozilla",
                        1,
                        null,
                        "",
                        [
                            ],
                        {
                            },
                        {
                            }
                      ],
                  [
                        "test262",
                        1,
                        "default",
                        "default",
                        [
                            ],
                        {
                            },
                        {
                            }
                      ],
                  [
                        "v8testing",
                        5,
                        null,
                        "",
                        [
                            ],
                        {
                            },
                        {
                            }
                      ]
                ]
          },
      "swarm_hashes": {
            "bot_default": "38d7ae00cbd98850b1dd60cdec21f9a5841de8c41f8b2e8daf9b1a07afe28219/319",
            "mozilla": "5f324931aa3827a5ea5f5f53f4062802a45f5de12b750142871cad5c5e480c84/318",
            "test262": "2c38e65ea64089fb52870ed3cb80ae6c7716f6668bf2bdeca351201a55887f4c/318"
          }
    },
  "gitilesCommit": {
    "host": "chromium.googlesource.com",
    "project": "v8/v8",
    "id": "014e1f857c335ce403447b4aca84f21243ad091b",
    "ref": "refs/branch-heads/9.4"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8997835814856249616"
    },
    {
      "key": "scheduler_job_id",
      "value": "v8/ci.br.extended-V8 Win32 - debug"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    },
    {
      "key": "parent_buildername",
      "value": "V8 Win32 - debug builder"
    },
    {
      "key": "parent_buildnumber",
      "value": "20"
    },
    {
      "key": "user_agent",
      "value": "recipe"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[10:41:43.936] Scheduled build:
{
  "id": "8832405753008208705",
  "builder": {
    "project": "v8",
    "bucket": "ci.br.extended",
    "builder": "V8 Win32 - debug"
  },
  "number": 18,
  "createdBy": "project:v8",
  "createTime": "2021-10-25T10:41:43.485660990Z",
  "updateTime": "2021-10-25T10:41:43.772361267Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "v8/v8",
      "id": "014e1f857c335ce403447b4aca84f21243ad091b",
      "ref": "refs/branch-heads/9.4"
    }
  }
}
[10:41:43.936] Task URL: https://cr-buildbucket.appspot.com/build/8832405753008208705
[10:41:43.936] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:2:0) after 3m51s
[10:45:34.958] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:2:0)
[10:45:34.992] Build status: SCHEDULED
[10:45:34.992] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:3:0) after 8m29s
[10:54:04.061] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:3:0)
[10:54:04.185] Build status: SCHEDULED
[10:54:04.185] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:4:0) after 2m11s
[10:56:15.252] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:4:0)
[10:56:15.285] Build status: SCHEDULED
[10:56:15.285] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:5:0) after 1m40s
[10:57:55.344] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:5:0)
[10:57:55.374] Build status: SCHEDULED
[10:57:55.374] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:6:0) after 7m57s
[11:05:52.403] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:6:0)
[11:05:52.462] Build status: SCHEDULED
[11:05:52.462] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:7:0) after 1m10s
[11:07:02.504] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:7:0)
[11:07:02.564] Build status: SCHEDULED
[11:07:02.564] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:8:0) after 5m19s
[11:12:21.588] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:8:0)
[11:12:21.622] Build status: SCHEDULED
[11:12:21.622] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:9:0) after 3m1s
[11:15:22.700] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:9:0)
[11:15:22.730] Build status: SCHEDULED
[11:15:22.730] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:10:0) after 6m14s
[11:21:36.854] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:10:0)
[11:21:36.898] Build status: SCHEDULED
[11:21:36.898] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:11:0) after 4m55s
[11:26:32.010] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:11:0)
[11:26:32.048] Build status: SCHEDULED
[11:26:32.048] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:12:0) after 9m39s
[11:36:11.149] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:12:0)
[11:36:11.193] Build status: SCHEDULED
[11:36:11.193] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:13:0) after 5m16s
[11:41:27.513] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:13:0)
[11:41:27.589] Build status: SCHEDULED
[11:41:27.589] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:14:0) after 8m44s
[11:50:11.765] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:14:0)
[11:50:11.794] Build status: SCHEDULED
[11:50:11.794] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:15:0) after 6m59s
[11:57:10.926] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:15:0)
[11:57:11.077] Build status: SCHEDULED
[11:57:11.077] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:16:0) after 7m1s
[12:04:12.247] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:16:0)
[12:04:12.285] Build status: SCHEDULED
[12:04:12.285] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:17:0) after 6m46s
[12:10:58.328] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:17:0)
[12:10:58.383] Build status: SCHEDULED
[12:10:58.383] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:18:0) after 1m57s
[12:12:55.546] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:18:0)
[12:12:55.576] Build status: SCHEDULED
[12:12:55.576] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:19:0) after 5m52s
[12:18:47.600] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:19:0)
[12:18:47.632] Build status: SCHEDULED
[12:18:47.632] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:20:0) after 1m53s
[12:20:40.731] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:20:0)
[12:20:40.761] Build status: SCHEDULED
[12:20:40.761] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:21:0) after 5m26s
[12:26:06.982] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:21:0)
[12:26:07.012] Build status: SCHEDULED
[12:26:07.012] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:22:0) after 9m1s
[12:35:08.034] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:22:0)
[12:35:08.205] Build status: SCHEDULED
[12:35:08.205] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:23:0) after 4m6s
[12:39:14.225] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:23:0)
[12:39:14.252] Build status: SCHEDULED
[12:39:14.252] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:24:0) after 5m55s
[12:45:09.435] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:24:0)
[12:45:09.490] Build status: SCHEDULED
[12:45:09.490] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:25:0) after 1m50s
[12:46:59.512] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:25:0)
[12:46:59.550] Build status: SCHEDULED
[12:46:59.550] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:26:0) after 1m51s
[12:48:50.706] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:26:0)
[12:48:50.741] Build status: SCHEDULED
[12:48:50.741] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:27:0) after 6m3s
[12:54:54.046] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:27:0)
[12:54:54.107] Build status: SCHEDULED
[12:54:54.107] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:28:0) after 1m3s
[12:55:57.133] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:28:0)
[12:55:57.181] Build status: SCHEDULED
[12:55:57.181] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:29:0) after 3m58s
[12:59:55.375] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:29:0)
[12:59:55.407] Build status: SCHEDULED
[12:59:55.407] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:30:0) after 6m8s
[13:06:03.470] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:30:0)
[13:06:03.535] Build status: SCHEDULED
[13:06:03.536] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:31:0) after 5m21s
[13:11:24.564] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:31:0)
[13:11:24.628] Build status: SCHEDULED
[13:11:24.628] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:32:0) after 2m48s
[13:14:12.648] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:32:0)
[13:14:12.792] Build status: SCHEDULED
[13:14:12.793] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:33:0) after 8m45s
[13:22:57.833] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:33:0)
[13:22:57.869] Build status: SCHEDULED
[13:22:57.869] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:34:0) after 5m42s
[13:28:39.869] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:34:0)
[13:28:39.903] Build status: SCHEDULED
[13:28:39.903] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:35:0) after 6m16s
[13:34:55.925] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:35:0)
[13:34:56.044] Build status: SCHEDULED
[13:34:56.045] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:36:0) after 7m37s
[13:42:33.066] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:36:0)
[13:42:33.099] Build status: SCHEDULED
[13:42:33.099] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:37:0) after 5m29s
[13:48:02.196] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:37:0)
[13:48:02.262] Build status: SCHEDULED
[13:48:02.262] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:38:0) after 6m24s
[13:54:26.637] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:38:0)
[13:54:26.689] Build status: SCHEDULED
[13:54:26.689] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:39:0) after 2m26s
[13:56:52.719] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:39:0)
[13:56:52.779] Build status: SCHEDULED
[13:56:52.779] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:40:0) after 6m42s
[14:03:34.803] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:40:0)
[14:03:34.832] Build status: SCHEDULED
[14:03:34.832] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:41:0) after 6m8s
[14:09:42.925] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:41:0)
[14:09:43.186] Build status: SCHEDULED
[14:09:43.186] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:42:0) after 5m23s
[14:15:06.207] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:42:0)
[14:15:06.237] Build status: SCHEDULED
[14:15:06.237] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:43:0) after 6m15s
[14:21:21.362] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:43:0)
[14:21:21.401] Build status: SCHEDULED
[14:21:21.401] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:44:0) after 7m14s
[14:28:35.524] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:44:0)
[14:28:35.552] Build status: SCHEDULED
[14:28:35.552] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:45:0) after 1m46s
[14:30:21.872] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:45:0)
[14:30:21.906] Build status: SCHEDULED
[14:30:21.906] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:46:0) after 1m4s
[14:31:25.927] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:46:0)
[14:31:25.957] Build status: SCHEDULED
[14:31:25.957] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:47:0) after 4m56s
[14:36:22.082] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:47:0)
[14:36:22.141] Build status: SCHEDULED
[14:36:22.141] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:48:0) after 4m52s
[14:41:14.163] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:48:0)
[14:41:14.198] Build status: SCHEDULED
[14:41:14.198] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:49:0) after 9m46s
[14:51:00.217] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:49:0)
[14:51:00.250] Build status: SCHEDULED
[14:51:00.250] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:50:0) after 3m10s
[14:54:10.274] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:50:0)
[14:54:10.381] Build status: SCHEDULED
[14:54:10.381] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:51:0) after 3m50s
[14:58:00.402] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:51:0)
[14:58:00.449] Build status: SCHEDULED
[14:58:00.449] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:52:0) after 8m14s
[15:06:14.486] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:52:0)
[15:06:14.536] Build status: SCHEDULED
[15:06:14.536] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:53:0) after 5m56s
[15:12:10.691] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:53:0)
[15:12:10.726] Build status: SCHEDULED
[15:12:10.726] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:54:0) after 4m33s
[15:16:43.794] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:54:0)
[15:16:43.825] Build status: SCHEDULED
[15:16:43.825] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:55:0) after 2m26s
[15:19:09.843] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:55:0)
[15:19:09.873] Build status: SCHEDULED
[15:19:09.873] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:56:0) after 9m13s
[15:22:57.752] Received PubSub notification, asking Buildbucket for the build status
[15:22:57.837] Build status: STARTED
[15:28:23.022] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:56:0)
[15:28:23.118] Build status: STARTED
[15:28:23.118] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:58:0) after 7m38s
[15:36:01.433] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:58:0)
[15:36:01.469] Build status: STARTED
[15:36:01.469] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8997835814856249616:59:0) after 6m36s
[15:40:21.362] Received PubSub notification, asking Buildbucket for the build status
[15:40:21.399] Build:
{
  "id": "8832405753008208705",
  "builder": {
    "project": "v8",
    "bucket": "ci.br.extended",
    "builder": "V8 Win32 - debug"
  },
  "number": 18,
  "createdBy": "project:v8",
  "createTime": "2021-10-25T10:41:43.485660990Z",
  "startTime": "2021-10-25T15:22:55.938244Z",
  "endTime": "2021-10-25T15:40:20.880729670Z",
  "updateTime": "2021-10-25T15:40:20.881226867Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "v8/v8",
      "id": "014e1f857c335ce403447b4aca84f21243ad091b",
      "ref": "refs/branch-heads/9.4"
    }
  }
}
[15:40:21.399] Invocation finished in 4h58m39.060119299s with status SUCCEEDED