[16:03:54.193] New invocation is queued and will start shortly
[16:03:56.784] Starting the invocation (attempt 1)
[16:03:56.810] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e2c43ba981620cf71ce3ccf004db7c0db4caf8a7"
[16:03:56.810] Popped gitiles commit info from properties and tags
[16:03:56.810] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:03:56.810] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:03:56.811] Buildbucket request:
{
"requestId": "8885565902581415712",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8885565902581415712",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8bc0f879a05228c58235ded510360da2220f0afd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8bc0f879a05228c58235ded510360da2220f0afd",
"title": "8bc0f879a05228c58235ded510360da2220f0afd",
"url": "https://llvm.googlesource.com/llvm-project/+/8bc0f879a05228c58235ded510360da2220f0afd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b8317df8d8f6dc110edfbf86d8269c912cb2a2a9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b8317df8d8f6dc110edfbf86d8269c912cb2a2a9",
"title": "b8317df8d8f6dc110edfbf86d8269c912cb2a2a9",
"url": "https://llvm.googlesource.com/llvm-project/+/b8317df8d8f6dc110edfbf86d8269c912cb2a2a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8789c0083de178fd044e5fb94b3a36c2eec49e0a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8789c0083de178fd044e5fb94b3a36c2eec49e0a",
"title": "8789c0083de178fd044e5fb94b3a36c2eec49e0a",
"url": "https://llvm.googlesource.com/llvm-project/+/8789c0083de178fd044e5fb94b3a36c2eec49e0a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e71686ed1539abe8ec68a4efa010f5ede13e9888"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e71686ed1539abe8ec68a4efa010f5ede13e9888",
"title": "e71686ed1539abe8ec68a4efa010f5ede13e9888",
"url": "https://llvm.googlesource.com/llvm-project/+/e71686ed1539abe8ec68a4efa010f5ede13e9888"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9455df969ef34681d08b2118a2ca2e8b0bd0155b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9455df969ef34681d08b2118a2ca2e8b0bd0155b",
"title": "9455df969ef34681d08b2118a2ca2e8b0bd0155b",
"url": "https://llvm.googlesource.com/llvm-project/+/9455df969ef34681d08b2118a2ca2e8b0bd0155b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "83356f3b62e95b980ca48083aafa4a1b4040d4c9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@83356f3b62e95b980ca48083aafa4a1b4040d4c9",
"title": "83356f3b62e95b980ca48083aafa4a1b4040d4c9",
"url": "https://llvm.googlesource.com/llvm-project/+/83356f3b62e95b980ca48083aafa4a1b4040d4c9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1b237198dc9d308c6d589e01637ec7496b48b3e0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1b237198dc9d308c6d589e01637ec7496b48b3e0",
"title": "1b237198dc9d308c6d589e01637ec7496b48b3e0",
"url": "https://llvm.googlesource.com/llvm-project/+/1b237198dc9d308c6d589e01637ec7496b48b3e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "37c3fbfa5ae9c124fffa4d53df708c688d8584c6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@37c3fbfa5ae9c124fffa4d53df708c688d8584c6",
"title": "37c3fbfa5ae9c124fffa4d53df708c688d8584c6",
"url": "https://llvm.googlesource.com/llvm-project/+/37c3fbfa5ae9c124fffa4d53df708c688d8584c6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "269c40fafc80576ab4efcd7fba954fd5588ea118"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@269c40fafc80576ab4efcd7fba954fd5588ea118",
"title": "269c40fafc80576ab4efcd7fba954fd5588ea118",
"url": "https://llvm.googlesource.com/llvm-project/+/269c40fafc80576ab4efcd7fba954fd5588ea118"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "52e7ca9279b4cbe30cacca67548347ef5f96b120"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@52e7ca9279b4cbe30cacca67548347ef5f96b120",
"title": "52e7ca9279b4cbe30cacca67548347ef5f96b120",
"url": "https://llvm.googlesource.com/llvm-project/+/52e7ca9279b4cbe30cacca67548347ef5f96b120"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3959bbc1345b9eb99b208e816a86e6a39103c345"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3959bbc1345b9eb99b208e816a86e6a39103c345",
"title": "3959bbc1345b9eb99b208e816a86e6a39103c345",
"url": "https://llvm.googlesource.com/llvm-project/+/3959bbc1345b9eb99b208e816a86e6a39103c345"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a4510aa7cb6073ccec63edce3aaed3e6f92563a5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a4510aa7cb6073ccec63edce3aaed3e6f92563a5",
"title": "a4510aa7cb6073ccec63edce3aaed3e6f92563a5",
"url": "https://llvm.googlesource.com/llvm-project/+/a4510aa7cb6073ccec63edce3aaed3e6f92563a5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7054655c52e03a2a0d3bca679cb883241679a14e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7054655c52e03a2a0d3bca679cb883241679a14e",
"title": "7054655c52e03a2a0d3bca679cb883241679a14e",
"url": "https://llvm.googlesource.com/llvm-project/+/7054655c52e03a2a0d3bca679cb883241679a14e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e2c43ba981620cf71ce3ccf004db7c0db4caf8a7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e2c43ba981620cf71ce3ccf004db7c0db4caf8a7",
"title": "e2c43ba981620cf71ce3ccf004db7c0db4caf8a7",
"url": "https://llvm.googlesource.com/llvm-project/+/e2c43ba981620cf71ce3ccf004db7c0db4caf8a7"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e2c43ba981620cf71ce3ccf004db7c0db4caf8a7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8885565902581415712"
},
{
"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"
}
}
[16:03:57.240] Scheduled build:
{
"id": "8720135839097981185",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-17T16:03:56.886713882Z",
"updateTime": "2025-03-17T16:03:56.886713882Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e2c43ba981620cf71ce3ccf004db7c0db4caf8a7",
"ref": "refs/heads/main"
}
}
}
[16:03:57.241] Task URL: https://cr-buildbucket.appspot.com/build/8720135839097981185
[16:03:57.241] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:2:0) after 9m40s
[16:03:57.524] Received PubSub notification, asking Buildbucket for the build status
[16:03:57.566] Build status: SCHEDULED
[16:05:48.209] Received PubSub notification, asking Buildbucket for the build status
[16:05:48.239] Build status: STARTED
[16:13:37.259] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:2:0)
[16:13:37.280] Build status: STARTED
[16:13:37.280] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:5:0) after 1m52s
[16:15:29.303] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:5:0)
[16:15:29.333] Build status: STARTED
[16:15:29.333] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:6:0) after 2m21s
[16:17:50.357] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:6:0)
[16:17:50.389] Build status: STARTED
[16:17:50.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:7:0) after 7m27s
[16:25:17.411] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:7:0)
[16:25:17.430] Build status: STARTED
[16:25:17.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:8:0) after 9m37s
[16:34:54.448] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:8:0)
[16:34:54.467] Build status: STARTED
[16:34:54.467] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:9:0) after 9m41s
[16:44:35.489] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:9:0)
[16:44:35.509] Build status: STARTED
[16:44:35.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:10:0) after 2m44s
[16:47:19.526] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:10:0)
[16:47:19.551] Build status: STARTED
[16:47:19.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:11:0) after 1m29s
[16:48:48.622] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:11:0)
[16:48:48.646] Build status: STARTED
[16:48:48.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:12:0) after 4m39s
[16:53:27.686] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:12:0)
[16:53:27.704] Build status: STARTED
[16:53:27.704] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:13:0) after 9m17s
[17:02:44.733] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:13:0)
[17:02:44.754] Build status: STARTED
[17:02:44.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:14:0) after 5m36s
[17:08:20.782] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:14:0)
[17:08:20.797] Build status: STARTED
[17:08:20.797] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:15:0) after 4m7s
[17:12:27.818] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:15:0)
[17:12:27.857] Build status: STARTED
[17:12:27.857] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:16:0) after 5m44s
[17:18:11.875] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:16:0)
[17:18:11.892] Build status: STARTED
[17:18:11.892] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:17:0) after 1m11s
[17:19:22.963] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:17:0)
[17:19:22.995] Build status: STARTED
[17:19:22.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:18:0) after 3m12s
[17:22:35.014] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:18:0)
[17:22:35.034] Build status: STARTED
[17:22:35.034] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:19:0) after 2m14s
[17:24:49.069] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:19:0)
[17:24:49.142] Build status: STARTED
[17:24:49.142] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:20:0) after 9m35s
[17:34:24.142] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:20:0)
[17:34:24.160] Build status: STARTED
[17:34:24.160] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:21:0) after 1m32s
[17:35:56.162] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:21:0)
[17:35:56.176] Build status: STARTED
[17:35:56.176] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8885565902581415712:22:0) after 8m45s
[17:41:48.962] Received PubSub notification, asking Buildbucket for the build status
[17:41:48.987] Build:
{
"id": "8720135839097981185",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-17T16:03:56.886713882Z",
"startTime": "2025-03-17T16:05:47.931680036Z",
"endTime": "2025-03-17T17:41:48.077919555Z",
"updateTime": "2025-03-17T17:41:48.077919555Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e2c43ba981620cf71ce3ccf004db7c0db4caf8a7",
"ref": "refs/heads/main"
}
}
}
[17:41:48.987] Invocation finished in 1h37m54.807062001s with status SUCCEEDED