[13:10:54.786] New invocation is queued and will start shortly
[13:10:54.786] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[13:10:55.968] Starting the invocation (attempt 1)
[13:10:55.998] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/614cd721e1c379ab6926687fd81167bd8f9b0179"
[13:10:55.998] Reconstructed gitiles commit from tags
[13:10:55.998] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:10:55.998] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:10:55.999] Buildbucket request:
{
"requestId": "8953433914006415072",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "ff4d2e298a09fd15b6c816123c240bc2c161566ddd1586ccf02752215be6e058/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "603c0f10715bc7d66bf70ba18ff6f616e92c6705",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8953433914006415072",
"job": "fuchsia/clang_toolchain.ci.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "521e6a33ea04dd3f6d6a24920d73b60eb147bd370314cd0e735f0801798addea/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "603c0f10715bc7d66bf70ba18ff6f616e92c6705",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "1422f1bf2b14b3e633a4803cc1796ebd389ccef0"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1422f1bf2b14b3e633a4803cc1796ebd389ccef0",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "8ea47897-f2ba-4e4c-a4ef-5727a1a02bf4",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "26b78a1fbfaa7caa0117d95394a6649176aafccb0efbdb840203fb9e2fd58732/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "603c0f10715bc7d66bf70ba18ff6f616e92c6705",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "7f635b90e7bdf1378fd9a65fc62b99e8e07d4aaf"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7f635b90e7bdf1378fd9a65fc62b99e8e07d4aaf",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "0f67c592-f5df-48dd-b930-ef708207d08f",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "ff4d2e298a09fd15b6c816123c240bc2c161566ddd1586ccf02752215be6e058/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "603c0f10715bc7d66bf70ba18ff6f616e92c6705",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "614cd721e1c379ab6926687fd81167bd8f9b0179"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/614cd721e1c379ab6926687fd81167bd8f9b0179",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "13486335-344c-476b-98a3-711724bd1dce",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "614cd721e1c379ab6926687fd81167bd8f9b0179"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "614cd721e1c379ab6926687fd81167bd8f9b0179",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8953433914006415072"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.arm64-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"
}
}
[13:10:56.450] Scheduled build:
{
"id": "8788003851909714081",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-02-27T13:10:56.162447676Z",
"updateTime": "2023-02-27T13:10:56.162447676Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "614cd721e1c379ab6926687fd81167bd8f9b0179",
"ref": "refs/heads/main"
}
},
"canary": true
}
[13:10:56.450] Task URL: https://cr-buildbucket.appspot.com/build/8788003851909714081
[13:10:56.450] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:2:0) after 9m40s
[13:11:00.321] Received PubSub notification, asking Buildbucket for the build status
[13:11:00.343] Build status: STARTED
[13:20:36.489] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:2:0)
[13:20:36.517] Build status: STARTED
[13:20:36.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:4:0) after 6m49s
[13:27:25.773] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:4:0)
[13:27:25.811] Build status: STARTED
[13:27:25.811] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:5:0) after 6m1s
[13:33:26.836] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:5:0)
[13:33:26.885] Build status: STARTED
[13:33:26.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:6:0) after 8m4s
[13:41:30.904] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:6:0)
[13:41:30.930] Build status: STARTED
[13:41:30.930] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:7:0) after 9m0s
[13:50:30.948] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:7:0)
[13:50:31.113] Build status: STARTED
[13:50:31.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:8:0) after 8m20s
[13:58:51.139] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:8:0)
[13:58:51.167] Build status: STARTED
[13:58:51.167] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:9:0) after 4m56s
[14:03:47.295] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:9:0)
[14:03:47.315] Build status: STARTED
[14:03:47.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:10:0) after 3m40s
[14:07:27.495] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:10:0)
[14:07:27.514] Build status: STARTED
[14:07:27.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:11:0) after 7m15s
[14:14:42.807] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:11:0)
[14:14:42.832] Build status: STARTED
[14:14:42.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:12:0) after 2m48s
[14:17:30.847] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:12:0)
[14:17:30.872] Build status: STARTED
[14:17:30.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:13:0) after 9m16s
[14:26:47.007] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:13:0)
[14:26:47.066] Build status: STARTED
[14:26:47.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:14:0) after 4m23s
[14:31:10.182] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:14:0)
[14:31:10.215] Build status: STARTED
[14:31:10.215] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:15:0) after 8m57s
[14:40:07.237] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:15:0)
[14:40:07.261] Build status: STARTED
[14:40:07.261] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:16:0) after 8m10s
[14:48:17.533] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:16:0)
[14:48:17.560] Build status: STARTED
[14:48:17.560] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:17:0) after 8m57s
[14:57:14.628] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:17:0)
[14:57:14.650] Build status: STARTED
[14:57:14.650] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:18:0) after 1m5s
[14:58:19.671] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:18:0)
[14:58:19.697] Build status: STARTED
[14:58:19.697] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:19:0) after 2m37s
[15:00:56.741] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:19:0)
[15:00:56.769] Build status: STARTED
[15:00:56.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:20:0) after 9m58s
[15:10:54.796] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:20:0)
[15:10:54.824] Build status: STARTED
[15:10:54.824] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:21:0) after 3m56s
[15:14:50.864] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:21:0)
[15:14:50.884] Build status: STARTED
[15:14:50.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:22:0) after 9m13s
[15:24:03.969] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:22:0)
[15:24:03.991] Build status: STARTED
[15:24:03.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8953433914006415072:23:0) after 2m58s
[15:24:09.306] Received PubSub notification, asking Buildbucket for the build status
[15:24:09.332] Build:
{
"id": "8788003851909714081",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-02-27T13:10:56.162447676Z",
"startTime": "2023-02-27T13:10:58.691914Z",
"endTime": "2023-02-27T15:24:08.736212601Z",
"updateTime": "2023-02-27T15:24:08.736212601Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "614cd721e1c379ab6926687fd81167bd8f9b0179",
"ref": "refs/heads/main"
}
},
"canary": true
}
[15:24:09.332] Invocation finished in 2h13m14.55323618s with status SUCCEEDED