[20:50:17.204] New invocation is queued and will start shortly
[20:50:17.204] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[20:50:19.431] Starting the invocation (attempt 1)
[20:50:19.462] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/3efb0274b7d90d675594a7a2735bdfed0a994fde"
[20:50:19.462] Reconstructed gitiles commit from tags
[20:50:19.462] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:50:19.462] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:50:19.463] Buildbucket request:
{
"requestId": "8958387845877742448",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "7f3a5fac204c294f282801659214d06347cfb7f7e6d1d241edc7cc0f365464b9/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "bdf882916c18eeb6115d199c0b42bf24ca44683e",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8958387845877742448",
"job": "fuchsia/clang_toolchain.ci.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "4b06daaef7b067ad00ccf0dc1b9883db5c7825baf91b622dc5f40317308f128c/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "7e19140286ab6112bb90998fc6abe07de79971cc",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "26fec4e845a833214d2b0036ea90f1b1c2418d50"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/26fec4e845a833214d2b0036ea90f1b1c2418d50",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "520443ba-913f-4ce2-915f-82c65f1c2ed5",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "b1126410781a5822d4339e65f5a4a369e80e86a677dff27508dc3db66362cfd2/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "7e19140286ab6112bb90998fc6abe07de79971cc",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "e35c7f1eaf5d89f65c0b82d9a860d654ffeca4d2"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e35c7f1eaf5d89f65c0b82d9a860d654ffeca4d2",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "5664f667-56ec-4445-9287-99c03a945bca",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "7f3a5fac204c294f282801659214d06347cfb7f7e6d1d241edc7cc0f365464b9/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "bdf882916c18eeb6115d199c0b42bf24ca44683e",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "3efb0274b7d90d675594a7a2735bdfed0a994fde"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/3efb0274b7d90d675594a7a2735bdfed0a994fde",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "da5b17dc-df24-4730-bb10-37a5991caf6b",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "3efb0274b7d90d675594a7a2735bdfed0a994fde"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3efb0274b7d90d675594a7a2735bdfed0a994fde",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8958387845877742448"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.arm64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "clang-linux-x64"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:50:19.783] Scheduled build:
{
"id": "8792957782753771009",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-01-03T20:50:19.551088433Z",
"updateTime": "2023-01-03T20:50:19.551088433Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3efb0274b7d90d675594a7a2735bdfed0a994fde",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:50:19.783] Task URL: https://cr-buildbucket.appspot.com/build/8792957782753771009
[20:50:19.783] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:2:0) after 3m11s
[20:51:26.827] Received PubSub notification, asking Buildbucket for the build status
[20:51:26.916] Build status: STARTED
[20:53:31.033] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:2:0)
[20:53:31.066] Build status: STARTED
[20:53:31.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:4:0) after 4m46s
[20:58:17.288] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:4:0)
[20:58:17.446] Build status: STARTED
[20:58:17.446] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:5:0) after 3m20s
[21:01:38.208] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:5:0)
[21:01:38.241] Build status: STARTED
[21:01:38.241] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:6:0) after 1m1s
[21:02:39.470] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:6:0)
[21:02:39.504] Build status: STARTED
[21:02:39.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:7:0) after 1m44s
[21:04:23.562] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:7:0)
[21:04:23.624] Build status: STARTED
[21:04:23.624] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:8:0) after 2m28s
[21:06:51.679] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:8:0)
[21:06:51.732] Build status: STARTED
[21:06:51.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:9:0) after 7m12s
[21:14:03.862] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:9:0)
[21:14:03.883] Build status: STARTED
[21:14:03.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:10:0) after 6m58s
[21:21:02.119] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:10:0)
[21:21:02.144] Build status: STARTED
[21:21:02.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:11:0) after 3m31s
[21:24:33.264] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:11:0)
[21:24:33.290] Build status: STARTED
[21:24:33.290] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:12:0) after 7m21s
[21:31:54.377] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:12:0)
[21:31:54.404] Build status: STARTED
[21:31:54.404] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:13:0) after 2m36s
[21:34:30.522] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:13:0)
[21:34:30.547] Build status: STARTED
[21:34:30.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:14:0) after 2m30s
[21:37:00.757] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:14:0)
[21:37:00.956] Build status: STARTED
[21:37:00.956] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:15:0) after 7m19s
[21:44:20.602] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:15:0)
[21:44:20.628] Build status: STARTED
[21:44:20.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:16:0) after 4m58s
[21:49:18.706] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:16:0)
[21:49:18.731] Build status: STARTED
[21:49:18.731] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:17:0) after 4m11s
[21:53:29.994] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:17:0)
[21:53:30.015] Build status: STARTED
[21:53:30.015] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:18:0) after 6m4s
[21:59:34.424] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:18:0)
[21:59:34.509] Build status: STARTED
[21:59:34.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:19:0) after 3m55s
[22:03:29.557] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:19:0)
[22:03:29.582] Build status: STARTED
[22:03:29.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:20:0) after 5m34s
[22:09:03.693] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:20:0)
[22:09:03.722] Build status: STARTED
[22:09:03.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:21:0) after 1m30s
[22:10:33.737] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:21:0)
[22:10:33.765] Build status: STARTED
[22:10:33.765] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:22:0) after 7m4s
[22:17:37.769] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:22:0)
[22:17:37.803] Build status: STARTED
[22:17:37.803] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:23:0) after 6m36s
[22:24:14.064] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:23:0)
[22:24:14.093] Build status: STARTED
[22:24:14.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:24:0) after 3m14s
[22:27:28.156] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:24:0)
[22:27:28.183] Build status: STARTED
[22:27:28.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:25:0) after 1m24s
[22:28:52.271] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:25:0)
[22:28:52.295] Build status: STARTED
[22:28:52.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:26:0) after 1m57s
[22:30:49.491] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:26:0)
[22:30:49.737] Build status: STARTED
[22:30:49.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:27:0) after 9m45s
[22:40:34.762] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:27:0)
[22:40:34.796] Build status: STARTED
[22:40:34.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:28:0) after 7m9s
[22:47:43.776] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:28:0)
[22:47:43.807] Build status: STARTED
[22:47:43.807] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:29:0) after 5m25s
[22:53:08.834] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:29:0)
[22:53:08.855] Build status: STARTED
[22:53:08.855] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8958387845877742448:30:0) after 6m12s
[22:55:54.076] Received PubSub notification, asking Buildbucket for the build status
[22:55:54.101] Build:
{
"id": "8792957782753771009",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-01-03T20:50:19.551088433Z",
"startTime": "2023-01-03T20:51:26.273383Z",
"endTime": "2023-01-03T22:55:53.704359190Z",
"updateTime": "2023-01-03T22:55:53.704359190Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3efb0274b7d90d675594a7a2735bdfed0a994fde",
"ref": "refs/heads/main"
}
},
"canary": true
}
[22:55:54.101] Invocation finished in 2h5m36.912470079s with status SUCCEEDED