[17:39:58.746] New invocation is queued and will start shortly
[17:40:00.163] Starting the invocation (attempt 1)
[17:40:00.190] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a0e3e76385feca289f03576b17d5e9cc7783c9b4"
[17:40:00.190] Popped gitiles commit info from properties and tags
[17:40:00.190] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:40:00.190] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:40:00.191] Buildbucket request:
{
"requestId": "8912829544903094816",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-linux-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8912829544903094816",
"job": "fuchsia/toolchain.ci-clang-linux-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4f5bc4bb55a8091ca9eb6dd016dcb2be82bf917a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4f5bc4bb55a8091ca9eb6dd016dcb2be82bf917a",
"title": "4f5bc4bb55a8091ca9eb6dd016dcb2be82bf917a",
"url": "https://llvm.googlesource.com/llvm-project/+/4f5bc4bb55a8091ca9eb6dd016dcb2be82bf917a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d71f30a7f45c5a73fe551ea4ca48b11191e7b0e8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d71f30a7f45c5a73fe551ea4ca48b11191e7b0e8",
"title": "d71f30a7f45c5a73fe551ea4ca48b11191e7b0e8",
"url": "https://llvm.googlesource.com/llvm-project/+/d71f30a7f45c5a73fe551ea4ca48b11191e7b0e8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0047df9af4a106560197850438d6543dcb87d839"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0047df9af4a106560197850438d6543dcb87d839",
"title": "0047df9af4a106560197850438d6543dcb87d839",
"url": "https://llvm.googlesource.com/llvm-project/+/0047df9af4a106560197850438d6543dcb87d839"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "50be0b1b967eeb479989ed26c13d17a53845dd1e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@50be0b1b967eeb479989ed26c13d17a53845dd1e",
"title": "50be0b1b967eeb479989ed26c13d17a53845dd1e",
"url": "https://llvm.googlesource.com/llvm-project/+/50be0b1b967eeb479989ed26c13d17a53845dd1e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1de1f775b55bb5c4c739e8f7ac78e7f59f2645fb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1de1f775b55bb5c4c739e8f7ac78e7f59f2645fb",
"title": "1de1f775b55bb5c4c739e8f7ac78e7f59f2645fb",
"url": "https://llvm.googlesource.com/llvm-project/+/1de1f775b55bb5c4c739e8f7ac78e7f59f2645fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3575d23ca866e0510b322e4520d6cbcebee18c22"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3575d23ca866e0510b322e4520d6cbcebee18c22",
"title": "3575d23ca866e0510b322e4520d6cbcebee18c22",
"url": "https://llvm.googlesource.com/llvm-project/+/3575d23ca866e0510b322e4520d6cbcebee18c22"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "285f1392da07f6b0bcaa7d106c00b1e9fda25333"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@285f1392da07f6b0bcaa7d106c00b1e9fda25333",
"title": "285f1392da07f6b0bcaa7d106c00b1e9fda25333",
"url": "https://llvm.googlesource.com/llvm-project/+/285f1392da07f6b0bcaa7d106c00b1e9fda25333"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a0e3e76385feca289f03576b17d5e9cc7783c9b4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a0e3e76385feca289f03576b17d5e9cc7783c9b4",
"title": "a0e3e76385feca289f03576b17d5e9cc7783c9b4",
"url": "https://llvm.googlesource.com/llvm-project/+/a0e3e76385feca289f03576b17d5e9cc7783c9b4"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a0e3e76385feca289f03576b17d5e9cc7783c9b4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8912829544903094816"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-linux-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:40:00.610] Scheduled build:
{
"id": "8747399482670919345",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-linux-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-20T17:40:00.239707753Z",
"updateTime": "2024-05-20T17:40:00.239707753Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a0e3e76385feca289f03576b17d5e9cc7783c9b4",
"ref": "refs/heads/main"
}
}
}
[17:40:00.610] Task URL: https://cr-buildbucket.appspot.com/build/8747399482670919345
[17:40:00.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8912829544903094816:2:0) after 9m18s
[17:40:01.552] Received PubSub notification, asking Buildbucket for the build status
[17:40:01.595] Build status: SCHEDULED
[17:40:04.981] Received PubSub notification, asking Buildbucket for the build status
[17:40:05.008] Build status: STARTED
[17:49:18.630] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8912829544903094816:2:0)
[17:49:18.661] Build status: STARTED
[17:49:18.661] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8912829544903094816:5:0) after 7m46s
[17:57:04.677] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8912829544903094816:5:0)
[17:57:04.706] Build status: STARTED
[17:57:04.706] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8912829544903094816:6:0) after 5m30s
[18:02:34.722] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8912829544903094816:6:0)
[18:02:34.769] Build status: STARTED
[18:02:34.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8912829544903094816:7:0) after 6m31s
[18:09:05.811] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8912829544903094816:7:0)
[18:09:05.834] Build status: STARTED
[18:09:05.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8912829544903094816:8:0) after 2m35s
[18:11:40.951] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8912829544903094816:8:0)
[18:11:40.984] Build status: STARTED
[18:11:40.984] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8912829544903094816:9:0) after 5m0s
[18:16:41.001] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8912829544903094816:9:0)
[18:16:41.028] Build status: STARTED
[18:16:41.028] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8912829544903094816:10:0) after 2m22s
[18:17:22.444] Received PubSub notification, asking Buildbucket for the build status
[18:17:22.464] Build:
{
"id": "8747399482670919345",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-linux-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-20T17:40:00.239707753Z",
"startTime": "2024-05-20T17:40:04.698035719Z",
"endTime": "2024-05-20T18:17:22.154062277Z",
"updateTime": "2024-05-20T18:17:22.154062277Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a0e3e76385feca289f03576b17d5e9cc7783c9b4",
"ref": "refs/heads/main"
}
}
}
[18:17:22.464] Invocation finished in 37m23.737063393s with status SUCCEEDED