[05:57:36.846] New invocation is queued and will start shortly
[05:57:38.053] Starting the invocation (attempt 1)
[05:57:38.078] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/bc9823cf60bf91cc8b45248c4205cd2c67b2a3d5"
[05:57:38.078] Popped gitiles commit info from properties and tags
[05:57:38.078] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:57:38.078] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:57:38.078] Buildbucket request:
{
"requestId": "8913145524781972080",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8913145524781972080",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d395b56a52e9809ec3ea1139f5b30698c9f4e247"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d395b56a52e9809ec3ea1139f5b30698c9f4e247",
"title": "d395b56a52e9809ec3ea1139f5b30698c9f4e247",
"url": "https://llvm.googlesource.com/llvm-project/+/d395b56a52e9809ec3ea1139f5b30698c9f4e247"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aaa8a8000009890b79effb0d0f3c6f989a3d5563"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aaa8a8000009890b79effb0d0f3c6f989a3d5563",
"title": "aaa8a8000009890b79effb0d0f3c6f989a3d5563",
"url": "https://llvm.googlesource.com/llvm-project/+/aaa8a8000009890b79effb0d0f3c6f989a3d5563"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a26fbf36a78a703be2da0744131a8d6ecbdb7c67"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a26fbf36a78a703be2da0744131a8d6ecbdb7c67",
"title": "a26fbf36a78a703be2da0744131a8d6ecbdb7c67",
"url": "https://llvm.googlesource.com/llvm-project/+/a26fbf36a78a703be2da0744131a8d6ecbdb7c67"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f4066fa2dd21c65bf0e24a479634c9a2d276cf8e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f4066fa2dd21c65bf0e24a479634c9a2d276cf8e",
"title": "f4066fa2dd21c65bf0e24a479634c9a2d276cf8e",
"url": "https://llvm.googlesource.com/llvm-project/+/f4066fa2dd21c65bf0e24a479634c9a2d276cf8e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "14030d71693b046784ff19cc157074e4db23e74f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@14030d71693b046784ff19cc157074e4db23e74f",
"title": "14030d71693b046784ff19cc157074e4db23e74f",
"url": "https://llvm.googlesource.com/llvm-project/+/14030d71693b046784ff19cc157074e4db23e74f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f71749c5ef8667e3fc23820e8e94864653ea9ac9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f71749c5ef8667e3fc23820e8e94864653ea9ac9",
"title": "f71749c5ef8667e3fc23820e8e94864653ea9ac9",
"url": "https://llvm.googlesource.com/llvm-project/+/f71749c5ef8667e3fc23820e8e94864653ea9ac9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9bffe790499e99a4110a33988100ba45835e905e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9bffe790499e99a4110a33988100ba45835e905e",
"title": "9bffe790499e99a4110a33988100ba45835e905e",
"url": "https://llvm.googlesource.com/llvm-project/+/9bffe790499e99a4110a33988100ba45835e905e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bc9823cf60bf91cc8b45248c4205cd2c67b2a3d5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bc9823cf60bf91cc8b45248c4205cd2c67b2a3d5",
"title": "bc9823cf60bf91cc8b45248c4205cd2c67b2a3d5",
"url": "https://llvm.googlesource.com/llvm-project/+/bc9823cf60bf91cc8b45248c4205cd2c67b2a3d5"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "bc9823cf60bf91cc8b45248c4205cd2c67b2a3d5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8913145524781972080"
},
{
"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"
}
}
[05:57:38.600] Scheduled build:
{
"id": "8747715462765266081",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-17T05:57:38.138029914Z",
"updateTime": "2024-05-17T05:57:38.138029914Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "bc9823cf60bf91cc8b45248c4205cd2c67b2a3d5",
"ref": "refs/heads/main"
}
}
}
[05:57:38.600] Task URL: https://cr-buildbucket.appspot.com/build/8747715462765266081
[05:57:38.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:2:0) after 7m41s
[05:57:39.537] Received PubSub notification, asking Buildbucket for the build status
[05:57:39.615] Build status: SCHEDULED
[05:58:30.777] Received PubSub notification, asking Buildbucket for the build status
[05:58:30.801] Build status: STARTED
[06:05:19.702] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:2:0)
[06:05:19.725] Build status: STARTED
[06:05:19.725] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:5:0) after 4m58s
[06:10:17.853] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:5:0)
[06:10:17.877] Build status: STARTED
[06:10:17.877] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:6:0) after 1m45s
[06:12:02.957] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:6:0)
[06:12:02.994] Build status: STARTED
[06:12:02.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:7:0) after 3m24s
[06:15:27.085] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:7:0)
[06:15:27.117] Build status: STARTED
[06:15:27.117] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:8:0) after 6m54s
[06:22:21.316] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:8:0)
[06:22:21.334] Build status: STARTED
[06:22:21.334] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:9:0) after 7m51s
[06:30:12.430] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:9:0)
[06:30:12.485] Build status: STARTED
[06:30:12.485] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:10:0) after 4m18s
[06:34:30.508] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:10:0)
[06:34:30.530] Build status: STARTED
[06:34:30.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:11:0) after 1m37s
[06:36:07.566] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:11:0)
[06:36:07.584] Build status: STARTED
[06:36:07.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:12:0) after 2m20s
[06:38:27.605] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:12:0)
[06:38:27.689] Build status: STARTED
[06:38:27.689] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:13:0) after 6m2s
[06:44:30.084] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:13:0)
[06:44:30.122] Build status: STARTED
[06:44:30.122] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:14:0) after 2m26s
[06:46:56.200] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:14:0)
[06:46:56.243] Build status: STARTED
[06:46:56.243] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:15:0) after 8m47s
[06:55:43.532] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:15:0)
[06:55:43.552] Build status: STARTED
[06:55:43.553] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:16:0) after 6m38s
[07:02:21.712] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:16:0)
[07:02:21.729] Build status: STARTED
[07:02:21.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:17:0) after 6m17s
[07:08:38.907] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:17:0)
[07:08:39.152] Build status: STARTED
[07:08:39.152] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:18:0) after 5m8s
[07:13:47.180] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:18:0)
[07:13:47.197] Build status: STARTED
[07:13:47.198] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:19:0) after 7m26s
[07:21:13.214] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:19:0)
[07:21:13.234] Build status: STARTED
[07:21:13.234] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913145524781972080:20:0) after 2m57s
[07:23:10.726] Received PubSub notification, asking Buildbucket for the build status
[07:23:10.745] Build:
{
"id": "8747715462765266081",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-17T05:57:38.138029914Z",
"startTime": "2024-05-17T05:58:30.617758012Z",
"endTime": "2024-05-17T07:23:10.066422805Z",
"updateTime": "2024-05-17T07:23:10.066422805Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "bc9823cf60bf91cc8b45248c4205cd2c67b2a3d5",
"ref": "refs/heads/main"
}
}
}
[07:23:10.745] Invocation finished in 1h25m33.912338839s with status SUCCEEDED