[11:11:51.692] New invocation is queued and will start shortly
[11:11:51.692] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[11:11:52.773] Starting the invocation (attempt 1)
[11:11:52.799] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4c65787f1e45199713f71f63817651ff2decd96c"
[11:11:52.799] Reconstructed gitiles commit from tags
[11:11:52.799] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:11:52.799] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:11:52.799] Buildbucket request:
{
"requestId": "8923997390007049520",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "8cec78676d65a2a3db113e895fccde501fe4b3ed1bea9a11490321fae8a7117a/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4b9868bc6bfbfcc5ec48014a58ae3a77c78805b0",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8923997390007049520",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6f29a36e8a5c6c7e4e69d510c6c1b47aa1ee5f4f608bb43db32c9fe0b1f5161a/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4b9868bc6bfbfcc5ec48014a58ae3a77c78805b0",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "9096bcc7c89491b5e26d5e275e69a8f76e2e5146"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9096bcc7c89491b5e26d5e275e69a8f76e2e5146",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "bd89cdf8-a9f4-4e9e-b428-8f3ca174f9cc",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "9121ae6f2941947d6c94d66ff9629f6ecdf7d206318530e6c5c79650630237ac/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4b9868bc6bfbfcc5ec48014a58ae3a77c78805b0",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "49e3e7514309823e39627175d5337c5d5aff92c1"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/49e3e7514309823e39627175d5337c5d5aff92c1",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "977a624f-4b3c-49b5-9f3d-6b67de96b95d",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "8cec78676d65a2a3db113e895fccde501fe4b3ed1bea9a11490321fae8a7117a/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4b9868bc6bfbfcc5ec48014a58ae3a77c78805b0",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "4c65787f1e45199713f71f63817651ff2decd96c"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4c65787f1e45199713f71f63817651ff2decd96c",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "274d8ae2-b19b-48d9-a841-d708706bbf69",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "4c65787f1e45199713f71f63817651ff2decd96c"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4c65787f1e45199713f71f63817651ff2decd96c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8923997390007049520"
},
{
"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"
}
}
[11:11:53.337] Scheduled build:
{
"id": "8758567328122948545",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-18T11:11:52.862995209Z",
"updateTime": "2024-01-18T11:11:52.862995209Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4c65787f1e45199713f71f63817651ff2decd96c",
"ref": "refs/heads/main"
}
}
}
[11:11:53.337] Task URL: https://cr-buildbucket.appspot.com/build/8758567328122948545
[11:11:53.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:2:0) after 6m26s
[11:11:54.668] Received PubSub notification, asking Buildbucket for the build status
[11:11:54.685] Build status: SCHEDULED
[11:13:51.908] Received PubSub notification, asking Buildbucket for the build status
[11:13:51.963] Build status: STARTED
[11:18:19.410] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:2:0)
[11:18:19.438] Build status: STARTED
[11:18:19.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:5:0) after 5m1s
[11:23:20.458] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:5:0)
[11:23:20.534] Build status: STARTED
[11:23:20.534] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:6:0) after 1m21s
[11:24:41.770] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:6:0)
[11:24:41.808] Build status: STARTED
[11:24:41.808] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:7:0) after 8m32s
[11:33:13.824] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:7:0)
[11:33:13.886] Build status: STARTED
[11:33:13.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:8:0) after 9m45s
[11:42:59.223] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:8:0)
[11:42:59.390] Build status: STARTED
[11:42:59.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:9:0) after 3m1s
[11:46:00.849] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:9:0)
[11:46:00.975] Build status: STARTED
[11:46:00.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:10:0) after 1m59s
[11:48:00.297] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:10:0)
[11:48:00.319] Build status: STARTED
[11:48:00.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:11:0) after 4m18s
[11:52:18.437] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:11:0)
[11:52:18.504] Build status: STARTED
[11:52:18.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:12:0) after 5m38s
[11:57:56.598] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:12:0)
[11:57:56.616] Build status: STARTED
[11:57:56.616] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:13:0) after 9m37s
[12:07:33.740] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:13:0)
[12:07:33.785] Build status: STARTED
[12:07:33.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:14:0) after 7m9s
[12:14:43.023] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:14:0)
[12:14:43.093] Build status: STARTED
[12:14:43.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:15:0) after 1m31s
[12:16:14.226] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:15:0)
[12:16:14.250] Build status: STARTED
[12:16:14.250] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:16:0) after 3m6s
[12:19:20.517] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:16:0)
[12:19:20.582] Build status: STARTED
[12:19:20.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:17:0) after 1m6s
[12:20:26.920] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:17:0)
[12:20:26.945] Build status: STARTED
[12:20:26.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:18:0) after 9m36s
[12:30:02.990] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:18:0)
[12:30:03.038] Build status: STARTED
[12:30:03.038] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:19:0) after 8m57s
[12:39:00.054] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:19:0)
[12:39:00.095] Build status: STARTED
[12:39:00.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:20:0) after 3m24s
[12:42:24.158] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:20:0)
[12:42:24.180] Build status: STARTED
[12:42:24.180] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:21:0) after 4m13s
[12:46:37.196] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:21:0)
[12:46:37.215] Build status: STARTED
[12:46:37.215] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:22:0) after 8m41s
[12:55:18.230] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:22:0)
[12:55:18.250] Build status: STARTED
[12:55:18.250] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:23:0) after 3m3s
[12:58:21.277] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:23:0)
[12:58:21.301] Build status: STARTED
[12:58:21.302] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8923997390007049520:24:0) after 9m18s
[13:06:16.513] Received PubSub notification, asking Buildbucket for the build status
[13:06:16.590] Build:
{
"id": "8758567328122948545",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-18T11:11:52.862995209Z",
"startTime": "2024-01-18T11:13:51.422308Z",
"endTime": "2024-01-18T13:06:15.293870Z",
"updateTime": "2024-01-18T13:06:15.293870Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4c65787f1e45199713f71f63817651ff2decd96c",
"ref": "refs/heads/main"
}
}
}
[13:06:16.590] Invocation finished in 1h54m24.908777735s with status SUCCEEDED