[09:06:49.600] New invocation is queued and will start shortly
[09:06:51.050] Starting the invocation (attempt 1)
[09:06:51.081] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/df1e39489e3c751eeba633f17ec94be393a8a165"
[09:06:51.082] Popped gitiles commit info from properties and tags
[09:06:51.082] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:06:51.082] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:06:51.083] Buildbucket request:
{
"requestId": "8930528238101173664",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8930528238101173664",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0b3d54973c75facf69daf2738c21f064c1854b33"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0b3d54973c75facf69daf2738c21f064c1854b33",
"title": "0b3d54973c75facf69daf2738c21f064c1854b33",
"url": "https://llvm.googlesource.com/llvm-project/+/0b3d54973c75facf69daf2738c21f064c1854b33"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a5c1ecada27a84161e8d947b4f4564c785aa3807"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a5c1ecada27a84161e8d947b4f4564c785aa3807",
"title": "a5c1ecada27a84161e8d947b4f4564c785aa3807",
"url": "https://llvm.googlesource.com/llvm-project/+/a5c1ecada27a84161e8d947b4f4564c785aa3807"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "17764d2c87bad3b9654b7310c9936c0d15e9bf96"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@17764d2c87bad3b9654b7310c9936c0d15e9bf96",
"title": "17764d2c87bad3b9654b7310c9936c0d15e9bf96",
"url": "https://llvm.googlesource.com/llvm-project/+/17764d2c87bad3b9654b7310c9936c0d15e9bf96"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e09184ffe087e7efcdd15eec65c89b7a3cb3762f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e09184ffe087e7efcdd15eec65c89b7a3cb3762f",
"title": "e09184ffe087e7efcdd15eec65c89b7a3cb3762f",
"url": "https://llvm.googlesource.com/llvm-project/+/e09184ffe087e7efcdd15eec65c89b7a3cb3762f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6b573f4611df470c23c7048fe820e0f216e9a8e1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6b573f4611df470c23c7048fe820e0f216e9a8e1",
"title": "6b573f4611df470c23c7048fe820e0f216e9a8e1",
"url": "https://llvm.googlesource.com/llvm-project/+/6b573f4611df470c23c7048fe820e0f216e9a8e1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ebc3302725350c44aaf5f97ce7ba484e30b3efa8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ebc3302725350c44aaf5f97ce7ba484e30b3efa8",
"title": "ebc3302725350c44aaf5f97ce7ba484e30b3efa8",
"url": "https://llvm.googlesource.com/llvm-project/+/ebc3302725350c44aaf5f97ce7ba484e30b3efa8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4989c62b318229bff2643c244ebbd03c20e2f781"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4989c62b318229bff2643c244ebbd03c20e2f781",
"title": "4989c62b318229bff2643c244ebbd03c20e2f781",
"url": "https://llvm.googlesource.com/llvm-project/+/4989c62b318229bff2643c244ebbd03c20e2f781"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "df1e39489e3c751eeba633f17ec94be393a8a165"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@df1e39489e3c751eeba633f17ec94be393a8a165",
"title": "df1e39489e3c751eeba633f17ec94be393a8a165",
"url": "https://llvm.googlesource.com/llvm-project/+/df1e39489e3c751eeba633f17ec94be393a8a165"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "df1e39489e3c751eeba633f17ec94be393a8a165",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8930528238101173664"
},
{
"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:06:51.678] Scheduled build:
{
"id": "8765098175749268673",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-07T09:06:51.216320186Z",
"updateTime": "2023-11-07T09:06:51.216320186Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "df1e39489e3c751eeba633f17ec94be393a8a165",
"ref": "refs/heads/main"
}
}
}
[09:06:51.678] Task URL: https://cr-buildbucket.appspot.com/build/8765098175749268673
[09:06:51.678] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:2:0) after 3m58s
[09:06:52.660] Received PubSub notification, asking Buildbucket for the build status
[09:06:52.679] Build status: STARTED
[09:06:52.843] Received PubSub notification, asking Buildbucket for the build status
[09:06:52.880] Build status: STARTED
[09:10:49.695] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:2:0)
[09:10:49.714] Build status: STARTED
[09:10:49.714] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:5:0) after 6m23s
[09:17:13.073] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:5:0)
[09:17:13.154] Build status: STARTED
[09:17:13.154] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:6:0) after 3m10s
[09:20:23.560] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:6:0)
[09:20:23.591] Build status: STARTED
[09:20:23.591] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:7:0) after 5m30s
[09:25:53.608] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:7:0)
[09:25:53.635] Build status: STARTED
[09:25:53.635] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:8:0) after 3m8s
[09:29:01.655] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:8:0)
[09:29:01.682] Build status: STARTED
[09:29:01.682] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:9:0) after 1m0s
[09:30:01.919] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:9:0)
[09:30:01.994] Build status: STARTED
[09:30:01.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:10:0) after 4m27s
[09:34:29.364] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:10:0)
[09:34:29.425] Build status: STARTED
[09:34:29.425] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:11:0) after 1m24s
[09:35:53.438] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:11:0)
[09:35:53.458] Build status: STARTED
[09:35:53.458] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:12:0) after 9m23s
[09:45:16.639] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:12:0)
[09:45:16.666] Build status: STARTED
[09:45:16.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:13:0) after 7m12s
[09:52:28.684] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:13:0)
[09:52:28.837] Build status: STARTED
[09:52:28.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:14:0) after 7m50s
[10:00:19.015] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:14:0)
[10:00:19.057] Build status: STARTED
[10:00:19.057] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8930528238101173664:15:0) after 1m22s
[10:01:38.885] Received PubSub notification, asking Buildbucket for the build status
[10:01:38.909] Build:
{
"id": "8765098175749268673",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-07T09:06:51.216320186Z",
"startTime": "2023-11-07T09:06:52.229174Z",
"endTime": "2023-11-07T10:01:38.232211Z",
"updateTime": "2023-11-07T10:01:38.232211Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "df1e39489e3c751eeba633f17ec94be393a8a165",
"ref": "refs/heads/main"
}
}
}
[10:01:38.909] Invocation finished in 54m49.319367127s with status SUCCEEDED