[10:08:56.370] New invocation is queued and will start shortly
[10:08:56.370] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[10:08:57.517] Starting the invocation (attempt 1)
[10:08:57.548] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/fffe4e12b98cdef0072009c96209c6d3a13e5189"
[10:08:57.548] Reconstructed gitiles commit from tags
[10:08:57.548] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:08:57.548] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:08:57.549] Buildbucket request:
{
"requestId": "8951905214373266576",
"builder": {
"project": "v8",
"bucket": "ci.br.extended",
"builder": "V8 Win32 - debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8951905214373266576",
"job": "v8/ci.br.extended-V8 Win32 - debug",
"triggers": [
{
"buildbucket": {
"properties": {
"newest_gitiles_revision": "fffe4e12b98cdef0072009c96209c6d3a13e5189",
"oldest_gitiles_revision": "fffe4e12b98cdef0072009c96209c6d3a13e5189",
"parent_build": "https://cr-buildbucket.appspot.com/build/8786479891886772929",
"parent_buildername": "V8 Win32 - debug builder",
"parent_gn_args": [
"is_component_build = true",
"is_debug = true",
"symbol_level = 1",
"target_cpu = \"x86\"",
"use_goma = false",
"use_remoteexec = true",
"v8_enable_backtrace = true",
"v8_enable_google_benchmark = true",
"v8_enable_slow_dchecks = true"
],
"parent_got_revision": "fffe4e12b98cdef0072009c96209c6d3a13e5189",
"parent_got_revision_cp": "refs/branch-heads/11.0@{#40}",
"parent_test_spec": {
"swarming_dimensions": {
"cpu": "x86-64",
"os": "Windows-10-19045"
},
"swarming_task_attrs": {
},
"tests": [
[
"mozilla",
1,
null,
"",
[
],
{
},
{
}
],
[
"test262",
2,
"default",
"default",
[
],
{
},
{
}
],
[
"v8testing",
5,
null,
"",
[
],
{
},
{
}
]
]
},
"revision": "fffe4e12b98cdef0072009c96209c6d3a13e5189",
"swarm_hashes": {
"bot_default": "4cbc978226e686f65204f6e32a4cc192babd0104995e7aa0bab93f64af2a9ab1/320",
"mozilla": "e52a2c3eb9084118a76c7d186e5f7a28066f73004d187a6ea4a5624412b728d8/319",
"test262": "b698396a57cf5b1e0d3cf2fb975ad7a46ed71e85daf5fd49af0f3641fcc1d003/404"
}
},
"tags": [
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/fffe4e12b98cdef0072009c96209c6d3a13e5189",
"gitiles_ref:refs/branch-heads/11.0",
"parent_buildername:V8 Win32 - debug builder",
"parent_buildnumber:179",
"user_agent:recipe"
]
},
"id": "c8c04b63-ec58-4c7e-861d-2c072bb1c966",
"title": "V8 Win32 - debug builder/179"
}
]
},
"newest_gitiles_revision": "fffe4e12b98cdef0072009c96209c6d3a13e5189",
"oldest_gitiles_revision": "fffe4e12b98cdef0072009c96209c6d3a13e5189",
"parent_build": "https://cr-buildbucket.appspot.com/build/8786479891886772929",
"parent_buildername": "V8 Win32 - debug builder",
"parent_gn_args": [
"is_component_build = true",
"is_debug = true",
"symbol_level = 1",
"target_cpu = \"x86\"",
"use_goma = false",
"use_remoteexec = true",
"v8_enable_backtrace = true",
"v8_enable_google_benchmark = true",
"v8_enable_slow_dchecks = true"
],
"parent_got_revision": "fffe4e12b98cdef0072009c96209c6d3a13e5189",
"parent_got_revision_cp": "refs/branch-heads/11.0@{#40}",
"parent_test_spec": {
"swarming_dimensions": {
"cpu": "x86-64",
"os": "Windows-10-19045"
},
"swarming_task_attrs": {
},
"tests": [
[
"mozilla",
1,
null,
"",
[
],
{
},
{
}
],
[
"test262",
2,
"default",
"default",
[
],
{
},
{
}
],
[
"v8testing",
5,
null,
"",
[
],
{
},
{
}
]
]
},
"swarm_hashes": {
"bot_default": "4cbc978226e686f65204f6e32a4cc192babd0104995e7aa0bab93f64af2a9ab1/320",
"mozilla": "e52a2c3eb9084118a76c7d186e5f7a28066f73004d187a6ea4a5624412b728d8/319",
"test262": "b698396a57cf5b1e0d3cf2fb975ad7a46ed71e85daf5fd49af0f3641fcc1d003/404"
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "fffe4e12b98cdef0072009c96209c6d3a13e5189",
"ref": "refs/branch-heads/11.0"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8951905214373266576"
},
{
"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": "179"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[10:08:57.970] Scheduled build:
{
"id": "8786475152401947921",
"builder": {
"project": "v8",
"bucket": "ci.br.extended",
"builder": "V8 Win32 - debug"
},
"number": 171,
"createdBy": "project:v8",
"createTime": "2023-03-16T10:08:57.620496262Z",
"updateTime": "2023-03-16T10:08:57.620496262Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "fffe4e12b98cdef0072009c96209c6d3a13e5189",
"ref": "refs/branch-heads/11.0"
}
}
}
[10:08:57.970] Task URL: https://cr-buildbucket.appspot.com/build/8786475152401947921
[10:08:57.970] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:2:0) after 1m52s
[10:10:50.182] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:2:0)
[10:10:50.202] Build status: SCHEDULED
[10:10:50.202] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:3:0) after 3m29s
[10:14:19.271] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:3:0)
[10:14:19.299] Build status: SCHEDULED
[10:14:19.299] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:4:0) after 6m52s
[10:21:12.006] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:4:0)
[10:21:12.032] Build status: SCHEDULED
[10:21:12.032] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:5:0) after 7m23s
[10:28:35.055] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:5:0)
[10:28:35.106] Build status: SCHEDULED
[10:28:35.106] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:6:0) after 8m38s
[10:37:13.147] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:6:0)
[10:37:13.166] Build status: SCHEDULED
[10:37:13.166] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:7:0) after 7m57s
[10:45:10.209] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:7:0)
[10:45:10.230] Build status: SCHEDULED
[10:45:10.230] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:8:0) after 2m28s
[10:47:38.246] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:8:0)
[10:47:38.300] Build status: SCHEDULED
[10:47:38.300] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:9:0) after 4m35s
[10:52:13.448] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:9:0)
[10:52:13.473] Build status: SCHEDULED
[10:52:13.473] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:10:0) after 7m23s
[10:59:36.668] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:10:0)
[10:59:36.707] Build status: SCHEDULED
[10:59:36.707] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:11:0) after 9m7s
[11:08:43.753] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:11:0)
[11:08:43.773] Build status: SCHEDULED
[11:08:43.773] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:12:0) after 1m52s
[11:10:35.955] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:12:0)
[11:10:35.984] Build status: SCHEDULED
[11:10:35.984] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:13:0) after 6m8s
[11:16:44.041] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:13:0)
[11:16:44.109] Build status: SCHEDULED
[11:16:44.109] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:14:0) after 7m30s
[11:24:14.127] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:14:0)
[11:24:14.150] Build status: SCHEDULED
[11:24:14.150] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:15:0) after 9m47s
[11:30:31.638] Received PubSub notification, asking Buildbucket for the build status
[11:30:31.656] Build status: STARTED
[11:34:01.198] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:15:0)
[11:34:01.220] Build status: STARTED
[11:34:01.220] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:17:0) after 3m21s
[11:37:22.324] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:17:0)
[11:37:22.343] Build status: STARTED
[11:37:22.343] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:18:0) after 4m37s
[11:41:59.768] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:18:0)
[11:41:59.789] Build status: STARTED
[11:41:59.789] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:19:0) after 4m13s
[11:46:12.906] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:19:0)
[11:46:12.928] Build status: STARTED
[11:46:12.928] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:20:0) after 1m23s
[11:47:35.987] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:20:0)
[11:47:36.046] Build status: STARTED
[11:47:36.046] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:21:0) after 4m57s
[11:52:33.442] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:21:0)
[11:52:33.475] Build status: STARTED
[11:52:33.475] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win32 - debug:8951905214373266576:22:0) after 2m11s
[11:54:27.338] Received PubSub notification, asking Buildbucket for the build status
[11:54:27.357] Build:
{
"id": "8786475152401947921",
"builder": {
"project": "v8",
"bucket": "ci.br.extended",
"builder": "V8 Win32 - debug"
},
"number": 171,
"createdBy": "project:v8",
"createTime": "2023-03-16T10:08:57.620496262Z",
"startTime": "2023-03-16T11:30:30.761641Z",
"endTime": "2023-03-16T11:54:27.039624479Z",
"updateTime": "2023-03-16T11:54:27.039624479Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "fffe4e12b98cdef0072009c96209c6d3a13e5189",
"ref": "refs/branch-heads/11.0"
}
}
}
[11:54:27.357] Invocation finished in 1h45m30.999668438s with status SUCCEEDED