[18:31:09.614] New invocation is queued and will start shortly
[18:31:09.614] Triggered by user:fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com
[18:31:10.692] Starting the invocation (attempt 1)
[18:31:10.719] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ff74236f342c7bc185f56a07bab7bd0cf356c7c6"
[18:31:10.719] Reconstructed gitiles commit from tags
[18:31:10.719] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:31:10.719] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:31:10.719] Buildbucket request:
{
"requestId": "8916359606540006256",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-release"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "465f743a55763c11a8980f87a6b2e6a009a101827490d1fc9e2c3347f33d500a/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "bb3b68b2720f76481a9ea001e174f0d88f278c21",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8916359606540006256",
"job": "fuchsia/clang_toolchain.prod.core.x64-release",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "465f743a55763c11a8980f87a6b2e6a009a101827490d1fc9e2c3347f33d500a/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "bb3b68b2720f76481a9ea001e174f0d88f278c21",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "ff74236f342c7bc185f56a07bab7bd0cf356c7c6"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ff74236f342c7bc185f56a07bab7bd0cf356c7c6",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "4f4d0955-1513-42fa-952f-d335119d7c64",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "ff74236f342c7bc185f56a07bab7bd0cf356c7c6"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ff74236f342c7bc185f56a07bab7bd0cf356c7c6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8916359606540006256"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.prod.core.x64-release"
},
{
"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"
}
}
[18:31:11.441] Scheduled build:
{
"id": "8750929544665741537",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-11T18:31:10.779297894Z",
"updateTime": "2024-04-11T18:31:10.779297894Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ff74236f342c7bc185f56a07bab7bd0cf356c7c6",
"ref": "refs/heads/main"
}
}
}
[18:31:11.442] Task URL: https://cr-buildbucket.appspot.com/build/8750929544665741537
[18:31:11.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:2:0) after 8m0s
[18:31:12.536] Received PubSub notification, asking Buildbucket for the build status
[18:31:12.570] Build status: SCHEDULED
[18:32:22.716] Received PubSub notification, asking Buildbucket for the build status
[18:32:22.787] Build status: STARTED
[18:39:11.520] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:2:0)
[18:39:11.544] Build status: STARTED
[18:39:11.544] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:5:0) after 9m27s
[18:48:38.749] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:5:0)
[18:48:38.774] Build status: STARTED
[18:48:38.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:6:0) after 7m36s
[18:56:14.849] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:6:0)
[18:56:14.880] Build status: STARTED
[18:56:14.880] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:7:0) after 4m8s
[19:00:22.913] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:7:0)
[19:00:22.979] Build status: STARTED
[19:00:22.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:8:0) after 9m4s
[19:09:26.961] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:8:0)
[19:09:26.990] Build status: STARTED
[19:09:26.990] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:9:0) after 2m59s
[19:12:26.069] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:9:0)
[19:12:26.172] Build status: STARTED
[19:12:26.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:10:0) after 6m45s
[19:19:11.461] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:10:0)
[19:19:11.531] Build status: STARTED
[19:19:11.532] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:11:0) after 5m0s
[19:24:11.980] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:11:0)
[19:24:12.016] Build status: STARTED
[19:24:12.016] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:12:0) after 5m57s
[19:30:09.045] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:12:0)
[19:30:09.070] Build status: STARTED
[19:30:09.070] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:13:0) after 2m45s
[19:32:54.090] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:13:0)
[19:32:54.110] Build status: STARTED
[19:32:54.110] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:14:0) after 7m48s
[19:40:43.587] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:14:0)
[19:40:43.606] Build status: STARTED
[19:40:43.606] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:15:0) after 5m34s
[19:46:17.639] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:15:0)
[19:46:17.695] Build status: STARTED
[19:46:17.695] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:16:0) after 9m47s
[19:56:04.840] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:16:0)
[19:56:04.900] Build status: STARTED
[19:56:04.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:17:0) after 7m31s
[20:03:36.155] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:17:0)
[20:03:36.217] Build status: STARTED
[20:03:36.217] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:18:0) after 2m37s
[20:06:13.266] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:18:0)
[20:06:13.359] Build status: STARTED
[20:06:13.359] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:19:0) after 3m8s
[20:09:21.371] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:19:0)
[20:09:21.419] Build status: STARTED
[20:09:21.419] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:20:0) after 4m43s
[20:14:04.458] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:20:0)
[20:14:04.555] Build status: STARTED
[20:14:04.555] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:21:0) after 2m54s
[20:16:59.045] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:21:0)
[20:16:59.067] Build status: STARTED
[20:16:59.067] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:22:0) after 6m39s
[20:23:38.093] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:22:0)
[20:23:38.137] Build status: STARTED
[20:23:38.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:23:0) after 8m10s
[20:31:48.153] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:23:0)
[20:31:48.241] Build status: STARTED
[20:31:48.241] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8916359606540006256:24:0) after 9m28s
[20:36:05.324] Received PubSub notification, asking Buildbucket for the build status
[20:36:05.354] Build:
{
"id": "8750929544665741537",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-11T18:31:10.779297894Z",
"startTime": "2024-04-11T18:32:22.434682834Z",
"endTime": "2024-04-11T20:36:04.886025113Z",
"updateTime": "2024-04-11T20:36:04.886025113Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ff74236f342c7bc185f56a07bab7bd0cf356c7c6",
"ref": "refs/heads/main"
}
}
}
[20:36:05.354] Invocation finished in 2h4m55.746092837s with status SUCCEEDED