[11:27:50.596] New invocation is queued and will start shortly
[11:27:50.596] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[11:27:51.861] Starting the invocation (attempt 1)
[11:27:51.896] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/adfdd5380e6b3c58338481368d35506a4ec4506f"
[11:27:51.896] Reconstructed gitiles commit from tags
[11:27:51.896] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:27:51.896] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:27:51.897] Buildbucket request:
{
"requestId": "8974368297847384784",
"builder": {
"project": "v8",
"bucket": "ci.br.extended",
"builder": "V8 Linux64 - custom snapshot - debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8974368297847384784",
"job": "v8/ci.br.extended-V8 Linux64 - custom snapshot - debug",
"triggers": [
{
"buildbucket": {
"properties": {
"newest_gitiles_revision": "adfdd5380e6b3c58338481368d35506a4ec4506f",
"oldest_gitiles_revision": "adfdd5380e6b3c58338481368d35506a4ec4506f",
"parent_build": "https://cr-buildbucket.appspot.com/build/8808940197815700401",
"parent_buildername": "V8 Linux64 - custom snapshot - debug builder",
"parent_gn_args": [
"is_component_build = true",
"is_debug = true",
"target_cpu = \"x64\"",
"use_goma = true",
"v8_embed_script = \"test/mjsunit/mjsunit.js\"",
"v8_enable_backtrace = true",
"v8_enable_google_benchmark = true",
"v8_enable_slow_dchecks = true"
],
"parent_got_revision": "adfdd5380e6b3c58338481368d35506a4ec4506f",
"parent_got_revision_cp": "refs/branch-heads/10.2@{#26}",
"parent_test_spec": {
"swarming_dimensions": {
"os": "Ubuntu-18.04"
},
"swarming_task_attrs": {
},
"tests": [
[
"mjsunit",
1,
null,
"",
[
"--no-harness"
],
{
},
{
}
]
]
},
"revision": "adfdd5380e6b3c58338481368d35506a4ec4506f",
"swarm_hashes": {
"mjsunit": "29b6c86b4e9ecc1f556b3b0e7e42a47e0f593797741f069494be5595858e4bc0/318"
}
},
"tags": [
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/adfdd5380e6b3c58338481368d35506a4ec4506f",
"gitiles_ref:refs/branch-heads/10.2",
"parent_buildername:V8 Linux64 - custom snapshot - debug builder",
"parent_buildnumber:103",
"user_agent:recipe"
]
},
"id": "ded359a5-d637-43c3-9b04-5a43e435d955",
"title": "V8 Linux64 - custom snapshot - debug builder/103"
}
]
},
"newest_gitiles_revision": "adfdd5380e6b3c58338481368d35506a4ec4506f",
"oldest_gitiles_revision": "adfdd5380e6b3c58338481368d35506a4ec4506f",
"parent_build": "https://cr-buildbucket.appspot.com/build/8808940197815700401",
"parent_buildername": "V8 Linux64 - custom snapshot - debug builder",
"parent_gn_args": [
"is_component_build = true",
"is_debug = true",
"target_cpu = \"x64\"",
"use_goma = true",
"v8_embed_script = \"test/mjsunit/mjsunit.js\"",
"v8_enable_backtrace = true",
"v8_enable_google_benchmark = true",
"v8_enable_slow_dchecks = true"
],
"parent_got_revision": "adfdd5380e6b3c58338481368d35506a4ec4506f",
"parent_got_revision_cp": "refs/branch-heads/10.2@{#26}",
"parent_test_spec": {
"swarming_dimensions": {
"os": "Ubuntu-18.04"
},
"swarming_task_attrs": {
},
"tests": [
[
"mjsunit",
1,
null,
"",
[
"--no-harness"
],
{
},
{
}
]
]
},
"swarm_hashes": {
"mjsunit": "29b6c86b4e9ecc1f556b3b0e7e42a47e0f593797741f069494be5595858e4bc0/318"
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "adfdd5380e6b3c58338481368d35506a4ec4506f",
"ref": "refs/branch-heads/10.2"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8974368297847384784"
},
{
"key": "scheduler_job_id",
"value": "v8/ci.br.extended-V8 Linux64 - custom snapshot - debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "V8 Linux64 - custom snapshot - debug builder"
},
{
"key": "parent_buildnumber",
"value": "103"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[11:27:52.776] Scheduled build:
{
"id": "8808938235662563617",
"builder": {
"project": "v8",
"bucket": "ci.br.extended",
"builder": "V8 Linux64 - custom snapshot - debug"
},
"number": 94,
"createdBy": "project:v8",
"createTime": "2022-07-11T11:27:52.047246397Z",
"updateTime": "2022-07-11T11:27:52.047246397Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "adfdd5380e6b3c58338481368d35506a4ec4506f",
"ref": "refs/branch-heads/10.2"
}
}
}
[11:27:52.776] Task URL: https://cr-buildbucket.appspot.com/build/8808938235662563617
[11:27:52.776] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:2:0) after 1m6s
[11:28:58.884] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:2:0)
[11:28:58.912] Build status: SCHEDULED
[11:28:58.912] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:3:0) after 4m24s
[11:33:22.932] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:3:0)
[11:33:22.962] Build status: SCHEDULED
[11:33:22.962] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:4:0) after 8m47s
[11:42:09.965] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:4:0)
[11:42:09.996] Build status: SCHEDULED
[11:42:09.996] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:5:0) after 3m24s
[11:45:33.967] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:5:0)
[11:45:34.003] Build status: SCHEDULED
[11:45:34.003] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:6:0) after 5m5s
[11:50:39.124] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:6:0)
[11:50:39.159] Build status: SCHEDULED
[11:50:39.159] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:7:0) after 5m50s
[11:56:29.220] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:7:0)
[11:56:29.271] Build status: SCHEDULED
[11:56:29.271] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:8:0) after 9m51s
[12:06:20.409] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:8:0)
[12:06:20.446] Build status: SCHEDULED
[12:06:20.446] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:9:0) after 2m2s
[12:08:22.468] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:9:0)
[12:08:22.502] Build status: SCHEDULED
[12:08:22.502] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:10:0) after 6m48s
[12:15:10.520] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:10:0)
[12:15:10.551] Build status: SCHEDULED
[12:15:10.552] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:11:0) after 8m21s
[12:23:31.541] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:11:0)
[12:23:31.576] Build status: SCHEDULED
[12:23:31.576] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:12:0) after 3m4s
[12:26:35.596] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:12:0)
[12:26:35.628] Build status: SCHEDULED
[12:26:35.628] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:13:0) after 5m20s
[12:31:55.648] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:13:0)
[12:31:55.720] Build status: SCHEDULED
[12:31:55.720] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:14:0) after 2m49s
[12:34:44.800] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:14:0)
[12:34:44.864] Build status: SCHEDULED
[12:34:44.864] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:15:0) after 4m12s
[12:38:56.849] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:15:0)
[12:38:56.885] Build status: SCHEDULED
[12:38:56.885] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:16:0) after 9m33s
[12:48:29.905] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:16:0)
[12:48:29.936] Build status: SCHEDULED
[12:48:29.936] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:17:0) after 2m53s
[12:51:22.954] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:17:0)
[12:51:23.040] Build status: SCHEDULED
[12:51:23.040] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:18:0) after 1m36s
[12:52:59.061] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:18:0)
[12:52:59.084] Build status: SCHEDULED
[12:52:59.084] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:19:0) after 6m15s
[12:59:14.104] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:19:0)
[12:59:14.144] Build status: SCHEDULED
[12:59:14.144] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:20:0) after 2m35s
[13:01:49.553] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:20:0)
[13:01:49.588] Build status: SCHEDULED
[13:01:49.588] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:21:0) after 5m37s
[13:07:26.827] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:21:0)
[13:07:26.862] Build status: SCHEDULED
[13:07:26.862] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:22:0) after 2m4s
[13:09:30.881] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:22:0)
[13:09:30.901] Build status: SCHEDULED
[13:09:30.901] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:23:0) after 4m0s
[13:13:30.994] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:23:0)
[13:13:31.032] Build status: SCHEDULED
[13:13:31.032] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:24:0) after 4m47s
[13:18:18.099] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:24:0)
[13:18:18.150] Build status: SCHEDULED
[13:18:18.150] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:25:0) after 7m1s
[13:19:41.417] Received PubSub notification, asking Buildbucket for the build status
[13:19:41.450] Build status: STARTED
[13:25:19.257] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:25:0)
[13:25:19.292] Build status: STARTED
[13:25:19.292] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:27:0) after 2m18s
[13:27:37.316] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:27:0)
[13:27:37.391] Build status: STARTED
[13:27:37.391] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:28:0) after 3m57s
[13:31:34.599] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:28:0)
[13:31:34.628] Build status: STARTED
[13:31:34.629] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:29:0) after 3m51s
[13:35:25.709] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:29:0)
[13:35:25.738] Build status: STARTED
[13:35:25.738] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:30:0) after 2m11s
[13:37:36.786] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:30:0)
[13:37:36.818] Build status: STARTED
[13:37:36.818] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:31:0) after 5m50s
[13:43:26.980] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:31:0)
[13:43:27.013] Build status: STARTED
[13:43:27.013] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:32:0) after 6m55s
[13:50:22.239] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:32:0)
[13:50:22.280] Build status: STARTED
[13:50:22.280] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Linux64 - custom snapshot - debug:8974368297847384784:33:0) after 6m8s
[13:55:25.438] Received PubSub notification, asking Buildbucket for the build status
[13:55:25.471] Build:
{
"id": "8808938235662563617",
"builder": {
"project": "v8",
"bucket": "ci.br.extended",
"builder": "V8 Linux64 - custom snapshot - debug"
},
"number": 94,
"createdBy": "project:v8",
"createTime": "2022-07-11T11:27:52.047246397Z",
"startTime": "2022-07-11T13:19:39.246657Z",
"endTime": "2022-07-11T13:54:43.281358573Z",
"updateTime": "2022-07-11T13:54:43.281358573Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "adfdd5380e6b3c58338481368d35506a4ec4506f",
"ref": "refs/branch-heads/10.2"
}
}
}
[13:55:25.471] Invocation finished in 2h27m34.891196654s with status SUCCEEDED