[09:44:26.319] New invocation is queued and will start shortly
[09:44:27.356] Starting the invocation (attempt 1)
[09:44:27.379] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a4656bbc595839b57e6f021aa2a728b4cf321d54"
[09:44:27.380] Popped gitiles commit info from properties and tags
[09:44:27.380] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:44:27.380] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:44:27.380] Buildbucket request:
{
"requestId": "8887401715752243136",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8887401715752243136",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3083aea4441493b11b72218207564bf54516bf3e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3083aea4441493b11b72218207564bf54516bf3e",
"title": "3083aea4441493b11b72218207564bf54516bf3e",
"url": "https://llvm.googlesource.com/llvm-project/+/3083aea4441493b11b72218207564bf54516bf3e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5088e1b435fd06de2bfccd3894dcc2f2c326630f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5088e1b435fd06de2bfccd3894dcc2f2c326630f",
"title": "5088e1b435fd06de2bfccd3894dcc2f2c326630f",
"url": "https://llvm.googlesource.com/llvm-project/+/5088e1b435fd06de2bfccd3894dcc2f2c326630f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d254fa877f419e61e54709f0a6f2e891da893a60"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d254fa877f419e61e54709f0a6f2e891da893a60",
"title": "d254fa877f419e61e54709f0a6f2e891da893a60",
"url": "https://llvm.googlesource.com/llvm-project/+/d254fa877f419e61e54709f0a6f2e891da893a60"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5114b9b386ca69058d19d9c3dac53b4b429c71a6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5114b9b386ca69058d19d9c3dac53b4b429c71a6",
"title": "5114b9b386ca69058d19d9c3dac53b4b429c71a6",
"url": "https://llvm.googlesource.com/llvm-project/+/5114b9b386ca69058d19d9c3dac53b4b429c71a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ea4e19df53abb21a1f1df725e3728fabec902978"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ea4e19df53abb21a1f1df725e3728fabec902978",
"title": "ea4e19df53abb21a1f1df725e3728fabec902978",
"url": "https://llvm.googlesource.com/llvm-project/+/ea4e19df53abb21a1f1df725e3728fabec902978"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0087523e1a273b738b94a15547dbf308d0470283"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0087523e1a273b738b94a15547dbf308d0470283",
"title": "0087523e1a273b738b94a15547dbf308d0470283",
"url": "https://llvm.googlesource.com/llvm-project/+/0087523e1a273b738b94a15547dbf308d0470283"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "49f60b4e098493f5128ba4276b3fbb985b0c61c8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@49f60b4e098493f5128ba4276b3fbb985b0c61c8",
"title": "49f60b4e098493f5128ba4276b3fbb985b0c61c8",
"url": "https://llvm.googlesource.com/llvm-project/+/49f60b4e098493f5128ba4276b3fbb985b0c61c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "674dbcfe8f400db65f0d066ea638e977e8b82781"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@674dbcfe8f400db65f0d066ea638e977e8b82781",
"title": "674dbcfe8f400db65f0d066ea638e977e8b82781",
"url": "https://llvm.googlesource.com/llvm-project/+/674dbcfe8f400db65f0d066ea638e977e8b82781"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d7211693af27760c939b6610f0c79a3ecd2790d2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d7211693af27760c939b6610f0c79a3ecd2790d2",
"title": "d7211693af27760c939b6610f0c79a3ecd2790d2",
"url": "https://llvm.googlesource.com/llvm-project/+/d7211693af27760c939b6610f0c79a3ecd2790d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "60cc3af0d93ecb8bfc9d6bebc6cbc395df3bb4b6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@60cc3af0d93ecb8bfc9d6bebc6cbc395df3bb4b6",
"title": "60cc3af0d93ecb8bfc9d6bebc6cbc395df3bb4b6",
"url": "https://llvm.googlesource.com/llvm-project/+/60cc3af0d93ecb8bfc9d6bebc6cbc395df3bb4b6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "275eeb56ddc4c236219f7df9618e7b03ff12e9fb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@275eeb56ddc4c236219f7df9618e7b03ff12e9fb",
"title": "275eeb56ddc4c236219f7df9618e7b03ff12e9fb",
"url": "https://llvm.googlesource.com/llvm-project/+/275eeb56ddc4c236219f7df9618e7b03ff12e9fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "87dc245f3e65ee926081e575ffb2e57a32a91ba3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@87dc245f3e65ee926081e575ffb2e57a32a91ba3",
"title": "87dc245f3e65ee926081e575ffb2e57a32a91ba3",
"url": "https://llvm.googlesource.com/llvm-project/+/87dc245f3e65ee926081e575ffb2e57a32a91ba3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a4656bbc595839b57e6f021aa2a728b4cf321d54"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a4656bbc595839b57e6f021aa2a728b4cf321d54",
"title": "a4656bbc595839b57e6f021aa2a728b4cf321d54",
"url": "https://llvm.googlesource.com/llvm-project/+/a4656bbc595839b57e6f021aa2a728b4cf321d54"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a4656bbc595839b57e6f021aa2a728b4cf321d54",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8887401715752243136"
},
{
"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"
}
}
[09:44:27.702] Scheduled build:
{
"id": "8721971653923042913",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-25T09:44:27.438499656Z",
"updateTime": "2025-02-25T09:44:27.438499656Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a4656bbc595839b57e6f021aa2a728b4cf321d54",
"ref": "refs/heads/main"
}
}
}
[09:44:27.702] Task URL: https://cr-buildbucket.appspot.com/build/8721971653923042913
[09:44:27.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:2:0) after 1m29s
[09:44:28.702] Received PubSub notification, asking Buildbucket for the build status
[09:44:28.726] Build status: SCHEDULED
[09:45:56.824] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:2:0)
[09:45:56.851] Build status: SCHEDULED
[09:45:56.851] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:4:0) after 8m23s
[09:51:31.130] Received PubSub notification, asking Buildbucket for the build status
[09:51:31.155] Build status: STARTED
[09:54:19.899] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:4:0)
[09:54:19.925] Build status: STARTED
[09:54:19.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:6:0) after 1m29s
[09:55:49.057] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:6:0)
[09:55:49.143] Build status: STARTED
[09:55:49.143] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:7:0) after 3m10s
[09:58:59.391] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:7:0)
[09:58:59.419] Build status: STARTED
[09:58:59.419] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:8:0) after 5m45s
[10:04:44.530] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:8:0)
[10:04:44.551] Build status: STARTED
[10:04:44.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:9:0) after 8m3s
[10:12:47.615] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:9:0)
[10:12:47.648] Build status: STARTED
[10:12:47.648] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:10:0) after 7m6s
[10:19:53.665] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:10:0)
[10:19:53.684] Build status: STARTED
[10:19:53.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:11:0) after 4m42s
[10:24:35.665] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:11:0)
[10:24:35.699] Build status: STARTED
[10:24:35.700] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:12:0) after 3m36s
[10:28:11.767] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:12:0)
[10:28:11.865] Build status: STARTED
[10:28:11.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:13:0) after 9m44s
[10:37:56.192] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:13:0)
[10:37:56.209] Build status: STARTED
[10:37:56.209] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:14:0) after 4m40s
[10:42:36.505] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:14:0)
[10:42:36.523] Build status: STARTED
[10:42:36.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:15:0) after 7m22s
[10:49:58.652] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:15:0)
[10:49:58.676] Build status: STARTED
[10:49:58.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:16:0) after 3m42s
[10:53:40.839] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:16:0)
[10:53:40.874] Build status: STARTED
[10:53:40.874] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:17:0) after 2m7s
[10:55:47.864] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:17:0)
[10:55:47.886] Build status: STARTED
[10:55:47.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:18:0) after 6m10s
[11:01:58.641] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:18:0)
[11:01:58.670] Build status: STARTED
[11:01:58.670] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:19:0) after 3m53s
[11:05:51.694] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:19:0)
[11:05:51.714] Build status: STARTED
[11:05:51.714] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:20:0) after 8m13s
[11:14:05.151] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:20:0)
[11:14:05.170] Build status: STARTED
[11:14:05.170] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887401715752243136:21:0) after 7m51s
[11:19:07.042] Received PubSub notification, asking Buildbucket for the build status
[11:19:07.056] Build:
{
"id": "8721971653923042913",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-25T09:44:27.438499656Z",
"startTime": "2025-02-25T09:51:30.838731238Z",
"endTime": "2025-02-25T11:19:06.683211431Z",
"updateTime": "2025-02-25T11:19:06.683211431Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a4656bbc595839b57e6f021aa2a728b4cf321d54",
"ref": "refs/heads/main"
}
}
}
[11:19:07.056] Invocation finished in 1h34m40.745840629s with status SUCCEEDED