[11:30:33.737] New invocation is queued and will start shortly
[11:30:33.737] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[11:30:34.819] Starting the invocation (attempt 1)
[11:30:34.852] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/057195e26fc9b057c0802f0c2a65c4fe264155bd"
[11:30:34.852] Reconstructed gitiles commit from tags
[11:30:34.852] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:30:34.852] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:30:34.853] Buildbucket request:
{
"requestId": "8950269333744862272",
"builder": {
"project": "v8",
"bucket": "ci.br.extended",
"builder": "V8 Win64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8950269333744862272",
"job": "v8/ci.br.extended-V8 Win64",
"triggers": [
{
"buildbucket": {
"properties": {
"newest_gitiles_revision": "057195e26fc9b057c0802f0c2a65c4fe264155bd",
"oldest_gitiles_revision": "057195e26fc9b057c0802f0c2a65c4fe264155bd",
"parent_build": "https://cr-buildbucket.appspot.com/build/8784844167737180609",
"parent_buildername": "V8 Win64 - builder",
"parent_gn_args": [
"dcheck_always_on = false",
"is_component_build = false",
"is_debug = false",
"symbol_level = 1",
"target_cpu = \"x64\"",
"use_goma = false",
"use_remoteexec = true",
"v8_enable_google_benchmark = true"
],
"parent_got_revision": "057195e26fc9b057c0802f0c2a65c4fe264155bd",
"parent_got_revision_cp": "refs/branch-heads/11.2@{#26}",
"parent_test_spec": {
"swarming_dimensions": {
"os": "Windows-10-19045"
},
"swarming_task_attrs": {
},
"tests": [
[
"mozilla",
1,
null,
"",
[
],
{
},
{
}
],
[
"test262",
2,
"default",
"default",
[
],
{
},
{
}
],
[
"v8testing",
2,
null,
"",
[
],
{
},
{
}
],
[
"v8testing",
2,
"extra",
"extra",
[
],
{
},
{
}
]
]
},
"revision": "057195e26fc9b057c0802f0c2a65c4fe264155bd",
"swarm_hashes": {
"bot_default": "bca6ed2dd939e2a84e0002759bc8302374eb360c04a6d82b6c0e304ec95650ad/320",
"mozilla": "3866f20cce6bb386d2118713b1cee82f019cfead229d3cc9c739c6866f64e598/319",
"test262": "ed5885f12d79290bd9a50131ad8e330a5f699438f015bd88adcc7bdb060cab63/404"
}
},
"tags": [
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/057195e26fc9b057c0802f0c2a65c4fe264155bd",
"gitiles_ref:refs/branch-heads/11.2",
"parent_buildername:V8 Win64 - builder",
"parent_buildnumber:153",
"user_agent:recipe"
]
},
"id": "c4558958-ed00-4dce-a608-df6c32449d43",
"title": "V8 Win64 - builder/153"
}
]
},
"newest_gitiles_revision": "057195e26fc9b057c0802f0c2a65c4fe264155bd",
"oldest_gitiles_revision": "057195e26fc9b057c0802f0c2a65c4fe264155bd",
"parent_build": "https://cr-buildbucket.appspot.com/build/8784844167737180609",
"parent_buildername": "V8 Win64 - builder",
"parent_gn_args": [
"dcheck_always_on = false",
"is_component_build = false",
"is_debug = false",
"symbol_level = 1",
"target_cpu = \"x64\"",
"use_goma = false",
"use_remoteexec = true",
"v8_enable_google_benchmark = true"
],
"parent_got_revision": "057195e26fc9b057c0802f0c2a65c4fe264155bd",
"parent_got_revision_cp": "refs/branch-heads/11.2@{#26}",
"parent_test_spec": {
"swarming_dimensions": {
"os": "Windows-10-19045"
},
"swarming_task_attrs": {
},
"tests": [
[
"mozilla",
1,
null,
"",
[
],
{
},
{
}
],
[
"test262",
2,
"default",
"default",
[
],
{
},
{
}
],
[
"v8testing",
2,
null,
"",
[
],
{
},
{
}
],
[
"v8testing",
2,
"extra",
"extra",
[
],
{
},
{
}
]
]
},
"swarm_hashes": {
"bot_default": "bca6ed2dd939e2a84e0002759bc8302374eb360c04a6d82b6c0e304ec95650ad/320",
"mozilla": "3866f20cce6bb386d2118713b1cee82f019cfead229d3cc9c739c6866f64e598/319",
"test262": "ed5885f12d79290bd9a50131ad8e330a5f699438f015bd88adcc7bdb060cab63/404"
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "057195e26fc9b057c0802f0c2a65c4fe264155bd",
"ref": "refs/branch-heads/11.2"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8950269333744862272"
},
{
"key": "scheduler_job_id",
"value": "v8/ci.br.extended-V8 Win64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "V8 Win64 - builder"
},
{
"key": "parent_buildnumber",
"value": "153"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[11:30:35.347] Scheduled build:
{
"id": "8784839271823297729",
"builder": {
"project": "v8",
"bucket": "ci.br.extended",
"builder": "V8 Win64"
},
"number": 176,
"createdBy": "project:v8",
"createTime": "2023-04-03T11:30:34.913837090Z",
"updateTime": "2023-04-03T11:30:34.913837090Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "057195e26fc9b057c0802f0c2a65c4fe264155bd",
"ref": "refs/branch-heads/11.2"
}
}
}
[11:30:35.347] Task URL: https://cr-buildbucket.appspot.com/build/8784839271823297729
[11:30:35.347] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:2:0) after 7m57s
[11:38:32.398] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:2:0)
[11:38:32.420] Build status: SCHEDULED
[11:38:32.420] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:3:0) after 5m0s
[11:43:32.457] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:3:0)
[11:43:32.478] Build status: SCHEDULED
[11:43:32.479] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:4:0) after 1m53s
[11:45:25.550] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:4:0)
[11:45:25.575] Build status: SCHEDULED
[11:45:25.575] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:5:0) after 5m47s
[11:51:12.595] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:5:0)
[11:51:12.618] Build status: SCHEDULED
[11:51:12.618] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:6:0) after 4m28s
[11:55:40.745] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:6:0)
[11:55:40.767] Build status: SCHEDULED
[11:55:40.767] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:7:0) after 1m7s
[11:56:47.834] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:7:0)
[11:56:47.858] Build status: SCHEDULED
[11:56:47.858] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:8:0) after 1m24s
[11:58:11.879] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:8:0)
[11:58:11.900] Build status: SCHEDULED
[11:58:11.900] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:9:0) after 1m23s
[11:59:34.974] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:9:0)
[11:59:34.995] Build status: SCHEDULED
[11:59:34.995] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:10:0) after 3m18s
[12:02:53.014] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:10:0)
[12:02:53.042] Build status: SCHEDULED
[12:02:53.042] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:11:0) after 6m25s
[12:09:18.258] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:11:0)
[12:09:18.281] Build status: SCHEDULED
[12:09:18.281] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:12:0) after 6m8s
[12:15:26.411] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:12:0)
[12:15:26.651] Build status: SCHEDULED
[12:15:26.651] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:13:0) after 5m48s
[12:21:14.708] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:13:0)
[12:21:14.728] Build status: SCHEDULED
[12:21:14.728] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:14:0) after 2m24s
[12:23:38.748] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:14:0)
[12:23:38.928] Build status: SCHEDULED
[12:23:38.928] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:15:0) after 3m35s
[12:27:13.955] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:15:0)
[12:27:13.976] Build status: SCHEDULED
[12:27:13.976] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:16:0) after 2m4s
[12:29:18.171] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:16:0)
[12:29:18.322] Build status: SCHEDULED
[12:29:18.323] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:17:0) after 5m30s
[12:34:48.818] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:17:0)
[12:34:48.840] Build status: SCHEDULED
[12:34:48.840] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:18:0) after 3m39s
[12:38:27.861] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:18:0)
[12:38:27.884] Build status: SCHEDULED
[12:38:27.884] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:19:0) after 9m33s
[12:48:01.046] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:19:0)
[12:48:02.982] Build status: SCHEDULED
[12:48:02.983] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:20:0) after 5m0s
[12:53:03.361] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:20:0)
[12:53:03.389] Build status: SCHEDULED
[12:53:03.389] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:21:0) after 5m55s
[12:58:58.537] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:21:0)
[12:58:58.557] Build status: SCHEDULED
[12:58:58.557] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:22:0) after 9m11s
[13:08:09.587] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:22:0)
[13:08:09.655] Build status: SCHEDULED
[13:08:09.655] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:23:0) after 3m58s
[13:12:07.677] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:23:0)
[13:12:07.708] Build status: SCHEDULED
[13:12:07.708] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:24:0) after 1m12s
[13:13:19.763] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:24:0)
[13:13:19.820] Build status: SCHEDULED
[13:13:19.820] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:25:0) after 4m47s
[13:18:06.841] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:25:0)
[13:18:06.864] Build status: SCHEDULED
[13:18:06.864] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:26:0) after 3m54s
[13:22:00.890] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:26:0)
[13:22:00.920] Build status: SCHEDULED
[13:22:00.920] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:27:0) after 4m12s
[13:26:12.945] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:27:0)
[13:26:12.969] Build status: SCHEDULED
[13:26:12.969] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:28:0) after 8m32s
[13:34:44.991] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:28:0)
[13:34:45.066] Build status: SCHEDULED
[13:34:45.067] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:29:0) after 6m16s
[13:41:01.086] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:29:0)
[13:41:01.109] Build status: SCHEDULED
[13:41:01.109] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:30:0) after 5m1s
[13:46:02.137] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:30:0)
[13:46:02.338] Build status: SCHEDULED
[13:46:02.338] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:31:0) after 8m51s
[13:54:53.409] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:31:0)
[13:54:53.434] Build status: SCHEDULED
[13:54:53.434] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:32:0) after 4m8s
[13:59:01.457] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:32:0)
[13:59:01.490] Build status: SCHEDULED
[13:59:01.490] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:33:0) after 3m12s
[14:02:13.552] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:33:0)
[14:02:13.974] Build status: SCHEDULED
[14:02:13.974] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:34:0) after 1m57s
[14:04:11.066] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:34:0)
[14:04:11.102] Build status: SCHEDULED
[14:04:11.102] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:35:0) after 6m26s
[14:09:24.164] Received PubSub notification, asking Buildbucket for the build status
[14:09:24.186] Build status: STARTED
[14:10:37.179] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:35:0)
[14:10:37.221] Build status: STARTED
[14:10:37.221] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:37:0) after 2m41s
[14:13:18.238] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:37:0)
[14:13:18.267] Build status: STARTED
[14:13:18.267] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:38:0) after 3m17s
[14:16:35.336] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:38:0)
[14:16:35.367] Build status: STARTED
[14:16:35.367] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64:8950269333744862272:39:0) after 9m49s
[14:22:25.000] Received PubSub notification, asking Buildbucket for the build status
[14:22:25.053] Build:
{
"id": "8784839271823297729",
"builder": {
"project": "v8",
"bucket": "ci.br.extended",
"builder": "V8 Win64"
},
"number": 176,
"createdBy": "project:v8",
"createTime": "2023-04-03T11:30:34.913837090Z",
"startTime": "2023-04-03T14:09:23.634080Z",
"endTime": "2023-04-03T14:22:24.690304138Z",
"updateTime": "2023-04-03T14:22:24.690304138Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "057195e26fc9b057c0802f0c2a65c4fe264155bd",
"ref": "refs/branch-heads/11.2"
}
}
}
[14:22:25.053] Invocation finished in 2h51m51.35596355s with status SUCCEEDED