[14:09:30.521] New invocation is queued and will start shortly
[14:09:31.600] Starting the invocation (attempt 1)
[14:09:31.658] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ef395a492aa931f428e99e1c0a93d4ad2fb0fcfa"
[14:09:31.658] Popped gitiles commit info from properties and tags
[14:09:31.658] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:09:31.659] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:09:31.660] Buildbucket request:
{
"requestId": "8918459798459407584",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8918459798459407584",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4e612a62bd0f3c4f182ecd7652f92d288fc06894"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4e612a62bd0f3c4f182ecd7652f92d288fc06894",
"title": "4e612a62bd0f3c4f182ecd7652f92d288fc06894",
"url": "https://llvm.googlesource.com/llvm-project/+/4e612a62bd0f3c4f182ecd7652f92d288fc06894"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "97fc16e14b16bd44dee1e1bf7211b4688b67027d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@97fc16e14b16bd44dee1e1bf7211b4688b67027d",
"title": "97fc16e14b16bd44dee1e1bf7211b4688b67027d",
"url": "https://llvm.googlesource.com/llvm-project/+/97fc16e14b16bd44dee1e1bf7211b4688b67027d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9f433bf8cada5855669b43ff70263a1b61128ca4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9f433bf8cada5855669b43ff70263a1b61128ca4",
"title": "9f433bf8cada5855669b43ff70263a1b61128ca4",
"url": "https://llvm.googlesource.com/llvm-project/+/9f433bf8cada5855669b43ff70263a1b61128ca4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9a3ece232ced907f87ed0d5846a57f6d9cbc9832"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9a3ece232ced907f87ed0d5846a57f6d9cbc9832",
"title": "9a3ece232ced907f87ed0d5846a57f6d9cbc9832",
"url": "https://llvm.googlesource.com/llvm-project/+/9a3ece232ced907f87ed0d5846a57f6d9cbc9832"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ef520ca6b18cf65fc7a13fcad1534f1d70332a88"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ef520ca6b18cf65fc7a13fcad1534f1d70332a88",
"title": "ef520ca6b18cf65fc7a13fcad1534f1d70332a88",
"url": "https://llvm.googlesource.com/llvm-project/+/ef520ca6b18cf65fc7a13fcad1534f1d70332a88"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "92764c99e97ab2b347072718ba2a6799b3fe41c7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@92764c99e97ab2b347072718ba2a6799b3fe41c7",
"title": "92764c99e97ab2b347072718ba2a6799b3fe41c7",
"url": "https://llvm.googlesource.com/llvm-project/+/92764c99e97ab2b347072718ba2a6799b3fe41c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "930f21c6bc0fe05c1d08be6353f7c7c6c51f4dc0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@930f21c6bc0fe05c1d08be6353f7c7c6c51f4dc0",
"title": "930f21c6bc0fe05c1d08be6353f7c7c6c51f4dc0",
"url": "https://llvm.googlesource.com/llvm-project/+/930f21c6bc0fe05c1d08be6353f7c7c6c51f4dc0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e9da5f0083d12a7284c780e916c17b6a2785933e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e9da5f0083d12a7284c780e916c17b6a2785933e",
"title": "e9da5f0083d12a7284c780e916c17b6a2785933e",
"url": "https://llvm.googlesource.com/llvm-project/+/e9da5f0083d12a7284c780e916c17b6a2785933e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "335f3659820e2e771f5165d215300567be478b13"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@335f3659820e2e771f5165d215300567be478b13",
"title": "335f3659820e2e771f5165d215300567be478b13",
"url": "https://llvm.googlesource.com/llvm-project/+/335f3659820e2e771f5165d215300567be478b13"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "175ad6630a869831126dde80f0f9257f9c4c477f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@175ad6630a869831126dde80f0f9257f9c4c477f",
"title": "175ad6630a869831126dde80f0f9257f9c4c477f",
"url": "https://llvm.googlesource.com/llvm-project/+/175ad6630a869831126dde80f0f9257f9c4c477f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4b10d1fdd31f46a9cdf3e7a196f9934d766a922f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4b10d1fdd31f46a9cdf3e7a196f9934d766a922f",
"title": "4b10d1fdd31f46a9cdf3e7a196f9934d766a922f",
"url": "https://llvm.googlesource.com/llvm-project/+/4b10d1fdd31f46a9cdf3e7a196f9934d766a922f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9f80444c2e669237a5c92013f1a42b91b5609012"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9f80444c2e669237a5c92013f1a42b91b5609012",
"title": "9f80444c2e669237a5c92013f1a42b91b5609012",
"url": "https://llvm.googlesource.com/llvm-project/+/9f80444c2e669237a5c92013f1a42b91b5609012"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "94c6ce1de92f56879cad1bfa12ba23ef0ecfcd91"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@94c6ce1de92f56879cad1bfa12ba23ef0ecfcd91",
"title": "94c6ce1de92f56879cad1bfa12ba23ef0ecfcd91",
"url": "https://llvm.googlesource.com/llvm-project/+/94c6ce1de92f56879cad1bfa12ba23ef0ecfcd91"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "835c1b56a82542d91c337e24140bd2b08a7bf715"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@835c1b56a82542d91c337e24140bd2b08a7bf715",
"title": "835c1b56a82542d91c337e24140bd2b08a7bf715",
"url": "https://llvm.googlesource.com/llvm-project/+/835c1b56a82542d91c337e24140bd2b08a7bf715"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5b59b3afe1cfe52c3c2cb9c9817ca21e589928a0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5b59b3afe1cfe52c3c2cb9c9817ca21e589928a0",
"title": "5b59b3afe1cfe52c3c2cb9c9817ca21e589928a0",
"url": "https://llvm.googlesource.com/llvm-project/+/5b59b3afe1cfe52c3c2cb9c9817ca21e589928a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c1328db9d8e41bb96e031eb3dfa884e56b07244b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c1328db9d8e41bb96e031eb3dfa884e56b07244b",
"title": "c1328db9d8e41bb96e031eb3dfa884e56b07244b",
"url": "https://llvm.googlesource.com/llvm-project/+/c1328db9d8e41bb96e031eb3dfa884e56b07244b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d93363a0e803a9fb2889ff03237f4e93aacf0108"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d93363a0e803a9fb2889ff03237f4e93aacf0108",
"title": "d93363a0e803a9fb2889ff03237f4e93aacf0108",
"url": "https://llvm.googlesource.com/llvm-project/+/d93363a0e803a9fb2889ff03237f4e93aacf0108"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ef395a492aa931f428e99e1c0a93d4ad2fb0fcfa"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ef395a492aa931f428e99e1c0a93d4ad2fb0fcfa",
"title": "ef395a492aa931f428e99e1c0a93d4ad2fb0fcfa",
"url": "https://llvm.googlesource.com/llvm-project/+/ef395a492aa931f428e99e1c0a93d4ad2fb0fcfa"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ef395a492aa931f428e99e1c0a93d4ad2fb0fcfa",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8918459798459407584"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[14:09:32.218] Scheduled build:
{
"id": "8753029736531353329",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-19T14:09:31.737661608Z",
"updateTime": "2024-03-19T14:09:31.737661608Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ef395a492aa931f428e99e1c0a93d4ad2fb0fcfa",
"ref": "refs/heads/main"
}
}
}
[14:09:32.218] Task URL: https://cr-buildbucket.appspot.com/build/8753029736531353329
[14:09:32.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:2:0) after 8m33s
[14:09:33.319] Received PubSub notification, asking Buildbucket for the build status
[14:09:33.349] Build status: SCHEDULED
[14:18:05.236] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:2:0)
[14:18:05.330] Build status: SCHEDULED
[14:18:05.330] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:4:0) after 8m57s
[14:27:02.379] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:4:0)
[14:27:02.401] Build status: SCHEDULED
[14:27:02.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:5:0) after 3m15s
[14:30:17.666] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:5:0)
[14:30:17.710] Build status: SCHEDULED
[14:30:17.710] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:6:0) after 3m54s
[14:34:11.812] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:6:0)
[14:34:11.830] Build status: SCHEDULED
[14:34:11.830] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:7:0) after 3m41s
[14:37:52.820] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:7:0)
[14:37:52.850] Build status: SCHEDULED
[14:37:52.850] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:8:0) after 4m12s
[14:39:20.879] Received PubSub notification, asking Buildbucket for the build status
[14:39:20.912] Build status: STARTED
[14:42:05.056] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:8:0)
[14:42:05.099] Build status: STARTED
[14:42:05.100] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:10:0) after 5m22s
[14:47:27.184] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:10:0)
[14:47:27.227] Build status: STARTED
[14:47:27.227] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:11:0) after 6m10s
[14:53:37.312] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:11:0)
[14:53:37.336] Build status: STARTED
[14:53:37.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:12:0) after 7m56s
[15:01:33.399] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:12:0)
[15:01:33.419] Build status: STARTED
[15:01:33.419] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:13:0) after 9m49s
[15:11:22.411] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:13:0)
[15:11:22.451] Build status: STARTED
[15:11:22.451] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:14:0) after 5m37s
[15:16:59.511] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:14:0)
[15:16:59.565] Build status: STARTED
[15:16:59.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:15:0) after 5m19s
[15:22:18.621] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:15:0)
[15:22:18.644] Build status: STARTED
[15:22:18.644] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:16:0) after 2m34s
[15:24:52.621] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:16:0)
[15:24:52.658] Build status: STARTED
[15:24:52.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:17:0) after 4m41s
[15:29:33.815] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:17:0)
[15:29:33.840] Build status: STARTED
[15:29:33.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:18:0) after 6m40s
[15:36:13.883] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:18:0)
[15:36:13.929] Build status: STARTED
[15:36:13.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:19:0) after 1m7s
[15:37:20.962] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:19:0)
[15:37:20.993] Build status: STARTED
[15:37:20.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:20:0) after 6m37s
[15:43:57.996] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:20:0)
[15:43:58.015] Build status: STARTED
[15:43:58.015] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:21:0) after 9m44s
[15:53:42.053] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:21:0)
[15:53:42.181] Build status: STARTED
[15:53:42.181] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8918459798459407584:22:0) after 2m16s
[15:53:56.107] Received PubSub notification, asking Buildbucket for the build status
[15:53:56.129] Build:
{
"id": "8753029736531353329",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-19T14:09:31.737661608Z",
"startTime": "2024-03-19T14:39:20.075513Z",
"endTime": "2024-03-19T15:53:55.104101Z",
"updateTime": "2024-03-19T15:53:55.104101Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ef395a492aa931f428e99e1c0a93d4ad2fb0fcfa",
"ref": "refs/heads/main"
}
}
}
[15:53:56.129] Invocation finished in 1h44m25.614290973s with status SUCCEEDED