[22:39:58.201] New invocation is queued and will start shortly
[22:39:58.201] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[22:39:59.435] Starting the invocation (attempt 1)
[22:39:59.479] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/94493cdcfe2bbb30c9e82265dce93404fcf3799c"
[22:39:59.479] Reconstructed gitiles commit from tags
[22:39:59.479] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:39:59.479] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:39:59.480] Buildbucket request:
{
"requestId": "8993623165141795632",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Win64 - debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"buildbucket": {
"properties": {
"newest_gitiles_revision": "94493cdcfe2bbb30c9e82265dce93404fcf3799c",
"oldest_gitiles_revision": "94493cdcfe2bbb30c9e82265dce93404fcf3799c",
"parent_build": "https://cr-buildbucket.appspot.com/build/8828196146208916033",
"parent_buildername": "V8 Win64 - debug builder",
"parent_gn_args": [
"is_component_build = true",
"is_debug = true",
"symbol_level = 1",
"target_cpu = \"x64\"",
"use_goma = true",
"v8_enable_backtrace = true",
"v8_enable_google_benchmark = true",
"v8_enable_slow_dchecks = true"
],
"parent_got_revision": "94493cdcfe2bbb30c9e82265dce93404fcf3799c",
"parent_got_revision_cp": "refs/branch-heads/9.8@{#3}",
"parent_test_spec": {
"swarming_dimensions": {
"os": "Windows-10-15063"
},
"swarming_task_attrs": {
},
"tests": [
[
"mozilla",
1,
null,
"",
[
],
{
},
{
}
],
[
"test262",
1,
"default",
"default",
[
],
{
},
{
}
],
[
"v8testing",
4,
null,
"",
[
],
{
},
{
}
],
[
"v8testing",
3,
"extra",
"extra",
[
],
{
},
{
}
]
]
},
"revision": "94493cdcfe2bbb30c9e82265dce93404fcf3799c",
"swarm_hashes": {
"bot_default": "b3a4ce2bba86b25eeee0a84fb60bb563a1d312836ed0cf962cd886cd51d0d22d/319",
"mozilla": "95c2488ab36f823c2bc77b424aeb6fac6c5b1144808b6f998905cabd70ec401c/318",
"test262": "9d238a53cab49cfa5376735744f875c9994fb05a253e61f8e3fc67902b184ed3/318"
}
},
"tags": [
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/94493cdcfe2bbb30c9e82265dce93404fcf3799c",
"gitiles_ref:refs/branch-heads/9.8",
"parent_buildername:V8 Win64 - debug builder",
"parent_buildnumber:30",
"user_agent:recipe"
]
},
"id": "0fb24ac4-9776-4a33-9e0b-2f63db135716",
"title": "V8 Win64 - debug builder/30"
}
]
},
"newest_gitiles_revision": "94493cdcfe2bbb30c9e82265dce93404fcf3799c",
"oldest_gitiles_revision": "94493cdcfe2bbb30c9e82265dce93404fcf3799c",
"parent_build": "https://cr-buildbucket.appspot.com/build/8828196146208916033",
"parent_buildername": "V8 Win64 - debug builder",
"parent_gn_args": [
"is_component_build = true",
"is_debug = true",
"symbol_level = 1",
"target_cpu = \"x64\"",
"use_goma = true",
"v8_enable_backtrace = true",
"v8_enable_google_benchmark = true",
"v8_enable_slow_dchecks = true"
],
"parent_got_revision": "94493cdcfe2bbb30c9e82265dce93404fcf3799c",
"parent_got_revision_cp": "refs/branch-heads/9.8@{#3}",
"parent_test_spec": {
"swarming_dimensions": {
"os": "Windows-10-15063"
},
"swarming_task_attrs": {
},
"tests": [
[
"mozilla",
1,
null,
"",
[
],
{
},
{
}
],
[
"test262",
1,
"default",
"default",
[
],
{
},
{
}
],
[
"v8testing",
4,
null,
"",
[
],
{
},
{
}
],
[
"v8testing",
3,
"extra",
"extra",
[
],
{
},
{
}
]
]
},
"swarm_hashes": {
"bot_default": "b3a4ce2bba86b25eeee0a84fb60bb563a1d312836ed0cf962cd886cd51d0d22d/319",
"mozilla": "95c2488ab36f823c2bc77b424aeb6fac6c5b1144808b6f998905cabd70ec401c/318",
"test262": "9d238a53cab49cfa5376735744f875c9994fb05a253e61f8e3fc67902b184ed3/318"
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "94493cdcfe2bbb30c9e82265dce93404fcf3799c",
"ref": "refs/branch-heads/9.8"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8993623165141795632"
},
{
"key": "scheduler_job_id",
"value": "v8/ci.br.beta-V8 Win64 - debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "V8 Win64 - debug builder"
},
{
"key": "parent_buildnumber",
"value": "30"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:40:00.011] Scheduled build:
{
"id": "8828193103062108929",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Win64 - debug"
},
"number": 414,
"createdBy": "project:v8",
"createTime": "2021-12-10T22:39:59.542309573Z",
"updateTime": "2021-12-10T22:39:59.542309573Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "94493cdcfe2bbb30c9e82265dce93404fcf3799c",
"ref": "refs/branch-heads/9.8"
}
}
}
[22:40:00.011] Task URL: https://cr-buildbucket.appspot.com/build/8828193103062108929
[22:40:00.011] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:2:0) after 1m11s
[22:41:11.094] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:2:0)
[22:41:11.130] Build status: SCHEDULED
[22:41:11.130] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:3:0) after 1m13s
[22:42:24.277] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:3:0)
[22:42:24.307] Build status: SCHEDULED
[22:42:24.307] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:4:0) after 4m34s
[22:46:58.426] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:4:0)
[22:46:58.457] Build status: SCHEDULED
[22:46:58.457] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:5:0) after 6m17s
[22:53:15.503] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:5:0)
[22:53:15.537] Build status: SCHEDULED
[22:53:15.537] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:6:0) after 9m37s
[23:02:52.625] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:6:0)
[23:02:52.758] Build status: SCHEDULED
[23:02:52.758] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:7:0) after 3m35s
[23:06:28.319] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:7:0)
[23:06:28.380] Build status: SCHEDULED
[23:06:28.380] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:8:0) after 8m5s
[23:14:34.448] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:8:0)
[23:14:34.492] Build status: SCHEDULED
[23:14:34.492] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:9:0) after 1m13s
[23:15:48.046] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:9:0)
[23:15:48.076] Build status: SCHEDULED
[23:15:48.076] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:10:0) after 4m37s
[23:20:25.095] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:10:0)
[23:20:25.137] Build status: SCHEDULED
[23:20:25.137] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:11:0) after 2m18s
[23:22:43.154] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:11:0)
[23:22:43.187] Build status: SCHEDULED
[23:22:43.187] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:12:0) after 9m45s
[23:30:32.329] Received PubSub notification, asking Buildbucket for the build status
[23:30:32.368] Build status: STARTED
[23:32:28.365] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:12:0)
[23:32:28.400] Build status: STARTED
[23:32:28.400] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:14:0) after 6m24s
[23:38:52.569] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:14:0)
[23:38:52.604] Build status: STARTED
[23:38:52.604] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:15:0) after 1m24s
[23:40:16.623] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:15:0)
[23:40:16.756] Build status: STARTED
[23:40:16.756] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:16:0) after 3m55s
[23:44:11.978] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:16:0)
[23:44:12.008] Build status: STARTED
[23:44:12.008] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:17:0) after 7m1s
[23:51:13.398] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:17:0)
[23:51:13.432] Build status: STARTED
[23:51:13.432] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:18:0) after 5m2s
[23:56:15.475] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:18:0)
[23:56:15.509] Build status: STARTED
[23:56:15.509] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Win64 - debug:8993623165141795632:19:0) after 8m59s
[00:02:43.965] Received PubSub notification, asking Buildbucket for the build status
[00:02:43.992] Build:
{
"id": "8828193103062108929",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Win64 - debug"
},
"number": 414,
"createdBy": "project:v8",
"createTime": "2021-12-10T22:39:59.542309573Z",
"startTime": "2021-12-10T23:30:22.757390Z",
"endTime": "2021-12-11T00:02:43.121847220Z",
"updateTime": "2021-12-11T00:02:43.121847220Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "94493cdcfe2bbb30c9e82265dce93404fcf3799c",
"ref": "refs/branch-heads/9.8"
}
}
}
[00:02:43.992] Invocation finished in 1h22m45.816655449s with status SUCCEEDED