[14:06:46.418] New invocation is queued and will start shortly
[14:06:46.418] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[14:06:47.574] Starting the invocation (attempt 1)
[14:06:47.601] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a28a7d41ef1a60795719fa3e6e2f7dc3b7fc3d27"
[14:06:47.601] Reconstructed gitiles commit from tags
[14:06:47.601] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:06:47.602] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:06:47.602] Buildbucket request:
{
"requestId": "8920362506833852048",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6873880435d70880bf30805c5f180334ae1331adb3288322835d102f31a7d481/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "78ba0e4c25c33fea2f6118488f6f97485ed2899f",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8920362506833852048",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "ce8d9f08bdf0631422bfb30f7f7ba6e7ed1214866e9e65a091b259fd66f98273/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "78ba0e4c25c33fea2f6118488f6f97485ed2899f",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "ca0560d8c821fa93e34cf84362fd523b546ba426"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ca0560d8c821fa93e34cf84362fd523b546ba426",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "463d039d-14bc-450b-8b51-9488de43dc89",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "41524842ede23a02d6ec6d3d1106a7c9647a9d0dea3b1f6036f46dffc36ad13b/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "78ba0e4c25c33fea2f6118488f6f97485ed2899f",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "56ad6d19397c4286fa412f5070fd1a563b6c43e4"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/56ad6d19397c4286fa412f5070fd1a563b6c43e4",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "ebcc0e93-40cc-4e14-b476-073b4f2e4c53",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6873880435d70880bf30805c5f180334ae1331adb3288322835d102f31a7d481/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "78ba0e4c25c33fea2f6118488f6f97485ed2899f",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a28a7d41ef1a60795719fa3e6e2f7dc3b7fc3d27"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a28a7d41ef1a60795719fa3e6e2f7dc3b7fc3d27",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "22d75699-f2ae-4e20-8339-20ead089fe62",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a28a7d41ef1a60795719fa3e6e2f7dc3b7fc3d27"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a28a7d41ef1a60795719fa3e6e2f7dc3b7fc3d27",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8920362506833852048"
},
{
"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"
}
}
[14:06:48.063] Scheduled build:
{
"id": "8754932444864626897",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-27T14:06:47.668376354Z",
"updateTime": "2024-02-27T14:06:47.668376354Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a28a7d41ef1a60795719fa3e6e2f7dc3b7fc3d27",
"ref": "refs/heads/main"
}
}
}
[14:06:48.063] Task URL: https://cr-buildbucket.appspot.com/build/8754932444864626897
[14:06:48.063] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:2:0) after 7m29s
[14:06:49.074] Received PubSub notification, asking Buildbucket for the build status
[14:06:49.125] Build status: STARTED
[14:06:49.552] Received PubSub notification, asking Buildbucket for the build status
[14:06:49.575] Build status: STARTED
[14:14:17.081] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:2:0)
[14:14:17.114] Build status: STARTED
[14:14:17.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:5:0) after 7m21s
[14:21:38.444] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:5:0)
[14:21:38.534] Build status: STARTED
[14:21:38.534] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:6:0) after 1m8s
[14:22:46.632] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:6:0)
[14:22:46.660] Build status: STARTED
[14:22:46.660] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:7:0) after 8m47s
[14:31:34.230] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:7:0)
[14:31:34.266] Build status: STARTED
[14:31:34.266] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:8:0) after 5m53s
[14:37:27.289] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:8:0)
[14:37:27.316] Build status: STARTED
[14:37:27.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:9:0) after 2m19s
[14:39:46.515] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:9:0)
[14:39:46.539] Build status: STARTED
[14:39:46.539] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:10:0) after 4m40s
[14:44:26.895] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:10:0)
[14:44:26.915] Build status: STARTED
[14:44:26.915] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:11:0) after 4m9s
[14:48:35.938] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:11:0)
[14:48:35.962] Build status: STARTED
[14:48:35.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:12:0) after 8m34s
[14:57:10.090] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:12:0)
[14:57:10.117] Build status: STARTED
[14:57:10.117] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:13:0) after 1m23s
[14:58:33.163] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:13:0)
[14:58:33.202] Build status: STARTED
[14:58:33.202] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:14:0) after 9m13s
[15:07:46.237] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:14:0)
[15:07:46.284] Build status: STARTED
[15:07:46.284] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:15:0) after 1m6s
[15:08:52.307] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:15:0)
[15:08:52.351] Build status: STARTED
[15:08:52.351] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:16:0) after 5m0s
[15:13:52.370] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:16:0)
[15:13:52.513] Build status: STARTED
[15:13:52.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:17:0) after 7m40s
[15:21:32.627] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:17:0)
[15:21:32.668] Build status: STARTED
[15:21:32.668] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:18:0) after 4m1s
[15:25:33.690] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:18:0)
[15:25:33.853] Build status: STARTED
[15:25:33.853] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:19:0) after 2m44s
[15:28:17.892] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:19:0)
[15:28:17.914] Build status: STARTED
[15:28:17.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:20:0) after 4m30s
[15:32:48.031] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:20:0)
[15:32:48.405] Build status: STARTED
[15:32:48.405] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:21:0) after 5m45s
[15:38:33.434] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:21:0)
[15:38:33.461] Build status: STARTED
[15:38:33.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:22:0) after 1m23s
[15:39:56.482] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:22:0)
[15:39:56.502] Build status: STARTED
[15:39:56.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:23:0) after 7m9s
[15:47:05.535] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:23:0)
[15:47:05.559] Build status: STARTED
[15:47:05.559] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:24:0) after 2m6s
[15:49:11.576] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:24:0)
[15:49:11.610] Build status: STARTED
[15:49:11.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:25:0) after 6m2s
[15:55:13.652] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:25:0)
[15:55:13.680] Build status: STARTED
[15:55:13.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:26:0) after 8m11s
[16:03:24.791] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:26:0)
[16:03:24.819] Build status: STARTED
[16:03:24.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:27:0) after 7m5s
[16:10:29.813] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:27:0)
[16:10:29.835] Build status: STARTED
[16:10:29.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:28:0) after 3m11s
[16:13:40.911] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:28:0)
[16:13:40.952] Build status: STARTED
[16:13:40.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:29:0) after 5m48s
[16:19:28.972] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:29:0)
[16:19:28.990] Build status: STARTED
[16:19:28.990] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920362506833852048:30:0) after 6m51s
[16:25:10.896] Received PubSub notification, asking Buildbucket for the build status
[16:25:10.935] Build:
{
"id": "8754932444864626897",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-27T14:06:47.668376354Z",
"startTime": "2024-02-27T14:06:48.455672Z",
"endTime": "2024-02-27T16:25:09.186024Z",
"updateTime": "2024-02-27T16:25:09.186024Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a28a7d41ef1a60795719fa3e6e2f7dc3b7fc3d27",
"ref": "refs/heads/main"
}
}
}
[16:25:10.935] Invocation finished in 2h18m24.528644422s with status SUCCEEDED