[12:39:16.219] New invocation is queued and will start shortly
[12:39:17.293] Starting the invocation (attempt 1)
[12:39:17.322] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/341d674b6f1863d027ed30c44a14cd32599eb42d"
[12:39:17.322] Popped gitiles commit info from properties and tags
[12:39:17.322] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:39:17.322] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:39:17.322] Buildbucket request:
{
"requestId": "8919733833300516704",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8919733833300516704",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "762f762504967efbe159db5c737154b989afc9bb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@762f762504967efbe159db5c737154b989afc9bb",
"title": "762f762504967efbe159db5c737154b989afc9bb",
"url": "https://llvm.googlesource.com/llvm-project/+/762f762504967efbe159db5c737154b989afc9bb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "923ddf65f4e21ec67018cf56e823895de18d83bc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@923ddf65f4e21ec67018cf56e823895de18d83bc",
"title": "923ddf65f4e21ec67018cf56e823895de18d83bc",
"url": "https://llvm.googlesource.com/llvm-project/+/923ddf65f4e21ec67018cf56e823895de18d83bc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "191f7678f7a76436b2b368d2c15f5ed61b9c5e2d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@191f7678f7a76436b2b368d2c15f5ed61b9c5e2d",
"title": "191f7678f7a76436b2b368d2c15f5ed61b9c5e2d",
"url": "https://llvm.googlesource.com/llvm-project/+/191f7678f7a76436b2b368d2c15f5ed61b9c5e2d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "49f95052c8cd6e611bd46e5d2730b432f1df6815"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@49f95052c8cd6e611bd46e5d2730b432f1df6815",
"title": "49f95052c8cd6e611bd46e5d2730b432f1df6815",
"url": "https://llvm.googlesource.com/llvm-project/+/49f95052c8cd6e611bd46e5d2730b432f1df6815"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d1d2932cb1dc24e0c8149f07b75599981ac405a7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d1d2932cb1dc24e0c8149f07b75599981ac405a7",
"title": "d1d2932cb1dc24e0c8149f07b75599981ac405a7",
"url": "https://llvm.googlesource.com/llvm-project/+/d1d2932cb1dc24e0c8149f07b75599981ac405a7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "20895965b2ed1bd037c64430dba98245ffa1232b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@20895965b2ed1bd037c64430dba98245ffa1232b",
"title": "20895965b2ed1bd037c64430dba98245ffa1232b",
"url": "https://llvm.googlesource.com/llvm-project/+/20895965b2ed1bd037c64430dba98245ffa1232b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "94a0dd5a1960e1ace0a161228f91c2e18865d061"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@94a0dd5a1960e1ace0a161228f91c2e18865d061",
"title": "94a0dd5a1960e1ace0a161228f91c2e18865d061",
"url": "https://llvm.googlesource.com/llvm-project/+/94a0dd5a1960e1ace0a161228f91c2e18865d061"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "de1f33873beff93063577195e1214a9509e229e0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@de1f33873beff93063577195e1214a9509e229e0",
"title": "de1f33873beff93063577195e1214a9509e229e0",
"url": "https://llvm.googlesource.com/llvm-project/+/de1f33873beff93063577195e1214a9509e229e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4693efe19c1cbb19ecac61e46802ffe74bd1a7ce"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4693efe19c1cbb19ecac61e46802ffe74bd1a7ce",
"title": "4693efe19c1cbb19ecac61e46802ffe74bd1a7ce",
"url": "https://llvm.googlesource.com/llvm-project/+/4693efe19c1cbb19ecac61e46802ffe74bd1a7ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "67a7a5e89d31cc332f2d782c30623dd3ddbd0862"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@67a7a5e89d31cc332f2d782c30623dd3ddbd0862",
"title": "67a7a5e89d31cc332f2d782c30623dd3ddbd0862",
"url": "https://llvm.googlesource.com/llvm-project/+/67a7a5e89d31cc332f2d782c30623dd3ddbd0862"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "90e97e71060cea8cb8bc4099d724d1fe9912cfc4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@90e97e71060cea8cb8bc4099d724d1fe9912cfc4",
"title": "90e97e71060cea8cb8bc4099d724d1fe9912cfc4",
"url": "https://llvm.googlesource.com/llvm-project/+/90e97e71060cea8cb8bc4099d724d1fe9912cfc4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "341d674b6f1863d027ed30c44a14cd32599eb42d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@341d674b6f1863d027ed30c44a14cd32599eb42d",
"title": "341d674b6f1863d027ed30c44a14cd32599eb42d",
"url": "https://llvm.googlesource.com/llvm-project/+/341d674b6f1863d027ed30c44a14cd32599eb42d"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "341d674b6f1863d027ed30c44a14cd32599eb42d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8919733833300516704"
},
{
"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"
}
}
[12:39:17.841] Scheduled build:
{
"id": "8754303771421357841",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-05T12:39:17.385835087Z",
"updateTime": "2024-03-05T12:39:17.385835087Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "341d674b6f1863d027ed30c44a14cd32599eb42d",
"ref": "refs/heads/main"
}
}
}
[12:39:17.841] Task URL: https://cr-buildbucket.appspot.com/build/8754303771421357841
[12:39:17.841] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:2:0) after 6m37s
[12:39:18.783] Received PubSub notification, asking Buildbucket for the build status
[12:39:18.830] Build status: SCHEDULED
[12:45:54.883] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:2:0)
[12:45:54.931] Build status: SCHEDULED
[12:45:54.931] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:4:0) after 8m41s
[12:54:36.055] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:4:0)
[12:54:36.091] Build status: SCHEDULED
[12:54:36.091] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:5:0) after 6m35s
[13:01:11.124] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:5:0)
[13:01:11.152] Build status: SCHEDULED
[13:01:11.152] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:6:0) after 2m54s
[13:03:34.705] Received PubSub notification, asking Buildbucket for the build status
[13:03:34.780] Build status: STARTED
[13:04:05.171] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:6:0)
[13:04:05.196] Build status: STARTED
[13:04:05.196] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:8:0) after 1m29s
[13:05:34.401] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:8:0)
[13:05:34.538] Build status: STARTED
[13:05:34.538] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:9:0) after 9m48s
[13:15:22.579] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:9:0)
[13:15:22.699] Build status: STARTED
[13:15:22.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:10:0) after 1m46s
[13:17:08.818] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:10:0)
[13:17:08.836] Build status: STARTED
[13:17:08.836] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:11:0) after 2m2s
[13:19:11.029] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:11:0)
[13:19:11.055] Build status: STARTED
[13:19:11.055] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:12:0) after 1m24s
[13:20:35.101] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:12:0)
[13:20:35.129] Build status: STARTED
[13:20:35.129] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:13:0) after 2m36s
[13:23:11.817] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:13:0)
[13:23:11.835] Build status: STARTED
[13:23:11.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:14:0) after 6m15s
[13:29:27.111] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:14:0)
[13:29:27.249] Build status: STARTED
[13:29:27.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:15:0) after 6m52s
[13:36:19.452] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:15:0)
[13:36:19.517] Build status: STARTED
[13:36:19.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:16:0) after 2m20s
[13:38:39.616] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:16:0)
[13:38:39.645] Build status: STARTED
[13:38:39.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:17:0) after 4m21s
[13:43:00.664] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:17:0)
[13:43:00.690] Build status: STARTED
[13:43:00.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:18:0) after 6m12s
[13:49:12.690] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:18:0)
[13:49:12.722] Build status: STARTED
[13:49:12.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:19:0) after 9m15s
[13:58:28.009] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:19:0)
[13:58:28.054] Build status: STARTED
[13:58:28.054] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:20:0) after 1m43s
[14:00:11.229] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:20:0)
[14:00:11.260] Build status: STARTED
[14:00:11.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:21:0) after 5m21s
[14:05:32.291] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:21:0)
[14:05:32.329] Build status: STARTED
[14:05:32.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:22:0) after 4m38s
[14:10:10.371] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:22:0)
[14:10:10.392] Build status: STARTED
[14:10:10.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:23:0) after 4m59s
[14:15:09.867] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:23:0)
[14:15:09.922] Build status: STARTED
[14:15:09.922] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919733833300516704:24:0) after 7m33s
[14:15:51.167] Received PubSub notification, asking Buildbucket for the build status
[14:15:51.223] Build:
{
"id": "8754303771421357841",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-05T12:39:17.385835087Z",
"startTime": "2024-03-05T13:03:32.545461Z",
"endTime": "2024-03-05T14:15:50.625696Z",
"updateTime": "2024-03-05T14:15:50.625696Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "341d674b6f1863d027ed30c44a14cd32599eb42d",
"ref": "refs/heads/main"
}
}
}
[14:15:51.223] Invocation finished in 1h36m35.013485977s with status SUCCEEDED