[07:31:52.636] New invocation is queued and will start shortly
[07:31:52.636] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[07:31:53.829] Starting the invocation (attempt 1)
[07:31:53.858] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/db777db25c31688c8e45b6aef8ed9de8541b3a72"
[07:31:53.858] Reconstructed gitiles commit from tags
[07:31:53.858] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:31:53.858] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:31:53.859] Buildbucket request:
{
"requestId": "8934158090452414352",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "2b4ce93eaee81a34e019c39057246c60f1c8fdfd7064edd29b200445b3c9204f/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "6d0c830a9d6c971bc20385c7b751113d33b7c361",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8934158090452414352",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "bbd3b806311bd8eb2f45d3e35cd7187607af93d4ef8eecdeb6ca095fb17234d0/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "cd1fb92918fe4587d06ebb4772dd4e43e7b3026f",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "da55b1b52fbce80093eee8dd4185df4861a44ba5"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/da55b1b52fbce80093eee8dd4185df4861a44ba5",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "a38bfa03-f4b7-46a7-9383-fc8ef5941409",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "9ed9871367744fcb84ba504bd572553a8cf0da585b37ebf4756f4cf778d27b8b/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "cd1fb92918fe4587d06ebb4772dd4e43e7b3026f",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "9744909a126ead515c433097c0b5f76c98e9a5b4"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9744909a126ead515c433097c0b5f76c98e9a5b4",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "93e3065d-93c7-44e0-962f-8f7caeaa3317",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "2b4ce93eaee81a34e019c39057246c60f1c8fdfd7064edd29b200445b3c9204f/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "6d0c830a9d6c971bc20385c7b751113d33b7c361",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "db777db25c31688c8e45b6aef8ed9de8541b3a72"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/db777db25c31688c8e45b6aef8ed9de8541b3a72",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "71390879-68a9-4c8a-9de5-53a3ac96042a",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "db777db25c31688c8e45b6aef8ed9de8541b3a72"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "db777db25c31688c8e45b6aef8ed9de8541b3a72",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8934158090452414352"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.x64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "clang-linux-x64"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:31:54.305] Scheduled build:
{
"id": "8768728028449521921",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-28T07:31:53.924012456Z",
"updateTime": "2023-09-28T07:31:53.924012456Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "db777db25c31688c8e45b6aef8ed9de8541b3a72",
"ref": "refs/heads/main"
}
}
}
[07:31:54.306] Task URL: https://cr-buildbucket.appspot.com/build/8768728028449521921
[07:31:54.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:2:0) after 3m0s
[07:31:54.505] Received PubSub notification, asking Buildbucket for the build status
[07:31:54.525] Build status: SCHEDULED
[07:31:56.131] Received PubSub notification, asking Buildbucket for the build status
[07:31:56.155] Build status: STARTED
[07:34:54.327] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:2:0)
[07:34:54.346] Build status: STARTED
[07:34:54.346] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:5:0) after 6m25s
[07:41:19.365] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:5:0)
[07:41:19.383] Build status: STARTED
[07:41:19.383] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:6:0) after 6m27s
[07:47:46.401] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:6:0)
[07:47:46.460] Build status: STARTED
[07:47:46.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:7:0) after 4m59s
[07:52:45.488] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:7:0)
[07:52:45.517] Build status: STARTED
[07:52:45.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:8:0) after 8m32s
[08:01:17.542] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:8:0)
[08:01:17.563] Build status: STARTED
[08:01:17.563] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:9:0) after 7m33s
[08:08:50.580] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:9:0)
[08:08:50.596] Build status: STARTED
[08:08:50.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:10:0) after 4m15s
[08:13:05.623] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:10:0)
[08:13:05.645] Build status: STARTED
[08:13:05.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:11:0) after 1m55s
[08:15:00.664] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:11:0)
[08:15:00.694] Build status: STARTED
[08:15:00.694] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:12:0) after 3m12s
[08:18:13.096] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:12:0)
[08:18:13.128] Build status: STARTED
[08:18:13.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:13:0) after 7m38s
[08:25:51.220] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:13:0)
[08:25:51.237] Build status: STARTED
[08:25:51.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:14:0) after 7m35s
[08:33:26.256] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:14:0)
[08:33:26.276] Build status: STARTED
[08:33:26.276] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:15:0) after 3m38s
[08:37:04.323] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:15:0)
[08:37:04.343] Build status: STARTED
[08:37:04.343] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:16:0) after 8m56s
[08:46:00.405] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:16:0)
[08:46:00.434] Build status: STARTED
[08:46:00.434] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:17:0) after 3m38s
[08:49:38.837] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:17:0)
[08:49:38.855] Build status: STARTED
[08:49:38.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:18:0) after 6m29s
[08:56:08.135] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:18:0)
[08:56:08.157] Build status: STARTED
[08:56:08.157] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:19:0) after 9m58s
[09:06:06.179] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:19:0)
[09:06:06.253] Build status: STARTED
[09:06:06.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:20:0) after 4m15s
[09:10:21.483] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:20:0)
[09:10:21.504] Build status: STARTED
[09:10:21.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:21:0) after 1m16s
[09:11:37.525] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:21:0)
[09:11:37.597] Build status: STARTED
[09:11:37.597] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:22:0) after 1m0s
[09:12:37.614] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:22:0)
[09:12:37.636] Build status: STARTED
[09:12:37.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:23:0) after 8m58s
[09:21:35.724] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:23:0)
[09:21:35.743] Build status: STARTED
[09:21:35.743] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:24:0) after 4m20s
[09:25:55.856] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:24:0)
[09:25:55.945] Build status: STARTED
[09:25:55.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934158090452414352:25:0) after 7m32s
[09:30:14.355] Received PubSub notification, asking Buildbucket for the build status
[09:30:14.445] Build:
{
"id": "8768728028449521921",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-28T07:31:53.924012456Z",
"startTime": "2023-09-28T07:31:55.393186Z",
"endTime": "2023-09-28T09:29:56.939874985Z",
"updateTime": "2023-09-28T09:29:56.939874985Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "db777db25c31688c8e45b6aef8ed9de8541b3a72",
"ref": "refs/heads/main"
}
}
}
[09:30:14.445] Invocation finished in 1h58m21.814693348s with status SUCCEEDED