[13:23:42.347] New invocation is queued and will start shortly
[13:23:42.347] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[13:23:43.590] Starting the invocation (attempt 1)
[13:23:43.620] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/cbfcfdf75e9939bc47ac7a7c11d2122a6ad426ed"
[13:23:43.620] Reconstructed gitiles commit from tags
[13:23:43.620] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:23:43.620] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:23:43.621] Buildbucket request:
{
"requestId": "8916197755975984512",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "7e2dc1bd4fbb686de74481f166a9176a0d9b21b607a05ab9980eef38238da6c1/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2a17c10e296173ea999be578b594a0ce74dfc0db",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8916197755975984512",
"job": "fuchsia/clang_toolchain.ci.core.x64-release",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "825d594810b2d02176d4750abdd967a6f2d77f9de1cc22ab974cc6d1f5aa01ce/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2a17c10e296173ea999be578b594a0ce74dfc0db",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "844b532713986999aa1ffed0883eff2d1339ec7a"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/844b532713986999aa1ffed0883eff2d1339ec7a",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "13003a7e-e72b-4d08-bba8-3252ad749b65",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "90161b2428c5c820caa3cc186e9156bd64a615c5d85ac79266c810c0c7ad562a/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2a17c10e296173ea999be578b594a0ce74dfc0db",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "910ec6ff6dd9ed031e31800c70740fdd17cc1c2a"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/910ec6ff6dd9ed031e31800c70740fdd17cc1c2a",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "b1f44722-8fee-4946-824b-23685eb8edfd",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "7e2dc1bd4fbb686de74481f166a9176a0d9b21b607a05ab9980eef38238da6c1/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2a17c10e296173ea999be578b594a0ce74dfc0db",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "cbfcfdf75e9939bc47ac7a7c11d2122a6ad426ed"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/cbfcfdf75e9939bc47ac7a7c11d2122a6ad426ed",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "e569ab96-982d-4768-857e-da129b2dc23d",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "cbfcfdf75e9939bc47ac7a7c11d2122a6ad426ed"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "cbfcfdf75e9939bc47ac7a7c11d2122a6ad426ed",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8916197755975984512"
},
{
"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:23:44.097] Scheduled build:
{
"id": "8750767693912589345",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-13T13:23:43.686170029Z",
"updateTime": "2024-04-13T13:23:43.686170029Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "cbfcfdf75e9939bc47ac7a7c11d2122a6ad426ed",
"ref": "refs/heads/main"
}
}
}
[13:23:44.097] Task URL: https://cr-buildbucket.appspot.com/build/8750767693912589345
[13:23:44.097] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:2:0) after 3m1s
[13:23:44.958] Received PubSub notification, asking Buildbucket for the build status
[13:23:44.981] Build status: SCHEDULED
[13:23:53.551] Received PubSub notification, asking Buildbucket for the build status
[13:23:53.578] Build status: STARTED
[13:26:45.115] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:2:0)
[13:26:45.154] Build status: STARTED
[13:26:45.154] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:5:0) after 4m50s
[13:31:35.324] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:5:0)
[13:31:35.358] Build status: STARTED
[13:31:35.358] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:6:0) after 1m25s
[13:33:00.377] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:6:0)
[13:33:00.417] Build status: STARTED
[13:33:00.417] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:7:0) after 7m31s
[13:40:31.445] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:7:0)
[13:40:31.495] Build status: STARTED
[13:40:31.495] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:8:0) after 4m56s
[13:45:27.565] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:8:0)
[13:45:27.586] Build status: STARTED
[13:45:27.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:9:0) after 4m33s
[13:50:00.873] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:9:0)
[13:50:00.903] Build status: STARTED
[13:50:00.903] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:10:0) after 1m20s
[13:51:20.939] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:10:0)
[13:51:20.964] Build status: STARTED
[13:51:20.964] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:11:0) after 1m14s
[13:52:34.979] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:11:0)
[13:52:35.019] Build status: STARTED
[13:52:35.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:12:0) after 7m22s
[13:59:57.039] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:12:0)
[13:59:57.061] Build status: STARTED
[13:59:57.061] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:13:0) after 1m14s
[14:01:11.272] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:13:0)
[14:01:11.444] Build status: STARTED
[14:01:11.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:14:0) after 1m40s
[14:02:51.451] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:14:0)
[14:02:51.470] Build status: STARTED
[14:02:51.470] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:15:0) after 9m1s
[14:11:52.513] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:15:0)
[14:11:52.542] Build status: STARTED
[14:11:52.542] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:16:0) after 9m13s
[14:21:05.548] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:16:0)
[14:21:05.567] Build status: STARTED
[14:21:05.567] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:17:0) after 6m30s
[14:27:35.572] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:17:0)
[14:27:35.597] Build status: STARTED
[14:27:35.597] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:18:0) after 7m34s
[14:35:09.618] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:18:0)
[14:35:09.675] Build status: STARTED
[14:35:09.675] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:19:0) after 7m5s
[14:42:14.950] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:19:0)
[14:42:14.975] Build status: STARTED
[14:42:14.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:20:0) after 8m38s
[14:50:52.994] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:20:0)
[14:50:53.045] Build status: STARTED
[14:50:53.045] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:21:0) after 5m14s
[14:56:07.166] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:21:0)
[14:56:07.193] Build status: STARTED
[14:56:07.193] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:22:0) after 5m49s
[15:01:56.234] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:22:0)
[15:01:56.439] Build status: STARTED
[15:01:56.439] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:23:0) after 5m34s
[15:07:30.558] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:23:0)
[15:07:30.613] Build status: STARTED
[15:07:30.613] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:24:0) after 2m24s
[15:09:54.922] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:24:0)
[15:09:54.993] Build status: STARTED
[15:09:54.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:25:0) after 7m26s
[15:17:21.014] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:25:0)
[15:17:21.049] Build status: STARTED
[15:17:21.049] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:26:0) after 5m19s
[15:22:40.120] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:26:0)
[15:22:40.138] Build status: STARTED
[15:22:40.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:27:0) after 8m38s
[15:31:18.430] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:27:0)
[15:31:18.453] Build status: STARTED
[15:31:18.453] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:28:0) after 3m28s
[15:34:46.608] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:28:0)
[15:34:46.637] Build status: STARTED
[15:34:46.637] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8916197755975984512:29:0) after 3m36s
[15:34:59.237] Received PubSub notification, asking Buildbucket for the build status
[15:34:59.255] Build:
{
"id": "8750767693912589345",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-13T13:23:43.686170029Z",
"startTime": "2024-04-13T13:23:52.087079222Z",
"endTime": "2024-04-13T15:34:58.718804527Z",
"updateTime": "2024-04-13T15:34:58.718804527Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "cbfcfdf75e9939bc47ac7a7c11d2122a6ad426ed",
"ref": "refs/heads/main"
}
}
}
[15:34:59.255] Invocation finished in 2h11m16.921151143s with status SUCCEEDED