[13:47:21.854] New invocation is queued and will start shortly
[13:47:21.854] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[13:47:22.951] Starting the invocation (attempt 1)
[13:47:22.978] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9ebf2f8a67cce570d0752556fed23ff2803aef33"
[13:47:22.978] Reconstructed gitiles commit from tags
[13:47:22.978] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:47:22.978] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:47:22.979] Buildbucket request:
{
"requestId": "8914565522113939184",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6c59dc7695e4a4bf59abd3a47bad7d581555af93dee4591d0e1c6734f948fdeb/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4beba15e9c9c5a65f74fec712eba0439544b0a15",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8914565522113939184",
"job": "fuchsia/clang_toolchain.ci.core.x64-release",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "dbae13b1ec1f7dbd653d49daef24d82a0bbc9cd2b707def7c8a892346f24f36c/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4beba15e9c9c5a65f74fec712eba0439544b0a15",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "803e03fbb7cd97461f349fb6e235592681fc1e6c"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/803e03fbb7cd97461f349fb6e235592681fc1e6c",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "2abcd877-9871-4a00-8e12-f244cae7cd11",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "00d1fff34d41d3fa3ff18615f384290ceecc85d00bfb870074fb6e67d0d43101/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4beba15e9c9c5a65f74fec712eba0439544b0a15",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "df241b19c952b904eec755d9f090737aed437986"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/df241b19c952b904eec755d9f090737aed437986",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "938bb8e1-496d-4d90-9171-ee43eb732e50",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "8600d26d30387d93f799169e394d600dea659d86e4ef7f323b7d11c48e6fce04/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4beba15e9c9c5a65f74fec712eba0439544b0a15",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "efce8a05aa4ef0353e73e63d270a22773e090e75"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/efce8a05aa4ef0353e73e63d270a22773e090e75",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "80a4ed83-ecf3-48e3-9265-8c8b6e01f73f",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6c59dc7695e4a4bf59abd3a47bad7d581555af93dee4591d0e1c6734f948fdeb/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4beba15e9c9c5a65f74fec712eba0439544b0a15",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "9ebf2f8a67cce570d0752556fed23ff2803aef33"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9ebf2f8a67cce570d0752556fed23ff2803aef33",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "eb1c1531-0cd3-4656-9219-535d5966215a",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "9ebf2f8a67cce570d0752556fed23ff2803aef33"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9ebf2f8a67cce570d0752556fed23ff2803aef33",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914565522113939184"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.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"
}
}
[13:47:23.655] Scheduled build:
{
"id": "8749135460159015825",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-01T13:47:23.095493159Z",
"updateTime": "2024-05-01T13:47:23.095493159Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9ebf2f8a67cce570d0752556fed23ff2803aef33",
"ref": "refs/heads/main"
}
}
}
[13:47:23.655] Task URL: https://cr-buildbucket.appspot.com/build/8749135460159015825
[13:47:23.655] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:2:0) after 4m59s
[13:47:24.673] Received PubSub notification, asking Buildbucket for the build status
[13:47:24.711] Build status: SCHEDULED
[13:48:38.784] Received PubSub notification, asking Buildbucket for the build status
[13:48:38.869] Build status: STARTED
[13:52:22.888] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:2:0)
[13:52:22.929] Build status: STARTED
[13:52:22.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:5:0) after 4m22s
[13:56:44.949] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:5:0)
[13:56:45.054] Build status: STARTED
[13:56:45.054] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:6:0) after 7m55s
[14:04:40.095] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:6:0)
[14:04:40.118] Build status: STARTED
[14:04:40.118] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:7:0) after 8m25s
[14:13:05.142] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:7:0)
[14:13:05.168] Build status: STARTED
[14:13:05.169] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:8:0) after 7m38s
[14:20:43.194] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:8:0)
[14:20:43.214] Build status: STARTED
[14:20:43.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:9:0) after 5m48s
[14:26:31.307] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:9:0)
[14:26:31.325] Build status: STARTED
[14:26:31.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:10:0) after 5m5s
[14:31:36.341] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:10:0)
[14:31:36.362] Build status: STARTED
[14:31:36.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:11:0) after 1m28s
[14:33:04.417] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:11:0)
[14:33:04.565] Build status: STARTED
[14:33:04.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:12:0) after 3m49s
[14:36:53.664] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:12:0)
[14:36:53.680] Build status: STARTED
[14:36:53.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:13:0) after 2m39s
[14:39:32.800] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:13:0)
[14:39:32.837] Build status: STARTED
[14:39:32.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:14:0) after 4m36s
[14:44:09.502] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:14:0)
[14:44:09.528] Build status: STARTED
[14:44:09.528] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:15:0) after 7m59s
[14:52:08.734] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:15:0)
[14:52:08.815] Build status: STARTED
[14:52:08.815] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:16:0) after 6m28s
[14:58:36.958] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:16:0)
[14:58:36.982] Build status: STARTED
[14:58:36.982] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:17:0) after 3m11s
[15:01:48.258] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:17:0)
[15:01:48.430] Build status: STARTED
[15:01:48.430] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:18:0) after 2m53s
[15:04:41.764] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:18:0)
[15:04:41.790] Build status: STARTED
[15:04:41.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:19:0) after 1m37s
[15:06:18.811] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:19:0)
[15:06:18.832] Build status: STARTED
[15:06:18.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:20:0) after 2m8s
[15:08:27.023] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:20:0)
[15:08:27.083] Build status: STARTED
[15:08:27.083] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:21:0) after 2m31s
[15:10:58.307] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:21:0)
[15:10:58.334] Build status: STARTED
[15:10:58.334] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:22:0) after 9m45s
[15:20:43.442] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:22:0)
[15:20:43.460] Build status: STARTED
[15:20:43.460] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:23:0) after 6m31s
[15:27:14.538] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:23:0)
[15:27:14.584] Build status: STARTED
[15:27:14.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:24:0) after 9m13s
[15:36:27.712] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:24:0)
[15:36:27.745] Build status: STARTED
[15:36:27.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:25:0) after 5m11s
[15:41:38.767] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:25:0)
[15:41:38.788] Build status: STARTED
[15:41:38.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:26:0) after 5m0s
[15:46:38.891] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:26:0)
[15:46:38.922] Build status: STARTED
[15:46:38.922] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:27:0) after 6m15s
[15:52:53.972] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:27:0)
[15:52:53.996] Build status: STARTED
[15:52:53.996] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:28:0) after 4m46s
[15:57:40.059] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:28:0)
[15:57:40.083] Build status: STARTED
[15:57:40.083] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:29:0) after 5m14s
[16:02:54.136] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:29:0)
[16:02:54.158] Build status: STARTED
[16:02:54.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:30:0) after 1m28s
[16:04:22.138] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:30:0)
[16:04:22.162] Build status: STARTED
[16:04:22.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:31:0) after 7m31s
[16:11:53.238] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:31:0)
[16:11:53.270] Build status: STARTED
[16:11:53.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8914565522113939184:32:0) after 9m54s
[16:13:55.810] Received PubSub notification, asking Buildbucket for the build status
[16:13:55.854] Build:
{
"id": "8749135460159015825",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-01T13:47:23.095493159Z",
"startTime": "2024-05-01T13:48:38.521075653Z",
"endTime": "2024-05-01T16:13:55.407967958Z",
"updateTime": "2024-05-01T16:13:55.407967958Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9ebf2f8a67cce570d0752556fed23ff2803aef33",
"ref": "refs/heads/main"
}
}
}
[16:13:55.854] Invocation finished in 2h26m34.007592756s with status SUCCEEDED