[08:35:29.250] New invocation is queued and will start shortly
[08:35:29.250] Triggered by user:fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com
[08:35:30.416] Starting the invocation (attempt 1)
[08:35:30.448] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/049630d0ae805d56b9587024d2542e7e08c9e1d2"
[08:35:30.448] Reconstructed gitiles commit from tags
[08:35:30.448] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:35:30.448] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:35:30.448] Buildbucket request:
{
"requestId": "8910236489312270144",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-release"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "1b37705bc4f16db379c021ef6dcb7c2efcb7a456f44c77737da0f1f0e8dff7f6/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "5eb11c688d88996e6251a869037923a0a76aa6f1",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8910236489312270144",
"job": "fuchsia/clang_toolchain.prod.core.x64-release",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "1b37705bc4f16db379c021ef6dcb7c2efcb7a456f44c77737da0f1f0e8dff7f6/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "5eb11c688d88996e6251a869037923a0a76aa6f1",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "049630d0ae805d56b9587024d2542e7e08c9e1d2"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/049630d0ae805d56b9587024d2542e7e08c9e1d2",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "2e078122-23a7-4718-8042-1b8b81486baa",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "049630d0ae805d56b9587024d2542e7e08c9e1d2"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "049630d0ae805d56b9587024d2542e7e08c9e1d2",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8910236489312270144"
},
{
"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"
}
}
[08:35:30.897] Scheduled build:
{
"id": "8744806427344873105",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-18T08:35:30.504673624Z",
"updateTime": "2024-06-18T08:35:30.504673624Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "049630d0ae805d56b9587024d2542e7e08c9e1d2",
"ref": "refs/heads/main"
}
}
}
[08:35:30.897] Task URL: https://cr-buildbucket.appspot.com/build/8744806427344873105
[08:35:30.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:2:0) after 6m36s
[08:36:33.957] Received PubSub notification, asking Buildbucket for the build status
[08:36:33.995] Build status: STARTED
[08:36:45.292] Received PubSub notification, asking Buildbucket for the build status
[08:36:45.392] Build status: STARTED
[08:42:06.964] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:2:0)
[08:42:07.007] Build status: STARTED
[08:42:07.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:5:0) after 7m52s
[08:49:59.164] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:5:0)
[08:49:59.213] Build status: STARTED
[08:49:59.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:6:0) after 2m53s
[08:52:52.611] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:6:0)
[08:52:52.631] Build status: STARTED
[08:52:52.631] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:7:0) after 4m16s
[08:57:09.275] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:7:0)
[08:57:09.297] Build status: STARTED
[08:57:09.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:8:0) after 5m4s
[09:02:13.384] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:8:0)
[09:02:13.399] Build status: STARTED
[09:02:13.400] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:9:0) after 1m42s
[09:03:55.433] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:9:0)
[09:03:55.451] Build status: STARTED
[09:03:55.451] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:10:0) after 2m30s
[09:06:25.690] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:10:0)
[09:06:25.715] Build status: STARTED
[09:06:25.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:11:0) after 3m5s
[09:09:30.740] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:11:0)
[09:09:30.758] Build status: STARTED
[09:09:30.758] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:12:0) after 3m6s
[09:12:36.776] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:12:0)
[09:12:36.797] Build status: STARTED
[09:12:36.797] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:13:0) after 7m48s
[09:20:24.912] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:13:0)
[09:20:24.928] Build status: STARTED
[09:20:24.928] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:14:0) after 8m41s
[09:29:06.031] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:14:0)
[09:29:06.047] Build status: STARTED
[09:29:06.048] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:15:0) after 4m35s
[09:33:41.073] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:15:0)
[09:33:41.096] Build status: STARTED
[09:33:41.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:16:0) after 1m17s
[09:34:58.141] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:16:0)
[09:34:58.162] Build status: STARTED
[09:34:58.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:17:0) after 3m53s
[09:38:51.202] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:17:0)
[09:38:51.236] Build status: STARTED
[09:38:51.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:18:0) after 7m58s
[09:46:49.551] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:18:0)
[09:46:49.572] Build status: STARTED
[09:46:49.572] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:19:0) after 2m38s
[09:49:27.587] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:19:0)
[09:49:27.700] Build status: STARTED
[09:49:27.700] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:20:0) after 3m36s
[09:53:04.177] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:20:0)
[09:53:04.196] Build status: STARTED
[09:53:04.196] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:21:0) after 6m35s
[09:59:39.505] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:21:0)
[09:59:39.567] Build status: STARTED
[09:59:39.567] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:22:0) after 7m0s
[10:06:39.633] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:22:0)
[10:06:39.665] Build status: STARTED
[10:06:39.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:23:0) after 3m37s
[10:10:17.514] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:23:0)
[10:10:17.532] Build status: STARTED
[10:10:17.532] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:24:0) after 6m32s
[10:16:49.549] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:24:0)
[10:16:49.612] Build status: STARTED
[10:16:49.613] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:25:0) after 2m38s
[10:19:27.711] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:25:0)
[10:19:27.728] Build status: STARTED
[10:19:27.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:26:0) after 2m45s
[10:22:12.925] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:26:0)
[10:22:12.944] Build status: STARTED
[10:22:12.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:27:0) after 1m49s
[10:24:01.971] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:27:0)
[10:24:01.992] Build status: STARTED
[10:24:01.992] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:28:0) after 4m57s
[10:28:59.059] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:28:0)
[10:28:59.076] Build status: STARTED
[10:28:59.076] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:29:0) after 1m9s
[10:30:08.093] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:29:0)
[10:30:08.114] Build status: STARTED
[10:30:08.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:30:0) after 8m3s
[10:38:11.116] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:30:0)
[10:38:11.136] Build status: STARTED
[10:38:11.136] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:31:0) after 9m49s
[10:48:00.217] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:31:0)
[10:48:00.237] Build status: STARTED
[10:48:00.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:32:0) after 3m10s
[10:51:10.260] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:32:0)
[10:51:10.287] Build status: STARTED
[10:51:10.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:33:0) after 7m50s
[10:59:00.287] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:33:0)
[10:59:00.323] Build status: STARTED
[10:59:00.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:34:0) after 8m36s
[11:07:36.343] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:34:0)
[11:07:36.376] Build status: STARTED
[11:07:36.376] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-release:8910236489312270144:35:0) after 1m40s
[11:08:47.418] Received PubSub notification, asking Buildbucket for the build status
[11:08:47.443] Build:
{
"id": "8744806427344873105",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-18T08:35:30.504673624Z",
"startTime": "2024-06-18T08:35:36.182183925Z",
"endTime": "2024-06-18T11:08:40.765482391Z",
"updateTime": "2024-06-18T11:08:40.765482391Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "049630d0ae805d56b9587024d2542e7e08c9e1d2",
"ref": "refs/heads/main"
}
}
}
[11:08:47.443] Invocation finished in 2h33m18.198124063s with status SUCCEEDED