[15:08:40.656] New invocation is queued and will start shortly
[15:08:40.656] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[15:08:41.823] Starting the invocation (attempt 1)
[15:08:41.855] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/9d410faaeb2d6520b484965eaea33cabc4447e61"
[15:08:41.855] Reconstructed gitiles commit from tags
[15:08:41.855] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:08:41.855] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:08:41.856] Buildbucket request:
{
"requestId": "8994466930692816784",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Linux64 ASAN"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"buildbucket": {
"properties": {
"newest_gitiles_revision": "9d410faaeb2d6520b484965eaea33cabc4447e61",
"oldest_gitiles_revision": "9d410faaeb2d6520b484965eaea33cabc4447e61",
"parent_build": "https://cr-buildbucket.appspot.com/build/8829038871325980657",
"parent_buildername": "V8 Linux64 ASAN - builder",
"parent_gn_args": [
"dcheck_always_on = false",
"is_asan = true",
"is_clang = true",
"is_component_build = false",
"is_debug = false",
"is_lsan = true",
"target_cpu = \"x64\"",
"use_goma = true",
"v8_enable_google_benchmark = true",
"v8_enable_test_features = true"
],
"parent_got_revision": "9d410faaeb2d6520b484965eaea33cabc4447e61",
"parent_got_revision_cp": "refs/branch-heads/9.7@{#29}",
"parent_test_spec": {
"swarming_dimensions": {
"os": "Ubuntu-18.04"
},
"swarming_task_attrs": {
},
"tests": [
[
"test262",
5,
null,
"",
[
],
{
},
{
}
],
[
"v8testing",
2,
null,
"",
[
],
{
},
{
}
],
[
"v8testing",
2,
"extra",
"extra",
[
],
{
},
{
}
],
[
"v8testing",
1,
"slow_path",
"slow_path",
[
],
{
},
{
}
]
]
},
"revision": "9d410faaeb2d6520b484965eaea33cabc4447e61",
"swarm_hashes": {
"bot_default": "e38d2165c4a75a9508506d496f714e330e8bc116dd0ad2874074046d76035bc6/404",
"test262": "dac7208330b354065b96618ff84c0d26c70af64b87be64572ae201641785baef/403"
}
},
"tags": [
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/9d410faaeb2d6520b484965eaea33cabc4447e61",
"gitiles_ref:refs/branch-heads/9.7",
"parent_buildername:V8 Linux64 ASAN - builder",
"parent_buildnumber:20",
"user_agent:recipe"
]
},
"id": "2e852023-72d8-4652-bbff-cb2bf2afe143",
"title": "V8 Linux64 ASAN - builder/20"
}
]
},
"newest_gitiles_revision": "9d410faaeb2d6520b484965eaea33cabc4447e61",
"oldest_gitiles_revision": "9d410faaeb2d6520b484965eaea33cabc4447e61",
"parent_build": "https://cr-buildbucket.appspot.com/build/8829038871325980657",
"parent_buildername": "V8 Linux64 ASAN - builder",
"parent_gn_args": [
"dcheck_always_on = false",
"is_asan = true",
"is_clang = true",
"is_component_build = false",
"is_debug = false",
"is_lsan = true",
"target_cpu = \"x64\"",
"use_goma = true",
"v8_enable_google_benchmark = true",
"v8_enable_test_features = true"
],
"parent_got_revision": "9d410faaeb2d6520b484965eaea33cabc4447e61",
"parent_got_revision_cp": "refs/branch-heads/9.7@{#29}",
"parent_test_spec": {
"swarming_dimensions": {
"os": "Ubuntu-18.04"
},
"swarming_task_attrs": {
},
"tests": [
[
"test262",
5,
null,
"",
[
],
{
},
{
}
],
[
"v8testing",
2,
null,
"",
[
],
{
},
{
}
],
[
"v8testing",
2,
"extra",
"extra",
[
],
{
},
{
}
],
[
"v8testing",
1,
"slow_path",
"slow_path",
[
],
{
},
{
}
]
]
},
"swarm_hashes": {
"bot_default": "e38d2165c4a75a9508506d496f714e330e8bc116dd0ad2874074046d76035bc6/404",
"test262": "dac7208330b354065b96618ff84c0d26c70af64b87be64572ae201641785baef/403"
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "9d410faaeb2d6520b484965eaea33cabc4447e61",
"ref": "refs/branch-heads/9.7"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8994466930692816784"
},
{
"key": "scheduler_job_id",
"value": "v8/ci.br.beta-V8 Linux64 ASAN"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "V8 Linux64 ASAN - builder"
},
{
"key": "parent_buildnumber",
"value": "20"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:08:42.560] Scheduled build:
{
"id": "8829036868640919393",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Linux64 ASAN"
},
"number": 408,
"createdBy": "project:v8",
"createTime": "2021-12-01T15:08:41.981502532Z",
"updateTime": "2021-12-01T15:08:41.981502532Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "9d410faaeb2d6520b484965eaea33cabc4447e61",
"ref": "refs/branch-heads/9.7"
}
}
}
[15:08:42.560] Task URL: https://cr-buildbucket.appspot.com/build/8829036868640919393
[15:08:42.560] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:2:0) after 7m50s
[15:16:32.614] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:2:0)
[15:16:32.642] Build status: SCHEDULED
[15:16:32.642] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:3:0) after 4m46s
[15:21:18.674] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:3:0)
[15:21:18.721] Build status: SCHEDULED
[15:21:18.721] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:4:0) after 2m38s
[15:23:56.870] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:4:0)
[15:23:56.901] Build status: SCHEDULED
[15:23:56.901] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:5:0) after 6m58s
[15:30:55.374] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:5:0)
[15:30:55.408] Build status: SCHEDULED
[15:30:55.408] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:6:0) after 3m49s
[15:34:44.529] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:6:0)
[15:34:44.582] Build status: SCHEDULED
[15:34:44.582] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:7:0) after 2m7s
[15:36:51.802] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:7:0)
[15:36:51.837] Build status: SCHEDULED
[15:36:51.837] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:8:0) after 8m14s
[15:45:06.043] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:8:0)
[15:45:06.077] Build status: SCHEDULED
[15:45:06.077] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:9:0) after 7m1s
[15:52:07.095] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:9:0)
[15:52:07.128] Build status: SCHEDULED
[15:52:07.128] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:10:0) after 2m20s
[15:54:27.227] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:10:0)
[15:54:27.256] Build status: SCHEDULED
[15:54:27.256] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:11:0) after 8m25s
[16:02:52.717] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:11:0)
[16:02:52.783] Build status: SCHEDULED
[16:02:52.783] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:12:0) after 4m14s
[16:07:07.045] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:12:0)
[16:07:07.113] Build status: SCHEDULED
[16:07:07.113] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:13:0) after 8m27s
[16:15:34.136] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:13:0)
[16:15:34.214] Build status: SCHEDULED
[16:15:34.214] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:14:0) after 3m39s
[16:19:13.441] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:14:0)
[16:19:13.469] Build status: SCHEDULED
[16:19:13.469] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:15:0) after 8m13s
[16:27:26.466] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:15:0)
[16:27:26.542] Build status: SCHEDULED
[16:27:26.542] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:16:0) after 7m39s
[16:35:05.630] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:16:0)
[16:35:05.681] Build status: SCHEDULED
[16:35:05.682] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:17:0) after 3m30s
[16:38:35.748] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:17:0)
[16:38:35.784] Build status: SCHEDULED
[16:38:35.784] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:18:0) after 9m45s
[16:48:20.852] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:18:0)
[16:48:20.883] Build status: SCHEDULED
[16:48:20.883] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:19:0) after 7m11s
[16:55:31.986] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:19:0)
[16:55:32.022] Build status: SCHEDULED
[16:55:32.022] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:20:0) after 1m49s
[16:57:21.180] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:20:0)
[16:57:21.212] Build status: SCHEDULED
[16:57:21.212] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:21:0) after 4m55s
[17:02:16.468] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:21:0)
[17:02:16.500] Build status: SCHEDULED
[17:02:16.500] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:22:0) after 9m51s
[17:12:07.533] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:22:0)
[17:12:07.573] Build status: SCHEDULED
[17:12:07.573] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:23:0) after 1m1s
[17:13:08.742] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:23:0)
[17:13:08.840] Build status: SCHEDULED
[17:13:08.840] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:24:0) after 7m2s
[17:20:10.971] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:24:0)
[17:20:11.007] Build status: SCHEDULED
[17:20:11.007] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:25:0) after 3m24s
[17:23:35.030] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:25:0)
[17:23:35.065] Build status: SCHEDULED
[17:23:35.065] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:26:0) after 6m39s
[17:30:14.230] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:26:0)
[17:30:14.290] Build status: SCHEDULED
[17:30:14.290] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:27:0) after 9m30s
[17:39:44.354] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:27:0)
[17:39:44.389] Build status: SCHEDULED
[17:39:44.389] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:28:0) after 1m4s
[17:40:48.885] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:28:0)
[17:40:48.915] Build status: SCHEDULED
[17:40:48.915] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:29:0) after 8m45s
[17:49:34.192] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:29:0)
[17:49:34.277] Build status: SCHEDULED
[17:49:34.277] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:30:0) after 9m15s
[17:58:49.317] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:30:0)
[17:58:49.389] Build status: SCHEDULED
[17:58:49.389] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:31:0) after 7m21s
[18:06:10.479] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:31:0)
[18:06:10.569] Build status: SCHEDULED
[18:06:10.569] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:32:0) after 3m54s
[18:10:04.557] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:32:0)
[18:10:04.598] Build status: SCHEDULED
[18:10:04.598] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:33:0) after 4m24s
[18:14:28.665] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:33:0)
[18:14:28.697] Build status: SCHEDULED
[18:14:28.697] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:34:0) after 8m2s
[18:22:30.737] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:34:0)
[18:22:30.768] Build status: SCHEDULED
[18:22:30.768] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:35:0) after 3m12s
[18:25:42.913] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:35:0)
[18:25:42.944] Build status: SCHEDULED
[18:25:42.944] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:36:0) after 6m19s
[18:32:02.308] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:36:0)
[18:32:02.385] Build status: SCHEDULED
[18:32:02.385] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:37:0) after 4m4s
[18:36:06.411] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:37:0)
[18:36:06.453] Build status: SCHEDULED
[18:36:06.453] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:38:0) after 6m20s
[18:39:04.861] Received PubSub notification, asking Buildbucket for the build status
[18:39:05.066] Build status: STARTED
[18:42:26.584] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:38:0)
[18:42:26.639] Build status: STARTED
[18:42:26.639] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:40:0) after 4m3s
[18:46:30.104] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:40:0)
[18:46:30.139] Build status: STARTED
[18:46:30.139] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:41:0) after 7m24s
[18:53:54.220] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:41:0)
[18:53:54.287] Build status: STARTED
[18:53:54.287] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:42:0) after 3m24s
[18:57:18.680] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:42:0)
[18:57:18.711] Build status: STARTED
[18:57:18.711] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:43:0) after 3m33s
[19:00:52.486] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:43:0)
[19:00:52.526] Build status: STARTED
[19:00:52.526] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:44:0) after 6m24s
[19:07:16.562] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:44:0)
[19:07:16.599] Build status: STARTED
[19:07:16.599] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:45:0) after 1m51s
[19:09:07.979] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:45:0)
[19:09:08.017] Build status: STARTED
[19:09:08.017] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:46:0) after 5m32s
[19:14:40.143] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:46:0)
[19:14:40.180] Build status: STARTED
[19:14:40.180] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 ASAN:8994466930692816784:47:0) after 9m56s
[19:21:29.106] Received PubSub notification, asking Buildbucket for the build status
[19:21:29.193] Build:
{
"id": "8829036868640919393",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Linux64 ASAN"
},
"number": 408,
"createdBy": "project:v8",
"createTime": "2021-12-01T15:08:41.981502532Z",
"startTime": "2021-12-01T18:39:01.195724Z",
"endTime": "2021-12-01T19:21:28.770261679Z",
"updateTime": "2021-12-01T19:21:28.770261679Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "9d410faaeb2d6520b484965eaea33cabc4447e61",
"ref": "refs/branch-heads/9.7"
}
}
}
[19:21:29.193] Invocation finished in 4h12m48.553105492s with status SUCCEEDED