[18:17:50.759] New invocation is queued and will start shortly
[18:17:50.759] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[18:17:51.990] Starting the invocation (attempt 1)
[18:17:52.014] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/5cfc7b3342ce4de0bbe182b38baa8a71fc83f8f8"
[18:17:52.014] Reconstructed gitiles commit from tags
[18:17:52.014] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:17:52.014] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:17:52.015] Buildbucket request:
{
"requestId": "8926144916573686848",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "5518193d7cbf3e186081a2b9830be6344fcb3b82707ca7d32ad30b0bf98fbce9/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ee6018260fa0284d783aba1b7eb48ec92aee40d7",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8926144916573686848",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "e7ef25d8984c78bc2227e95099b9da3bd20bbc143c5e876fb66ec8048ccffd88/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ee6018260fa0284d783aba1b7eb48ec92aee40d7",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "ff76627aeb8d431d5451201d656bb38318908f0a"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ff76627aeb8d431d5451201d656bb38318908f0a",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "5ed7c07f-747d-4a68-9b70-8d668a585a4c",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "5518193d7cbf3e186081a2b9830be6344fcb3b82707ca7d32ad30b0bf98fbce9/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ee6018260fa0284d783aba1b7eb48ec92aee40d7",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "5cfc7b3342ce4de0bbe182b38baa8a71fc83f8f8"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/5cfc7b3342ce4de0bbe182b38baa8a71fc83f8f8",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "627d0561-c0a2-4e88-a98c-02d4d0c0bab1",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "5cfc7b3342ce4de0bbe182b38baa8a71fc83f8f8"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5cfc7b3342ce4de0bbe182b38baa8a71fc83f8f8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8926144916573686848"
},
{
"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"
}
}
[18:17:52.485] Scheduled build:
{
"id": "8760714854542929841",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-25T18:17:52.071097968Z",
"updateTime": "2023-12-25T18:17:52.071097968Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5cfc7b3342ce4de0bbe182b38baa8a71fc83f8f8",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:17:52.485] Task URL: https://cr-buildbucket.appspot.com/build/8760714854542929841
[18:17:52.485] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:2:0) after 7m48s
[18:17:53.339] Received PubSub notification, asking Buildbucket for the build status
[18:17:53.363] Build status: STARTED
[18:17:54.436] Received PubSub notification, asking Buildbucket for the build status
[18:17:54.471] Build status: STARTED
[18:25:40.514] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:2:0)
[18:25:40.536] Build status: STARTED
[18:25:40.537] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:5:0) after 8m23s
[18:34:03.617] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:5:0)
[18:34:03.645] Build status: STARTED
[18:34:03.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:6:0) after 9m30s
[18:43:33.659] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:6:0)
[18:43:33.682] Build status: STARTED
[18:43:33.682] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:7:0) after 9m42s
[18:53:15.699] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:7:0)
[18:53:15.717] Build status: STARTED
[18:53:15.717] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:8:0) after 9m49s
[19:03:04.731] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:8:0)
[19:03:04.759] Build status: STARTED
[19:03:04.759] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:9:0) after 9m26s
[19:12:30.778] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:9:0)
[19:12:30.808] Build status: STARTED
[19:12:30.808] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:10:0) after 2m50s
[19:15:20.841] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:10:0)
[19:15:20.861] Build status: STARTED
[19:15:20.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:11:0) after 5m12s
[19:20:32.911] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:11:0)
[19:20:32.941] Build status: STARTED
[19:20:32.941] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:12:0) after 7m27s
[19:27:59.954] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:12:0)
[19:27:59.975] Build status: STARTED
[19:27:59.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:13:0) after 4m55s
[19:32:55.115] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:13:0)
[19:32:55.133] Build status: STARTED
[19:32:55.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:14:0) after 1m9s
[19:34:04.149] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:14:0)
[19:34:04.185] Build status: STARTED
[19:34:04.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:15:0) after 6m12s
[19:40:16.199] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:15:0)
[19:40:16.258] Build status: STARTED
[19:40:16.258] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:16:0) after 8m8s
[19:48:24.416] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:16:0)
[19:48:24.520] Build status: STARTED
[19:48:24.520] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:17:0) after 7m8s
[19:55:33.309] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:17:0)
[19:55:33.327] Build status: STARTED
[19:55:33.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:18:0) after 4m54s
[20:00:27.437] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:18:0)
[20:00:27.485] Build status: STARTED
[20:00:27.485] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8926144916573686848:19:0) after 5m41s
[20:03:25.892] Received PubSub notification, asking Buildbucket for the build status
[20:03:25.912] Build:
{
"id": "8760714854542929841",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-25T18:17:52.071097968Z",
"startTime": "2023-12-25T18:17:52.786213Z",
"endTime": "2023-12-25T20:03:18.906011Z",
"updateTime": "2023-12-25T20:03:18.906011Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5cfc7b3342ce4de0bbe182b38baa8a71fc83f8f8",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:03:25.912] Invocation finished in 1h45m35.161823972s with status SUCCEEDED