[07:19:01.153] New invocation is queued and will start shortly
[07:19:01.153] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[07:19:02.229] Starting the invocation (attempt 1)
[07:19:02.297] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/bd997a77ae2137076f05352b09729f3a41af5739"
[07:19:02.297] Reconstructed gitiles commit from tags
[07:19:02.297] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:19:02.297] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:19:02.297] Buildbucket request:
{
"requestId": "8983081261276451440",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Linux64 - verify csa"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"buildbucket": {
"properties": {
"newest_gitiles_revision": "bd997a77ae2137076f05352b09729f3a41af5739",
"oldest_gitiles_revision": "bd997a77ae2137076f05352b09729f3a41af5739",
"parent_build": "https://cr-buildbucket.appspot.com/build/8817651552451255441",
"parent_buildername": "V8 Linux64 - verify csa - builder",
"parent_gn_args": [
"dcheck_always_on = true",
"is_component_build = false",
"is_debug = false",
"target_cpu = \"x64\"",
"use_goma = true",
"v8_enable_google_benchmark = true",
"v8_enable_slow_dchecks = true",
"v8_enable_verify_csa = true"
],
"parent_got_revision": "bd997a77ae2137076f05352b09729f3a41af5739",
"parent_got_revision_cp": "refs/branch-heads/10.1@{#17}",
"parent_test_spec": {
"swarming_dimensions": {
"os": "Ubuntu-18.04"
},
"swarming_task_attrs": {
},
"tests": [
[
"v8testing",
1,
null,
"",
[
],
{
},
{
}
]
]
},
"revision": "bd997a77ae2137076f05352b09729f3a41af5739",
"swarm_hashes": {
"bot_default": "265ca0499d14529f8e1113ef55f3151c6cbae9931d216f28d02e783a4c01a998/319"
}
},
"tags": [
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/bd997a77ae2137076f05352b09729f3a41af5739",
"gitiles_ref:refs/branch-heads/10.1",
"parent_buildername:V8 Linux64 - verify csa - builder",
"parent_buildnumber:82",
"user_agent:recipe"
]
},
"id": "df1bf481-9218-44b5-9103-f443b9408e34",
"title": "V8 Linux64 - verify csa - builder/82"
}
]
},
"newest_gitiles_revision": "bd997a77ae2137076f05352b09729f3a41af5739",
"oldest_gitiles_revision": "bd997a77ae2137076f05352b09729f3a41af5739",
"parent_build": "https://cr-buildbucket.appspot.com/build/8817651552451255441",
"parent_buildername": "V8 Linux64 - verify csa - builder",
"parent_gn_args": [
"dcheck_always_on = true",
"is_component_build = false",
"is_debug = false",
"target_cpu = \"x64\"",
"use_goma = true",
"v8_enable_google_benchmark = true",
"v8_enable_slow_dchecks = true",
"v8_enable_verify_csa = true"
],
"parent_got_revision": "bd997a77ae2137076f05352b09729f3a41af5739",
"parent_got_revision_cp": "refs/branch-heads/10.1@{#17}",
"parent_test_spec": {
"swarming_dimensions": {
"os": "Ubuntu-18.04"
},
"swarming_task_attrs": {
},
"tests": [
[
"v8testing",
1,
null,
"",
[
],
{
},
{
}
]
]
},
"swarm_hashes": {
"bot_default": "265ca0499d14529f8e1113ef55f3151c6cbae9931d216f28d02e783a4c01a998/319"
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "bd997a77ae2137076f05352b09729f3a41af5739",
"ref": "refs/branch-heads/10.1"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8983081261276451440"
},
{
"key": "scheduler_job_id",
"value": "v8/ci.br.beta-V8 Linux64 - verify csa"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "V8 Linux64 - verify csa - builder"
},
{
"key": "parent_buildnumber",
"value": "82"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:19:03.492] Scheduled build:
{
"id": "8817651199297012689",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Linux64 - verify csa"
},
"number": 475,
"createdBy": "project:v8",
"createTime": "2022-04-06T07:19:02.409786287Z",
"updateTime": "2022-04-06T07:19:02.409786287Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "bd997a77ae2137076f05352b09729f3a41af5739",
"ref": "refs/branch-heads/10.1"
}
},
"canary": true
}
[07:19:03.492] Task URL: https://cr-buildbucket.appspot.com/build/8817651199297012689
[07:19:03.492] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:2:0) after 7m30s
[07:26:33.589] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:2:0)
[07:26:33.624] Build status: SCHEDULED
[07:26:33.624] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:3:0) after 3m29s
[07:30:02.718] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:3:0)
[07:30:02.750] Build status: SCHEDULED
[07:30:02.751] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:4:0) after 8m42s
[07:38:45.124] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:4:0)
[07:38:45.156] Build status: SCHEDULED
[07:38:45.156] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:5:0) after 3m35s
[07:42:20.278] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:5:0)
[07:42:20.296] Build status: SCHEDULED
[07:42:20.296] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:6:0) after 2m48s
[07:45:08.349] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:6:0)
[07:45:08.389] Build status: SCHEDULED
[07:45:08.389] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:7:0) after 9m43s
[07:54:51.678] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:7:0)
[07:54:51.708] Build status: SCHEDULED
[07:54:51.708] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:8:0) after 6m43s
[08:01:34.745] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:8:0)
[08:01:34.779] Build status: SCHEDULED
[08:01:34.779] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:9:0) after 7m21s
[08:08:55.891] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:9:0)
[08:08:55.931] Build status: SCHEDULED
[08:08:55.931] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:10:0) after 9m36s
[08:18:31.990] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:10:0)
[08:18:32.068] Build status: SCHEDULED
[08:18:32.068] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:11:0) after 6m36s
[08:25:08.086] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:11:0)
[08:25:08.124] Build status: SCHEDULED
[08:25:08.124] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:12:0) after 6m5s
[08:31:13.144] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:12:0)
[08:31:13.184] Build status: SCHEDULED
[08:31:13.184] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:13:0) after 2m5s
[08:33:18.290] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:13:0)
[08:33:18.404] Build status: SCHEDULED
[08:33:18.404] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:14:0) after 1m8s
[08:34:26.413] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:14:0)
[08:34:26.648] Build status: SCHEDULED
[08:34:26.648] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:15:0) after 1m59s
[08:36:25.893] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:15:0)
[08:36:25.925] Build status: SCHEDULED
[08:36:25.925] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:16:0) after 1m7s
[08:37:32.944] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:16:0)
[08:37:32.977] Build status: SCHEDULED
[08:37:32.977] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:17:0) after 7m2s
[08:44:35.088] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:17:0)
[08:44:35.126] Build status: SCHEDULED
[08:44:35.126] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:18:0) after 2m26s
[08:47:01.184] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:18:0)
[08:47:01.231] Build status: SCHEDULED
[08:47:01.231] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:19:0) after 9m34s
[08:56:35.352] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:19:0)
[08:56:35.386] Build status: SCHEDULED
[08:56:35.386] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:20:0) after 5m37s
[09:02:12.406] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:20:0)
[09:02:12.434] Build status: SCHEDULED
[09:02:12.434] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:21:0) after 4m1s
[09:06:14.535] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:21:0)
[09:06:14.576] Build status: SCHEDULED
[09:06:14.576] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:22:0) after 5m22s
[09:11:36.580] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:22:0)
[09:11:36.620] Build status: SCHEDULED
[09:11:36.620] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:23:0) after 2m34s
[09:14:10.686] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:23:0)
[09:14:10.708] Build status: SCHEDULED
[09:14:10.708] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:24:0) after 3m26s
[09:17:37.212] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:24:0)
[09:17:37.242] Build status: SCHEDULED
[09:17:37.242] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:25:0) after 2m12s
[09:19:49.262] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:25:0)
[09:19:49.298] Build status: SCHEDULED
[09:19:49.298] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:26:0) after 9m57s
[09:29:46.512] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:26:0)
[09:29:46.541] Build status: SCHEDULED
[09:29:46.541] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:27:0) after 5m28s
[09:35:14.768] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:27:0)
[09:35:14.796] Build status: SCHEDULED
[09:35:14.796] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:28:0) after 1m5s
[09:36:19.835] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:28:0)
[09:36:19.877] Build status: SCHEDULED
[09:36:19.877] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:29:0) after 3m14s
[09:39:33.896] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:29:0)
[09:39:33.917] Build status: SCHEDULED
[09:39:33.917] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:30:0) after 4m44s
[09:44:18.000] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:30:0)
[09:44:18.042] Build status: SCHEDULED
[09:44:18.042] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:31:0) after 7m5s
[09:51:23.061] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:31:0)
[09:51:23.113] Build status: SCHEDULED
[09:51:23.113] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:32:0) after 1m51s
[09:53:14.241] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:32:0)
[09:53:14.273] Build status: SCHEDULED
[09:53:14.273] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:33:0) after 8m10s
[10:01:24.415] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:33:0)
[10:01:24.448] Build status: SCHEDULED
[10:01:24.448] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:34:0) after 7m50s
[10:09:14.473] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:34:0)
[10:09:14.493] Build status: SCHEDULED
[10:09:14.493] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:35:0) after 2m46s
[10:12:00.519] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:35:0)
[10:12:00.549] Build status: SCHEDULED
[10:12:00.549] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:36:0) after 7m27s
[10:19:27.574] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:36:0)
[10:19:27.598] Build status: SCHEDULED
[10:19:27.598] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:37:0) after 2m5s
[10:21:32.687] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:37:0)
[10:21:32.720] Build status: SCHEDULED
[10:21:32.720] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:38:0) after 9m8s
[10:30:40.747] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:38:0)
[10:30:40.774] Build status: SCHEDULED
[10:30:40.774] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:39:0) after 8m50s
[10:39:30.794] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:39:0)
[10:39:30.822] Build status: SCHEDULED
[10:39:30.822] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:40:0) after 9m51s
[10:49:22.236] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:40:0)
[10:49:22.317] Build status: SCHEDULED
[10:49:22.317] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:41:0) after 7m23s
[10:56:45.335] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:41:0)
[10:56:45.367] Build status: SCHEDULED
[10:56:45.367] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:42:0) after 6m48s
[10:57:41.871] Received PubSub notification, asking Buildbucket for the build status
[10:57:41.903] Build status: STARTED
[11:03:33.588] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:42:0)
[11:03:33.625] Build status: STARTED
[11:03:33.625] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:44:0) after 9m27s
[11:13:00.644] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:44:0)
[11:13:00.668] Build status: STARTED
[11:13:00.668] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:45:0) after 2m29s
[11:15:29.826] Handling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:45:0)
[11:15:29.878] Build status: STARTED
[11:15:29.878] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.beta-V8 Linux64 - verify csa:8983081261276451440:46:0) after 9m38s
[11:22:29.882] Received PubSub notification, asking Buildbucket for the build status
[11:22:29.914] Build:
{
"id": "8817651199297012689",
"builder": {
"project": "v8",
"bucket": "ci.br.beta",
"builder": "V8 Linux64 - verify csa"
},
"number": 475,
"createdBy": "project:v8",
"createTime": "2022-04-06T07:19:02.409786287Z",
"startTime": "2022-04-06T10:57:40.735952Z",
"endTime": "2022-04-06T11:22:29.398442073Z",
"updateTime": "2022-04-06T11:22:29.398442073Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "bd997a77ae2137076f05352b09729f3a41af5739",
"ref": "refs/branch-heads/10.1"
}
},
"canary": true
}
[11:22:29.914] Invocation finished in 4h3m28.775491147s with status SUCCEEDED