[15:05:20.247] New invocation is queued and will start shortly
[15:05:20.247] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[15:05:21.345] Starting the invocation (attempt 1)
[15:05:21.389] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/d0111b6c7b782cb6c33ea3d03bedf7f8e5f423fe"
[15:05:21.389] Reconstructed gitiles commit from tags
[15:05:21.389] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:05:21.389] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:05:21.390] Buildbucket request:
{
"requestId": "8962939396528183472",
"builder": {
"project": "v8",
"bucket": "ci.br.extended",
"builder": "V8 Win64 ASAN"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8962939396528183472",
"job": "v8/ci.br.extended-V8 Win64 ASAN",
"triggers": [
{
"buildbucket": {
"properties": {
"newest_gitiles_revision": "d0111b6c7b782cb6c33ea3d03bedf7f8e5f423fe",
"oldest_gitiles_revision": "d0111b6c7b782cb6c33ea3d03bedf7f8e5f423fe",
"parent_build": "https://cr-buildbucket.appspot.com/build/8797510001291059089",
"parent_buildername": "V8 Win64 ASAN - builder",
"parent_gn_args": [
"dcheck_always_on = false",
"is_asan = true",
"is_clang = true",
"is_component_build = false",
"is_debug = false",
"target_cpu = \"x64\"",
"use_goma = false",
"use_remoteexec = true",
"v8_enable_google_benchmark = true",
"v8_enable_sandbox = true",
"v8_enable_test_features = true"
],
"parent_got_revision": "d0111b6c7b782cb6c33ea3d03bedf7f8e5f423fe",
"parent_got_revision_cp": "refs/branch-heads/10.8@{#36}",
"parent_test_spec": {
"swarming_dimensions": {
"os": "Windows-10-19042"
},
"swarming_task_attrs": {
},
"tests": [
[
"v8testing",
5,
null,
"",
[
],
{
},
{
}
]
]
},
"revision": "d0111b6c7b782cb6c33ea3d03bedf7f8e5f423fe",
"swarm_hashes": {
"bot_default": "dec6464f47c7e174ac4a7b3d83890d028ee43726a80726cea59ea9eae157a1ef/405"
}
},
"tags": [
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/d0111b6c7b782cb6c33ea3d03bedf7f8e5f423fe",
"gitiles_ref:refs/branch-heads/10.8",
"parent_buildername:V8 Win64 ASAN - builder",
"parent_buildnumber:118",
"user_agent:recipe"
]
},
"id": "ab85baf6-a296-465c-ab34-bff7426d5b36",
"title": "V8 Win64 ASAN - builder/118"
}
]
},
"newest_gitiles_revision": "d0111b6c7b782cb6c33ea3d03bedf7f8e5f423fe",
"oldest_gitiles_revision": "d0111b6c7b782cb6c33ea3d03bedf7f8e5f423fe",
"parent_build": "https://cr-buildbucket.appspot.com/build/8797510001291059089",
"parent_buildername": "V8 Win64 ASAN - builder",
"parent_gn_args": [
"dcheck_always_on = false",
"is_asan = true",
"is_clang = true",
"is_component_build = false",
"is_debug = false",
"target_cpu = \"x64\"",
"use_goma = false",
"use_remoteexec = true",
"v8_enable_google_benchmark = true",
"v8_enable_sandbox = true",
"v8_enable_test_features = true"
],
"parent_got_revision": "d0111b6c7b782cb6c33ea3d03bedf7f8e5f423fe",
"parent_got_revision_cp": "refs/branch-heads/10.8@{#36}",
"parent_test_spec": {
"swarming_dimensions": {
"os": "Windows-10-19042"
},
"swarming_task_attrs": {
},
"tests": [
[
"v8testing",
5,
null,
"",
[
],
{
},
{
}
]
]
},
"swarm_hashes": {
"bot_default": "dec6464f47c7e174ac4a7b3d83890d028ee43726a80726cea59ea9eae157a1ef/405"
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "d0111b6c7b782cb6c33ea3d03bedf7f8e5f423fe",
"ref": "refs/branch-heads/10.8"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8962939396528183472"
},
{
"key": "scheduler_job_id",
"value": "v8/ci.br.extended-V8 Win64 ASAN"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "V8 Win64 ASAN - builder"
},
{
"key": "parent_buildnumber",
"value": "118"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:05:21.996] Scheduled build:
{
"id": "8797509334576556673",
"builder": {
"project": "v8",
"bucket": "ci.br.extended",
"builder": "V8 Win64 ASAN"
},
"number": 142,
"createdBy": "project:v8",
"createTime": "2022-11-14T15:05:21.478070137Z",
"updateTime": "2022-11-14T15:05:21.478070137Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "d0111b6c7b782cb6c33ea3d03bedf7f8e5f423fe",
"ref": "refs/branch-heads/10.8"
}
},
"canary": true
}
[15:05:21.996] Task URL: https://cr-buildbucket.appspot.com/build/8797509334576556673
[15:05:21.996] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:2:0) after 3m3s
[15:08:25.024] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:2:0)
[15:08:25.067] Build status: SCHEDULED
[15:08:25.067] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:3:0) after 9m51s
[15:18:16.103] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:3:0)
[15:18:16.154] Build status: SCHEDULED
[15:18:16.154] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:4:0) after 1m14s
[15:19:30.174] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:4:0)
[15:19:30.229] Build status: SCHEDULED
[15:19:30.229] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:5:0) after 5m32s
[15:25:02.258] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:5:0)
[15:25:02.287] Build status: SCHEDULED
[15:25:02.287] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:6:0) after 3m49s
[15:28:51.309] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:6:0)
[15:28:51.337] Build status: SCHEDULED
[15:28:51.337] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:7:0) after 9m38s
[15:38:29.421] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:7:0)
[15:38:29.486] Build status: SCHEDULED
[15:38:29.486] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:8:0) after 6m10s
[15:44:39.997] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:8:0)
[15:44:40.038] Build status: SCHEDULED
[15:44:40.038] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:9:0) after 7m52s
[15:52:32.164] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:9:0)
[15:52:32.199] Build status: SCHEDULED
[15:52:32.199] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:10:0) after 5m40s
[15:58:12.270] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:10:0)
[15:58:12.348] Build status: SCHEDULED
[15:58:12.348] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:11:0) after 9m24s
[16:07:36.411] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:11:0)
[16:07:36.436] Build status: SCHEDULED
[16:07:36.436] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:12:0) after 5m26s
[16:13:03.153] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:12:0)
[16:13:03.179] Build status: SCHEDULED
[16:13:03.179] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:13:0) after 6m4s
[16:19:07.167] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:13:0)
[16:19:07.225] Build status: SCHEDULED
[16:19:07.225] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:14:0) after 9m27s
[16:28:34.255] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:14:0)
[16:28:34.283] Build status: SCHEDULED
[16:28:34.283] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:15:0) after 1m29s
[16:30:03.356] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:15:0)
[16:30:03.387] Build status: SCHEDULED
[16:30:03.387] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:16:0) after 6m35s
[16:36:38.484] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:16:0)
[16:36:38.516] Build status: SCHEDULED
[16:36:38.516] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:17:0) after 1m24s
[16:38:02.556] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:17:0)
[16:38:02.583] Build status: SCHEDULED
[16:38:02.583] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:18:0) after 1m44s
[16:39:46.767] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:18:0)
[16:39:46.799] Build status: SCHEDULED
[16:39:46.799] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:19:0) after 2m54s
[16:42:41.013] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:19:0)
[16:42:41.045] Build status: SCHEDULED
[16:42:41.045] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:20:0) after 4m57s
[16:47:38.084] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:20:0)
[16:47:38.126] Build status: SCHEDULED
[16:47:38.126] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:21:0) after 8m16s
[16:55:54.205] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:21:0)
[16:55:54.231] Build status: SCHEDULED
[16:55:54.231] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:22:0) after 5m38s
[17:01:32.350] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:22:0)
[17:01:32.376] Build status: SCHEDULED
[17:01:32.377] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:23:0) after 6m20s
[17:07:52.664] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:23:0)
[17:07:52.732] Build status: SCHEDULED
[17:07:52.733] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:24:0) after 8m29s
[17:16:21.758] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:24:0)
[17:16:21.783] Build status: SCHEDULED
[17:16:21.783] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:25:0) after 2m58s
[17:19:20.207] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:25:0)
[17:19:20.248] Build status: SCHEDULED
[17:19:20.248] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:26:0) after 7m14s
[17:26:34.282] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:26:0)
[17:26:34.305] Build status: SCHEDULED
[17:26:34.305] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:27:0) after 1m30s
[17:28:04.339] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:27:0)
[17:28:04.367] Build status: SCHEDULED
[17:28:04.367] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:28:0) after 8m14s
[17:36:18.406] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:28:0)
[17:36:18.437] Build status: SCHEDULED
[17:36:18.437] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:29:0) after 6m15s
[17:42:33.519] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:29:0)
[17:42:33.543] Build status: SCHEDULED
[17:42:33.543] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:30:0) after 7m5s
[17:49:38.567] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:30:0)
[17:49:38.592] Build status: SCHEDULED
[17:49:38.592] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:31:0) after 9m1s
[17:58:39.723] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:31:0)
[17:58:39.753] Build status: SCHEDULED
[17:58:39.753] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:32:0) after 5m30s
[18:04:09.940] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:32:0)
[18:04:09.981] Build status: SCHEDULED
[18:04:09.981] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:33:0) after 1m27s
[18:05:37.056] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:33:0)
[18:05:37.086] Build status: SCHEDULED
[18:05:37.086] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:34:0) after 9m48s
[18:15:25.395] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:34:0)
[18:15:25.475] Build status: SCHEDULED
[18:15:25.475] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:35:0) after 5m31s
[18:20:56.573] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:35:0)
[18:20:56.600] Build status: SCHEDULED
[18:20:56.600] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:36:0) after 7m27s
[18:28:23.694] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:36:0)
[18:28:23.771] Build status: SCHEDULED
[18:28:23.771] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:37:0) after 6m27s
[18:34:50.998] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:37:0)
[18:34:51.026] Build status: SCHEDULED
[18:34:51.026] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:38:0) after 7m10s
[18:42:01.016] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:38:0)
[18:42:01.041] Build status: SCHEDULED
[18:42:01.042] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:39:0) after 9m42s
[18:51:43.102] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:39:0)
[18:51:43.145] Build status: SCHEDULED
[18:51:43.145] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:40:0) after 6m2s
[18:56:54.163] Received PubSub notification, asking Buildbucket for the build status
[18:56:54.189] Build status: STARTED
[18:57:45.169] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:40:0)
[18:57:45.193] Build status: STARTED
[18:57:45.193] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:42:0) after 5m38s
[19:03:23.302] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:42:0)
[19:03:23.324] Build status: STARTED
[19:03:23.324] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:43:0) after 5m19s
[19:08:42.357] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:43:0)
[19:08:42.386] Build status: STARTED
[19:08:42.386] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:44:0) after 4m40s
[19:13:22.427] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:44:0)
[19:13:22.452] Build status: STARTED
[19:13:22.452] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:45:0) after 1m14s
[19:14:36.593] Handling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:45:0)
[19:14:36.619] Build status: STARTED
[19:14:36.619] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.extended-V8 Win64 ASAN:8962939396528183472:46:0) after 8m39s
[19:21:25.659] Received PubSub notification, asking Buildbucket for the build status
[19:21:25.696] Build:
{
"id": "8797509334576556673",
"builder": {
"project": "v8",
"bucket": "ci.br.extended",
"builder": "V8 Win64 ASAN"
},
"number": 142,
"createdBy": "project:v8",
"createTime": "2022-11-14T15:05:21.478070137Z",
"startTime": "2022-11-14T18:56:53.603288Z",
"endTime": "2022-11-14T19:21:25.397831750Z",
"updateTime": "2022-11-14T19:21:25.397831750Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "d0111b6c7b782cb6c33ea3d03bedf7f8e5f423fe",
"ref": "refs/branch-heads/10.8"
}
},
"canary": true
}
[19:21:25.696] Invocation finished in 4h16m5.462891621s with status SUCCEEDED