[22:53:00.477] New invocation is queued and will start shortly
[22:53:00.477] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[22:53:01.586] Starting the invocation (attempt 1)
[22:53:01.612] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/58e8147d1690485ed0a6fcb59c7b6ea4b8cd2936"
[22:53:01.612] Reconstructed gitiles commit from tags
[22:53:01.612] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:53:01.612] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:53:01.613] Buildbucket request:
{
"requestId": "8922050741407482352",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "d5311df6e2a2f12483296e9d3e04f6a628a8018cafc5a969466188168cd4589c/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "522801774dc589fcc28f93a1b50313104559e8f5",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8922050741407482352",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "b727985122e6fa9f82e333620e9a3018449febfed5bc228ce9e48c0a146205b1/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "522801774dc589fcc28f93a1b50313104559e8f5",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "7c9c4983b1d493c2fdea76f99591f9ab49877306"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7c9c4983b1d493c2fdea76f99591f9ab49877306",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "37655c61-27ec-4cdc-bf4f-394cf0be2d57",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "d5311df6e2a2f12483296e9d3e04f6a628a8018cafc5a969466188168cd4589c/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "522801774dc589fcc28f93a1b50313104559e8f5",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "58e8147d1690485ed0a6fcb59c7b6ea4b8cd2936"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/58e8147d1690485ed0a6fcb59c7b6ea4b8cd2936",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "c42fabc0-2afa-4859-9b37-14c564258637",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "58e8147d1690485ed0a6fcb59c7b6ea4b8cd2936"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "58e8147d1690485ed0a6fcb59c7b6ea4b8cd2936",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8922050741407482352"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.x64-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"
}
}
[22:53:12.210] Scheduled build:
{
"id": "8756620679469449393",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-08T22:53:01.686785530Z",
"updateTime": "2024-02-08T22:53:01.686785530Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "58e8147d1690485ed0a6fcb59c7b6ea4b8cd2936",
"ref": "refs/heads/main"
}
}
}
[22:53:12.210] Task URL: https://cr-buildbucket.appspot.com/build/8756620679469449393
[22:53:12.210] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:2:0) after 4m53s
[22:53:13.210] Received PubSub notification, asking Buildbucket for the build status
[22:53:13.271] Build status: SCHEDULED
[22:53:32.935] Received PubSub notification, asking Buildbucket for the build status
[22:53:32.965] Build status: STARTED
[22:58:05.326] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:2:0)
[22:58:05.471] Build status: STARTED
[22:58:05.471] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:5:0) after 6m55s
[23:05:00.625] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:5:0)
[23:05:00.655] Build status: STARTED
[23:05:00.655] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:6:0) after 5m17s
[23:10:17.756] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:6:0)
[23:10:17.779] Build status: STARTED
[23:10:17.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:7:0) after 1m34s
[23:11:51.798] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:7:0)
[23:11:51.830] Build status: STARTED
[23:11:51.830] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:8:0) after 1m31s
[23:13:22.856] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:8:0)
[23:13:22.899] Build status: STARTED
[23:13:22.899] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:9:0) after 1m10s
[23:14:32.972] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:9:0)
[23:14:33.006] Build status: STARTED
[23:14:33.006] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:10:0) after 8m38s
[23:23:11.020] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:10:0)
[23:23:11.044] Build status: STARTED
[23:23:11.044] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:11:0) after 1m0s
[23:24:11.117] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:11:0)
[23:24:11.146] Build status: STARTED
[23:24:11.146] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:12:0) after 1m17s
[23:25:28.175] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:12:0)
[23:25:28.196] Build status: STARTED
[23:25:28.196] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:13:0) after 7m40s
[23:33:08.293] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:13:0)
[23:33:08.314] Build status: STARTED
[23:33:08.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:14:0) after 1m25s
[23:34:33.328] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:14:0)
[23:34:33.351] Build status: STARTED
[23:34:33.351] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:15:0) after 1m1s
[23:35:34.366] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:15:0)
[23:35:34.457] Build status: STARTED
[23:35:34.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:16:0) after 4m25s
[23:39:59.518] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:16:0)
[23:39:59.626] Build status: STARTED
[23:39:59.626] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:17:0) after 9m25s
[23:49:24.649] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:17:0)
[23:49:24.694] Build status: STARTED
[23:49:24.694] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:18:0) after 7m14s
[23:56:38.735] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:18:0)
[23:56:38.759] Build status: STARTED
[23:56:38.759] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:19:0) after 9m35s
[00:06:13.780] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:19:0)
[00:06:13.840] Build status: STARTED
[00:06:13.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:20:0) after 6m46s
[00:12:59.858] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:20:0)
[00:13:00.028] Build status: STARTED
[00:13:00.028] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:21:0) after 8m53s
[00:21:53.107] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:21:0)
[00:21:53.133] Build status: STARTED
[00:21:53.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:22:0) after 9m29s
[00:31:22.163] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:22:0)
[00:31:22.183] Build status: STARTED
[00:31:22.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:23:0) after 8m59s
[00:40:21.334] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:23:0)
[00:40:21.485] Build status: STARTED
[00:40:21.485] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922050741407482352:24:0) after 9m13s
[00:48:16.949] Received PubSub notification, asking Buildbucket for the build status
[00:48:16.981] Build:
{
"id": "8756620679469449393",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-08T22:53:01.686785530Z",
"startTime": "2024-02-08T22:53:32.445210Z",
"endTime": "2024-02-09T00:48:15.822728Z",
"updateTime": "2024-02-09T00:48:15.822728Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "58e8147d1690485ed0a6fcb59c7b6ea4b8cd2936",
"ref": "refs/heads/main"
}
}
}
[00:48:16.981] Invocation finished in 1h55m16.527265904s with status SUCCEEDED