[11:56:37.300] New invocation is queued and will start shortly
[11:56:37.300] Triggered by user:v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[11:56:38.722] Starting the invocation (attempt 1)
[11:56:38.766] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/de6858e30ccc64cfbd9fc92ffc086d3765cb0bbc"
[11:56:38.766] Reconstructed gitiles commit from tags
[11:56:38.766] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:56:38.766] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:56:38.766] Buildbucket request:
{
"requestId": "8967843505691706848",
"builder": {
"project": "v8",
"bucket": "ci.br.stable",
"builder": "V8 Linux64 - debug - header includes"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8967843505691706848",
"job": "v8/ci.br.stable-V8 Linux64 - debug - header includes",
"triggers": [
{
"buildbucket": {
"properties": {
"newest_gitiles_revision": "de6858e30ccc64cfbd9fc92ffc086d3765cb0bbc",
"oldest_gitiles_revision": "de6858e30ccc64cfbd9fc92ffc086d3765cb0bbc",
"parent_build": "https://cr-buildbucket.appspot.com/build/8802413838491586049",
"parent_buildername": "V8 Linux64 - debug - header includes - builder",
"parent_gn_args": [
"is_component_build = true",
"is_debug = true",
"target_cpu = \"x64\"",
"use_goma = false",
"use_remoteexec = true",
"v8_check_header_includes = true",
"v8_enable_backtrace = true",
"v8_enable_google_benchmark = true",
"v8_enable_sandbox = true",
"v8_enable_slow_dchecks = true"
],
"parent_got_revision": "de6858e30ccc64cfbd9fc92ffc086d3765cb0bbc",
"parent_got_revision_cp": "refs/branch-heads/10.6@{#23}",
"revision": "de6858e30ccc64cfbd9fc92ffc086d3765cb0bbc"
},
"tags": [
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/de6858e30ccc64cfbd9fc92ffc086d3765cb0bbc",
"gitiles_ref:refs/branch-heads/10.6",
"parent_buildername:V8 Linux64 - debug - header includes - builder",
"parent_buildnumber:104",
"user_agent:recipe"
]
},
"id": "fe39a3fd-ba7f-4048-82f0-093b16132148",
"title": "V8 Linux64 - debug - header includes - builder/104"
}
]
},
"newest_gitiles_revision": "de6858e30ccc64cfbd9fc92ffc086d3765cb0bbc",
"oldest_gitiles_revision": "de6858e30ccc64cfbd9fc92ffc086d3765cb0bbc",
"parent_build": "https://cr-buildbucket.appspot.com/build/8802413838491586049",
"parent_buildername": "V8 Linux64 - debug - header includes - builder",
"parent_gn_args": [
"is_component_build = true",
"is_debug = true",
"target_cpu = \"x64\"",
"use_goma = false",
"use_remoteexec = true",
"v8_check_header_includes = true",
"v8_enable_backtrace = true",
"v8_enable_google_benchmark = true",
"v8_enable_sandbox = true",
"v8_enable_slow_dchecks = true"
],
"parent_got_revision": "de6858e30ccc64cfbd9fc92ffc086d3765cb0bbc",
"parent_got_revision_cp": "refs/branch-heads/10.6@{#23}"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "de6858e30ccc64cfbd9fc92ffc086d3765cb0bbc",
"ref": "refs/branch-heads/10.6"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8967843505691706848"
},
{
"key": "scheduler_job_id",
"value": "v8/ci.br.stable-V8 Linux64 - debug - header includes"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "V8 Linux64 - debug - header includes - builder"
},
{
"key": "parent_buildnumber",
"value": "104"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[11:56:39.861] Scheduled build:
{
"id": "8802413443378420977",
"builder": {
"project": "v8",
"bucket": "ci.br.stable",
"builder": "V8 Linux64 - debug - header includes"
},
"number": 319,
"createdBy": "project:v8",
"createTime": "2022-09-21T11:56:38.868889355Z",
"updateTime": "2022-09-21T11:56:38.868889355Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "de6858e30ccc64cfbd9fc92ffc086d3765cb0bbc",
"ref": "refs/branch-heads/10.6"
}
},
"canary": true
}
[11:56:39.861] Task URL: https://cr-buildbucket.appspot.com/build/8802413443378420977
[11:56:39.861] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:2:0) after 8m11s
[12:04:50.877] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:2:0)
[12:04:50.927] Build status: SCHEDULED
[12:04:50.927] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:3:0) after 7m16s
[12:12:07.048] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:3:0)
[12:12:07.076] Build status: SCHEDULED
[12:12:07.076] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:4:0) after 6m48s
[12:18:55.201] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:4:0)
[12:18:55.230] Build status: SCHEDULED
[12:18:55.230] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:5:0) after 1m30s
[12:20:25.252] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:5:0)
[12:20:25.282] Build status: SCHEDULED
[12:20:25.283] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:6:0) after 9m6s
[12:29:31.572] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:6:0)
[12:29:31.634] Build status: SCHEDULED
[12:29:31.634] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:7:0) after 2m12s
[12:31:44.030] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:7:0)
[12:31:44.060] Build status: SCHEDULED
[12:31:44.060] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:8:0) after 8m41s
[12:40:25.100] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:8:0)
[12:40:25.253] Build status: SCHEDULED
[12:40:25.253] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:9:0) after 4m17s
[12:44:42.844] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:9:0)
[12:44:42.872] Build status: SCHEDULED
[12:44:42.872] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:10:0) after 7m11s
[12:51:53.908] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:10:0)
[12:51:53.939] Build status: SCHEDULED
[12:51:53.939] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:11:0) after 5m8s
[12:57:02.051] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:11:0)
[12:57:02.081] Build status: SCHEDULED
[12:57:02.081] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:12:0) after 6m19s
[13:03:21.333] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:12:0)
[13:03:21.423] Build status: SCHEDULED
[13:03:21.423] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:13:0) after 5m43s
[13:09:04.583] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:13:0)
[13:09:04.632] Build status: SCHEDULED
[13:09:04.633] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:14:0) after 8m22s
[13:17:26.894] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:14:0)
[13:17:26.931] Build status: SCHEDULED
[13:17:26.931] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:15:0) after 7m46s
[13:25:13.248] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:15:0)
[13:25:13.424] Build status: SCHEDULED
[13:25:13.424] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:16:0) after 9m54s
[13:35:07.444] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:16:0)
[13:35:07.474] Build status: SCHEDULED
[13:35:07.474] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:17:0) after 9m3s
[13:44:10.499] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:17:0)
[13:44:10.558] Build status: SCHEDULED
[13:44:10.558] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:18:0) after 3m13s
[13:47:23.603] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:18:0)
[13:47:23.666] Build status: SCHEDULED
[13:47:23.666] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:19:0) after 4m32s
[13:51:55.690] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:19:0)
[13:51:55.721] Build status: SCHEDULED
[13:51:55.721] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:20:0) after 7m55s
[13:59:51.052] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:20:0)
[13:59:51.078] Build status: SCHEDULED
[13:59:51.078] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:21:0) after 8m6s
[14:07:57.099] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:21:0)
[14:07:57.132] Build status: SCHEDULED
[14:07:57.132] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:22:0) after 1m15s
[14:09:12.184] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:22:0)
[14:09:12.212] Build status: SCHEDULED
[14:09:12.212] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:23:0) after 3m13s
[14:12:25.277] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:23:0)
[14:12:25.310] Build status: SCHEDULED
[14:12:25.310] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:24:0) after 1m13s
[14:13:38.333] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:24:0)
[14:13:38.362] Build status: SCHEDULED
[14:13:38.362] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:25:0) after 1m11s
[14:14:50.038] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:25:0)
[14:14:50.082] Build status: SCHEDULED
[14:14:50.082] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:26:0) after 7m16s
[14:22:06.102] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:26:0)
[14:22:06.128] Build status: SCHEDULED
[14:22:06.128] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:27:0) after 9m2s
[14:31:08.238] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:27:0)
[14:31:08.265] Build status: SCHEDULED
[14:31:08.265] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:28:0) after 7m19s
[14:38:27.313] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:28:0)
[14:38:27.346] Build status: SCHEDULED
[14:38:27.346] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:29:0) after 2m50s
[14:41:17.452] Handling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:29:0)
[14:41:17.506] Build status: SCHEDULED
[14:41:17.506] Scheduling timer "check-buildbucket-build-status" (v8/ci.br.stable-V8 Linux64 - debug - header includes:8967843505691706848:30:0) after 8m25s
[14:41:56.046] Received PubSub notification, asking Buildbucket for the build status
[14:41:56.072] Build status: STARTED
[14:42:53.449] Received PubSub notification, asking Buildbucket for the build status
[14:42:53.476] Build:
{
"id": "8802413443378420977",
"builder": {
"project": "v8",
"bucket": "ci.br.stable",
"builder": "V8 Linux64 - debug - header includes"
},
"number": 319,
"createdBy": "project:v8",
"createTime": "2022-09-21T11:56:38.868889355Z",
"startTime": "2022-09-21T14:41:55.278139Z",
"endTime": "2022-09-21T14:42:52.967807362Z",
"updateTime": "2022-09-21T14:42:52.967807362Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "de6858e30ccc64cfbd9fc92ffc086d3765cb0bbc",
"ref": "refs/branch-heads/10.6"
}
},
"canary": true
}
[14:42:53.476] Invocation finished in 2h46m16.19670093s with status SUCCEEDED