[04:19:48.186] New invocation is queued and will start shortly
[04:19:48.186] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[04:19:49.221] Starting the invocation (attempt 1)
[04:19:49.255] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7700695739d078eff01aad6f4d40c933419d08bc"
[04:19:49.255] Reconstructed gitiles commit from tags
[04:19:49.255] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:19:49.255] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:19:49.255] Buildbucket request:
{
"requestId": "8892042585343169472",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "b06db202d09e1380e58dbe2cf077f9a2d2b83e352bad96880951a2506da467a6/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f4c1d96d1fdaa91b344818dfdf6dc7e3b76cce8a",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8892042585343169472",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "377b3609f44284f37f712b5f83fcd3a7727eaa8c0e18fe9521d64221a1b68762/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "badc906ad780019d39e2eaaef6722e1027070320",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a774adb017256ceae85ec92ce5148ed47e517540"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a774adb017256ceae85ec92ce5148ed47e517540",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "6acb5adb-1eaf-429c-86cc-56942a172030",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "34936eafb2466d90083495d3b13a0442d131dc933d18276748a3de484bca24d7/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "badc906ad780019d39e2eaaef6722e1027070320",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "ddba0365b33da70543f9add3037d7402371014c9"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ddba0365b33da70543f9add3037d7402371014c9",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "90f75b8c-4e3b-406a-b382-d596cb96a430",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "b96c4f3ebcc4a86e4e85b003c4574ae7e910863de0b17019cdea0abae83e066a/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "badc906ad780019d39e2eaaef6722e1027070320",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "2d9d291da0fb94c05b31de0b08ccb881dbead798"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2d9d291da0fb94c05b31de0b08ccb881dbead798",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "119f5ed9-151d-4480-92d1-edfd75425c85",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "a2181e24d6bf252901278b981bebb56e6901aaa2cd667bd3e3e4f0ec65e5711f/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "badc906ad780019d39e2eaaef6722e1027070320",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "3092ebcd1e2746ee8db22bf3746b2ad2fb7534dd"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/3092ebcd1e2746ee8db22bf3746b2ad2fb7534dd",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "5e6e71cc-3ebe-4c64-8b85-9f39773e8fc1",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "b06db202d09e1380e58dbe2cf077f9a2d2b83e352bad96880951a2506da467a6/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f4c1d96d1fdaa91b344818dfdf6dc7e3b76cce8a",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "7700695739d078eff01aad6f4d40c933419d08bc"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7700695739d078eff01aad6f4d40c933419d08bc",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "78a14f84-f81f-4f6c-b203-d865d8f180ba",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "7700695739d078eff01aad6f4d40c933419d08bc"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7700695739d078eff01aad6f4d40c933419d08bc",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8892042585343169472"
},
{
"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"
}
}
[04:19:49.623] Scheduled build:
{
"id": "8726612523509847553",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-05T04:19:49.307801234Z",
"updateTime": "2025-01-05T04:19:49.307801234Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7700695739d078eff01aad6f4d40c933419d08bc",
"ref": "refs/heads/main"
}
}
}
[04:19:49.623] Task URL: https://cr-buildbucket.appspot.com/build/8726612523509847553
[04:19:49.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:2:0) after 7m6s
[04:19:50.595] Received PubSub notification, asking Buildbucket for the build status
[04:19:50.613] Build status: SCHEDULED
[04:19:55.208] Received PubSub notification, asking Buildbucket for the build status
[04:19:55.231] Build status: STARTED
[04:26:55.645] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:2:0)
[04:26:55.677] Build status: STARTED
[04:26:55.677] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:5:0) after 1m50s
[04:28:45.697] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:5:0)
[04:28:45.724] Build status: STARTED
[04:28:45.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:6:0) after 8m40s
[04:37:25.740] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:6:0)
[04:37:25.757] Build status: STARTED
[04:37:25.758] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:7:0) after 7m38s
[04:45:03.829] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:7:0)
[04:45:03.856] Build status: STARTED
[04:45:03.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:8:0) after 5m16s
[04:50:19.910] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:8:0)
[04:50:19.926] Build status: STARTED
[04:50:19.926] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:9:0) after 5m1s
[04:55:20.946] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:9:0)
[04:55:20.969] Build status: STARTED
[04:55:20.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:10:0) after 4m47s
[05:00:08.020] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:10:0)
[05:00:08.041] Build status: STARTED
[05:00:08.041] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:11:0) after 5m8s
[05:05:16.181] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:11:0)
[05:05:16.209] Build status: STARTED
[05:05:16.209] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:12:0) after 5m29s
[05:10:45.260] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:12:0)
[05:10:45.277] Build status: STARTED
[05:10:45.277] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:13:0) after 3m11s
[05:13:56.297] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:13:0)
[05:13:56.326] Build status: STARTED
[05:13:56.326] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:14:0) after 2m15s
[05:16:11.355] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:14:0)
[05:16:11.373] Build status: STARTED
[05:16:11.373] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:15:0) after 8m32s
[05:24:43.443] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:15:0)
[05:24:43.507] Build status: STARTED
[05:24:43.507] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:16:0) after 4m49s
[05:29:32.496] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:16:0)
[05:29:32.515] Build status: STARTED
[05:29:32.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:17:0) after 6m33s
[05:36:05.542] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:17:0)
[05:36:05.555] Build status: STARTED
[05:36:05.555] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:18:0) after 8m1s
[05:44:06.721] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:18:0)
[05:44:06.745] Build status: STARTED
[05:44:06.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:19:0) after 9m18s
[05:53:24.857] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:19:0)
[05:53:25.024] Build status: STARTED
[05:53:25.024] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:20:0) after 8m5s
[06:01:30.168] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:20:0)
[06:01:30.185] Build status: STARTED
[06:01:30.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:21:0) after 2m6s
[06:03:36.213] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:21:0)
[06:03:36.236] Build status: STARTED
[06:03:36.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:22:0) after 4m21s
[06:07:57.367] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:22:0)
[06:07:57.390] Build status: STARTED
[06:07:57.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:23:0) after 2m55s
[06:10:52.417] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:23:0)
[06:10:52.457] Build status: STARTED
[06:10:52.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:24:0) after 5m12s
[06:16:04.472] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:24:0)
[06:16:04.515] Build status: STARTED
[06:16:04.515] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:25:0) after 4m53s
[06:20:57.572] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:25:0)
[06:20:57.591] Build status: STARTED
[06:20:57.591] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:26:0) after 7m11s
[06:28:08.715] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:26:0)
[06:28:08.735] Build status: STARTED
[06:28:08.735] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:27:0) after 2m18s
[06:30:26.752] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:27:0)
[06:30:26.793] Build status: STARTED
[06:30:26.793] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:28:0) after 5m0s
[06:35:26.992] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:28:0)
[06:35:27.011] Build status: STARTED
[06:35:27.011] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:29:0) after 4m51s
[06:40:18.032] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:29:0)
[06:40:18.055] Build status: STARTED
[06:40:18.055] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:30:0) after 4m33s
[06:44:51.101] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:30:0)
[06:44:51.119] Build status: STARTED
[06:44:51.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:31:0) after 7m43s
[06:52:34.140] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:31:0)
[06:52:34.163] Build status: STARTED
[06:52:34.163] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:32:0) after 4m5s
[06:56:39.237] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:32:0)
[06:56:39.269] Build status: STARTED
[06:56:39.269] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:33:0) after 6m10s
[07:02:49.296] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:33:0)
[07:02:49.331] Build status: STARTED
[07:02:49.331] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:34:0) after 3m36s
[07:06:26.661] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:34:0)
[07:06:26.680] Build status: STARTED
[07:06:26.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:35:0) after 2m32s
[07:08:58.660] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:35:0)
[07:08:58.689] Build status: STARTED
[07:08:58.689] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:36:0) after 8m45s
[07:17:43.710] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:36:0)
[07:17:43.918] Build status: STARTED
[07:17:43.918] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892042585343169472:37:0) after 4m3s
[07:18:06.003] Received PubSub notification, asking Buildbucket for the build status
[07:18:06.020] Build:
{
"id": "8726612523509847553",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-05T04:19:49.307801234Z",
"startTime": "2025-01-05T04:19:54.795408486Z",
"endTime": "2025-01-05T07:18:05.290273053Z",
"updateTime": "2025-01-05T07:18:05.290273053Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7700695739d078eff01aad6f4d40c933419d08bc",
"ref": "refs/heads/main"
}
}
}
[07:18:06.020] Invocation finished in 2h58m17.845676355s with status SUCCEEDED