[13:53:20.420] New invocation is queued and will start shortly
[13:53:20.420] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[13:53:21.537] Starting the invocation (attempt 1)
[13:53:21.578] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/b0cb349e88900b7f027620cc3539f179d6a4d08f"
[13:53:21.578] Reconstructed gitiles commit from tags
[13:53:21.578] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:53:21.578] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:53:21.579] Buildbucket request:
{
"requestId": "8979794961961789152",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Mac64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8979794961961789152",
"job": "v8/ci.br.beta-V8 Mac64",
"triggers": [
{
"buildbucket": {
"properties": {
"newest_gitiles_revision": "b0cb349e88900b7f027620cc3539f179d6a4d08f",
"oldest_gitiles_revision": "b0cb349e88900b7f027620cc3539f179d6a4d08f",
"parent_build": "https://cr-buildbucket.appspot.com/build/8814367152189091505",
"parent_buildername": "V8 Mac64 - builder",
"parent_gn_args": [
"dcheck_always_on = false",
"is_component_build = false",
"is_debug = false",
"target_cpu = \"x64\"",
"use_goma = true",
"v8_enable_google_benchmark = true"
],
"parent_got_revision": "b0cb349e88900b7f027620cc3539f179d6a4d08f",
"parent_got_revision_cp": "refs/branch-heads/10.3@{#1}",
"parent_test_spec": {
"swarming_dimensions": {
"cpu": "x86-64",
"os": "Mac-10.15"
},
"swarming_task_attrs": {
},
"tests": [
[
"mozilla",
1,
null,
"",
[
],
{
},
{
}
],
[
"test262",
3,
"default",
"default",
[
],
{
},
{
}
],
[
"v8testing",
3,
null,
"",
[
],
{
},
{
}
],
[
"v8testing",
3,
"extra",
"extra",
[
],
{
},
{
}
]
]
},
"revision": "b0cb349e88900b7f027620cc3539f179d6a4d08f",
"swarm_hashes": {
"bot_default": "1f8ec584503a6746044cf136b3cbf57681a6da9b1bd1c402a492793386139482/319",
"mozilla": "ad89f533e11dd85c6b4518298235255a93d4904255dfacd24d170feb4efd3109/318",
"test262": "5963d4ebc6a8beadd42bbad4e2378c81beb3dd6476bccd8a72e49fd2fd6271da/403"
}
},
"tags": [
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/b0cb349e88900b7f027620cc3539f179d6a4d08f",
"gitiles_ref:refs/branch-heads/10.3",
"parent_buildername:V8 Mac64 - builder",
"parent_buildnumber:157",
"user_agent:recipe"
]
},
"id": "3c494b98-9eba-43e5-8f6a-8db7eb874013",
"title": "V8 Mac64 - builder/157"
}
]
},
"newest_gitiles_revision": "b0cb349e88900b7f027620cc3539f179d6a4d08f",
"oldest_gitiles_revision": "b0cb349e88900b7f027620cc3539f179d6a4d08f",
"parent_build": "https://cr-buildbucket.appspot.com/build/8814367152189091505",
"parent_buildername": "V8 Mac64 - builder",
"parent_gn_args": [
"dcheck_always_on = false",
"is_component_build = false",
"is_debug = false",
"target_cpu = \"x64\"",
"use_goma = true",
"v8_enable_google_benchmark = true"
],
"parent_got_revision": "b0cb349e88900b7f027620cc3539f179d6a4d08f",
"parent_got_revision_cp": "refs/branch-heads/10.3@{#1}",
"parent_test_spec": {
"swarming_dimensions": {
"cpu": "x86-64",
"os": "Mac-10.15"
},
"swarming_task_attrs": {
},
"tests": [
[
"mozilla",
1,
null,
"",
[
],
{
},
{
}
],
[
"test262",
3,
"default",
"default",
[
],
{
},
{
}
],
[
"v8testing",
3,
null,
"",
[
],
{
},
{
}
],
[
"v8testing",
3,
"extra",
"extra",
[
],
{
},
{
}
]
]
},
"swarm_hashes": {
"bot_default": "1f8ec584503a6746044cf136b3cbf57681a6da9b1bd1c402a492793386139482/319",
"mozilla": "ad89f533e11dd85c6b4518298235255a93d4904255dfacd24d170feb4efd3109/318",
"test262": "5963d4ebc6a8beadd42bbad4e2378c81beb3dd6476bccd8a72e49fd2fd6271da/403"
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "b0cb349e88900b7f027620cc3539f179d6a4d08f",
"ref": "refs/branch-heads/10.3"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8979794961961789152"
},
{
"key": "scheduler_job_id",
"value": "v8/ci.br.beta-V8 Mac64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "V8 Mac64 - builder"
},
{
"key": "parent_buildnumber",
"value": "157"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:53:22.336] Scheduled build:
{
"id": "8814364899978202097",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Mac64"
},
"number": 480,
"createdBy": "project:v8",
"createTime": "2022-05-12T13:53:21.666827335Z",
"updateTime": "2022-05-12T13:53:21.666827335Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "b0cb349e88900b7f027620cc3539f179d6a4d08f",
"ref": "refs/branch-heads/10.3"
}
}
}
[13:53:22.336] Task URL: https://cr-buildbucket.appspot.com/build/8814364899978202097
[13:53:22.336] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:2:0) after 3m46s
[13:57:08.468] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:2:0)
[13:57:08.499] Build status: SCHEDULED
[13:57:08.499] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:3:0) after 4m31s
[14:01:39.590] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:3:0)
[14:01:39.624] Build status: SCHEDULED
[14:01:39.624] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:4:0) after 8m0s
[14:09:39.764] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:4:0)
[14:09:39.840] Build status: SCHEDULED
[14:09:39.840] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:5:0) after 5m51s
[14:15:31.270] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:5:0)
[14:15:31.291] Build status: SCHEDULED
[14:15:31.291] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:6:0) after 5m29s
[14:21:00.331] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:6:0)
[14:21:00.370] Build status: SCHEDULED
[14:21:00.370] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:7:0) after 5m44s
[14:26:44.388] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:7:0)
[14:26:44.455] Build status: SCHEDULED
[14:26:44.455] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:8:0) after 5m58s
[14:32:42.760] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:8:0)
[14:32:42.794] Build status: SCHEDULED
[14:32:42.794] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:9:0) after 1m30s
[14:34:12.942] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:9:0)
[14:34:12.986] Build status: SCHEDULED
[14:34:12.986] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:10:0) after 5m21s
[14:39:34.110] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:10:0)
[14:39:34.141] Build status: SCHEDULED
[14:39:34.141] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:11:0) after 8m22s
[14:47:56.368] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:11:0)
[14:47:56.419] Build status: SCHEDULED
[14:47:56.419] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:12:0) after 1m20s
[14:49:16.532] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:12:0)
[14:49:16.563] Build status: SCHEDULED
[14:49:16.563] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:13:0) after 2m8s
[14:51:24.646] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:13:0)
[14:51:24.674] Build status: SCHEDULED
[14:51:24.674] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:14:0) after 5m2s
[14:56:26.702] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:14:0)
[14:56:26.734] Build status: SCHEDULED
[14:56:26.734] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:15:0) after 4m4s
[15:00:30.764] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:15:0)
[15:00:30.796] Build status: SCHEDULED
[15:00:30.796] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:16:0) after 2m10s
[15:02:40.924] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:16:0)
[15:02:40.956] Build status: SCHEDULED
[15:02:40.956] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:17:0) after 2m22s
[15:05:02.978] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:17:0)
[15:05:03.011] Build status: SCHEDULED
[15:05:03.011] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:18:0) after 5m53s
[15:10:56.129] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:18:0)
[15:10:56.166] Build status: SCHEDULED
[15:10:56.167] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:19:0) after 2m40s
[15:13:36.255] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:19:0)
[15:13:36.288] Build status: SCHEDULED
[15:13:36.288] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:20:0) after 8m20s
[15:21:56.435] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:20:0)
[15:21:56.466] Build status: SCHEDULED
[15:21:56.466] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:21:0) after 2m54s
[15:24:51.034] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:21:0)
[15:24:51.067] Build status: SCHEDULED
[15:24:51.067] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:22:0) after 3m37s
[15:28:28.136] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:22:0)
[15:28:28.169] Build status: SCHEDULED
[15:28:28.169] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:23:0) after 6m5s
[15:34:33.190] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:23:0)
[15:34:33.210] Build status: SCHEDULED
[15:34:33.210] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:24:0) after 4m15s
[15:38:48.568] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:24:0)
[15:38:48.639] Build status: SCHEDULED
[15:38:48.639] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:25:0) after 8m47s
[15:47:35.715] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:25:0)
[15:47:35.737] Build status: SCHEDULED
[15:47:35.737] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:26:0) after 9m39s
[15:57:15.044] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:26:0)
[15:57:15.069] Build status: SCHEDULED
[15:57:15.069] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:27:0) after 1m58s
[15:59:13.131] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:27:0)
[15:59:13.177] Build status: SCHEDULED
[15:59:13.177] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:28:0) after 6m29s
[16:05:42.196] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:28:0)
[16:05:42.219] Build status: SCHEDULED
[16:05:42.219] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:29:0) after 4m4s
[16:09:46.346] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:29:0)
[16:09:46.376] Build status: SCHEDULED
[16:09:46.376] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:30:0) after 6m48s
[16:10:57.717] Received PubSub notification, asking Buildbucket for the build status
[16:10:57.746] Build status: STARTED
[16:16:34.404] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:30:0)
[16:16:34.434] Build status: STARTED
[16:16:34.434] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:32:0) after 5m1s
[16:21:35.478] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:32:0)
[16:21:35.509] Build status: STARTED
[16:21:35.509] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:33:0) after 6m40s
[16:28:15.705] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:33:0)
[16:28:15.746] Build status: STARTED
[16:28:15.746] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:34:0) after 2m47s
[16:31:02.768] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:34:0)
[16:31:02.789] Build status: STARTED
[16:31:02.790] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Mac64:8979794961961789152:35:0) after 2m9s
[16:32:48.426] Received PubSub notification, asking Buildbucket for the build status
[16:32:48.446] Build:
{
"id": "8814364899978202097",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Mac64"
},
"number": 480,
"createdBy": "project:v8",
"createTime": "2022-05-12T13:53:21.666827335Z",
"startTime": "2022-05-12T16:10:53.839891Z",
"endTime": "2022-05-12T16:32:48.092087701Z",
"updateTime": "2022-05-12T16:32:48.092087701Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "b0cb349e88900b7f027620cc3539f179d6a4d08f",
"ref": "refs/branch-heads/10.3"
}
}
}
[16:32:48.446] Invocation finished in 2h39m28.056050742s with status SUCCEEDED