[07:11:06.445] New invocation is queued and will start shortly
[07:11:06.445] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[07:11:07.799] Starting the invocation (attempt 1)
[07:11:07.827] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a42a2ca19b2325fa6844d6b10e88eb53a3f2fde8"
[07:11:07.827] Reconstructed gitiles commit from tags
[07:11:07.827] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:11:07.830] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:11:07.830] Buildbucket request:
{
"requestId": "8914318661545760528",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "318c2d4ad72268dc376d1f5c8386d92014f9a5de503cf1c68e7aa00f4ad85c59/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "b3ea9f4abadfe34a0b99b1760bf9aaa2eeb09c38",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8914318661545760528",
"job": "fuchsia/clang_toolchain.ci.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "318c2d4ad72268dc376d1f5c8386d92014f9a5de503cf1c68e7aa00f4ad85c59/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "b3ea9f4abadfe34a0b99b1760bf9aaa2eeb09c38",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a42a2ca19b2325fa6844d6b10e88eb53a3f2fde8"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a42a2ca19b2325fa6844d6b10e88eb53a3f2fde8",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "c1993bb6-8129-427c-8d9c-42d5a5b367cc",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a42a2ca19b2325fa6844d6b10e88eb53a3f2fde8"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a42a2ca19b2325fa6844d6b10e88eb53a3f2fde8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914318661545760528"
},
{
"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"
}
}
[07:11:08.643] Scheduled build:
{
"id": "8748888599216826177",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-04T07:11:08.035490099Z",
"updateTime": "2024-05-04T07:11:08.035490099Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a42a2ca19b2325fa6844d6b10e88eb53a3f2fde8",
"ref": "refs/heads/main"
}
}
}
[07:11:08.643] Task URL: https://cr-buildbucket.appspot.com/build/8748888599216826177
[07:11:08.643] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:2:0) after 1m43s
[07:11:09.448] Received PubSub notification, asking Buildbucket for the build status
[07:11:09.477] Build status: SCHEDULED
[07:12:51.680] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:2:0)
[07:12:51.711] Build status: SCHEDULED
[07:12:51.711] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:4:0) after 2m0s
[07:14:16.562] Received PubSub notification, asking Buildbucket for the build status
[07:14:16.588] Build status: STARTED
[07:14:51.886] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:4:0)
[07:14:51.905] Build status: STARTED
[07:14:51.905] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:6:0) after 5m59s
[07:20:51.165] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:6:0)
[07:20:51.184] Build status: STARTED
[07:20:51.184] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:7:0) after 2m30s
[07:23:21.542] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:7:0)
[07:23:21.571] Build status: STARTED
[07:23:21.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:8:0) after 4m48s
[07:28:09.939] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:8:0)
[07:28:09.956] Build status: STARTED
[07:28:09.956] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:9:0) after 3m3s
[07:31:13.023] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:9:0)
[07:31:13.044] Build status: STARTED
[07:31:13.044] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:10:0) after 4m28s
[07:35:41.170] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:10:0)
[07:35:41.187] Build status: STARTED
[07:35:41.187] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:11:0) after 8m7s
[07:43:48.268] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:11:0)
[07:43:48.339] Build status: STARTED
[07:43:48.339] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:12:0) after 6m31s
[07:50:19.518] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:12:0)
[07:50:19.545] Build status: STARTED
[07:50:19.545] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:13:0) after 5m45s
[07:56:04.804] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:13:0)
[07:56:04.831] Build status: STARTED
[07:56:04.831] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:14:0) after 1m30s
[07:57:34.964] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:14:0)
[07:57:34.999] Build status: STARTED
[07:57:35.000] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:15:0) after 9m42s
[08:07:17.256] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:15:0)
[08:07:17.313] Build status: STARTED
[08:07:17.313] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:16:0) after 8m43s
[08:16:00.484] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:16:0)
[08:16:00.551] Build status: STARTED
[08:16:00.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:17:0) after 3m22s
[08:19:22.587] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:17:0)
[08:19:22.626] Build status: STARTED
[08:19:22.626] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:18:0) after 6m43s
[08:26:05.645] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:18:0)
[08:26:05.664] Build status: STARTED
[08:26:05.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:19:0) after 9m13s
[08:35:18.797] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:19:0)
[08:35:18.920] Build status: STARTED
[08:35:18.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:20:0) after 4m35s
[08:39:54.156] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:20:0)
[08:39:54.183] Build status: STARTED
[08:39:54.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:21:0) after 9m30s
[08:49:24.221] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:21:0)
[08:49:24.244] Build status: STARTED
[08:49:24.244] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:22:0) after 4m20s
[08:53:44.425] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:22:0)
[08:53:44.444] Build status: STARTED
[08:53:44.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:23:0) after 7m1s
[09:00:45.463] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:23:0)
[09:00:45.506] Build status: STARTED
[09:00:45.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:24:0) after 9m54s
[09:10:39.994] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:24:0)
[09:10:40.009] Build status: STARTED
[09:10:40.009] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:25:0) after 1m56s
[09:12:36.130] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:25:0)
[09:12:36.148] Build status: STARTED
[09:12:36.148] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:26:0) after 2m45s
[09:15:21.267] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:26:0)
[09:15:21.308] Build status: STARTED
[09:15:21.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:27:0) after 9m37s
[09:24:58.379] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:27:0)
[09:24:58.401] Build status: STARTED
[09:24:58.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:28:0) after 1m8s
[09:26:06.453] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:28:0)
[09:26:06.491] Build status: STARTED
[09:26:06.491] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:29:0) after 3m58s
[09:30:04.755] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:29:0)
[09:30:04.898] Build status: STARTED
[09:30:04.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:30:0) after 2m41s
[09:32:46.046] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:30:0)
[09:32:46.071] Build status: STARTED
[09:32:46.071] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:31:0) after 5m59s
[09:38:45.119] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:31:0)
[09:38:45.143] Build status: STARTED
[09:38:45.143] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:32:0) after 1m19s
[09:40:04.266] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:32:0)
[09:40:04.324] Build status: STARTED
[09:40:04.324] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:33:0) after 4m24s
[09:44:28.342] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:33:0)
[09:44:28.379] Build status: STARTED
[09:44:28.379] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:34:0) after 2m41s
[09:47:09.449] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:34:0)
[09:47:09.471] Build status: STARTED
[09:47:09.471] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:35:0) after 8m53s
[09:56:02.568] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:35:0)
[09:56:02.611] Build status: STARTED
[09:56:02.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:36:0) after 3m58s
[10:00:00.734] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:36:0)
[10:00:00.753] Build status: STARTED
[10:00:00.753] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:37:0) after 3m34s
[10:03:34.771] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:37:0)
[10:03:34.792] Build status: STARTED
[10:03:34.793] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:38:0) after 8m52s
[10:12:26.854] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:38:0)
[10:12:26.876] Build status: STARTED
[10:12:26.876] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8914318661545760528:39:0) after 7m26s
[10:14:20.929] Received PubSub notification, asking Buildbucket for the build status
[10:14:20.969] Build:
{
"id": "8748888599216826177",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-04T07:11:08.035490099Z",
"startTime": "2024-05-04T07:14:16.322039474Z",
"endTime": "2024-05-04T10:14:20.170346532Z",
"updateTime": "2024-05-04T10:14:20.170346532Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a42a2ca19b2325fa6844d6b10e88eb53a3f2fde8",
"ref": "refs/heads/main"
}
}
}
[10:14:20.969] Invocation finished in 3h3m14.539482129s with status SUCCEEDED