[07:11:07.320] New invocation is queued and will start shortly
[07:11:07.320] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[07:11:08.594] Starting the invocation (attempt 1)
[07:11:08.623] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a42a2ca19b2325fa6844d6b10e88eb53a3f2fde8"
[07:11:08.623] Reconstructed gitiles commit from tags
[07:11:08.623] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:11:08.624] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:11:08.624] Buildbucket request:
{
"requestId": "8914318660637251472",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-release"
},
"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": "8914318660637251472",
"job": "fuchsia/clang_toolchain.ci.core.arm64-release",
"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": "8914318660637251472"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.arm64-release"
},
{
"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:09.302] Scheduled build:
{
"id": "8748888598541912225",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-04T07:11:08.679568301Z",
"updateTime": "2024-05-04T07:11:08.679568301Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a42a2ca19b2325fa6844d6b10e88eb53a3f2fde8",
"ref": "refs/heads/main"
}
},
"canary": true
}
[07:11:09.302] Task URL: https://cr-buildbucket.appspot.com/build/8748888598541912225
[07:11:09.302] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:2:0) after 3m43s
[07:11:10.292] Received PubSub notification, asking Buildbucket for the build status
[07:11:10.315] Build status: SCHEDULED
[07:14:48.971] Received PubSub notification, asking Buildbucket for the build status
[07:14:48.997] Build status: STARTED
[07:14:52.312] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:2:0)
[07:14:52.342] Build status: STARTED
[07:14:52.342] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:5:0) after 3m47s
[07:18:39.316] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:5:0)
[07:18:39.347] Build status: STARTED
[07:18:39.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:6:0) after 1m32s
[07:20:11.460] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:6:0)
[07:20:11.480] Build status: STARTED
[07:20:11.480] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:7:0) after 8m37s
[07:28:48.562] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:7:0)
[07:28:48.592] Build status: STARTED
[07:28:48.592] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:8:0) after 6m25s
[07:35:13.752] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:8:0)
[07:35:13.822] Build status: STARTED
[07:35:13.822] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:9:0) after 2m40s
[07:37:53.937] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:9:0)
[07:37:53.965] Build status: STARTED
[07:37:53.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:10:0) after 8m15s
[07:46:08.973] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:10:0)
[07:46:09.053] Build status: STARTED
[07:46:09.053] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:11:0) after 3m22s
[07:49:31.070] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:11:0)
[07:49:31.096] Build status: STARTED
[07:49:31.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:12:0) after 6m11s
[07:55:42.666] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:12:0)
[07:55:42.689] Build status: STARTED
[07:55:42.689] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:13:0) after 2m12s
[07:57:54.805] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:13:0)
[07:57:54.830] Build status: STARTED
[07:57:54.830] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:14:0) after 6m12s
[08:04:06.839] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:14:0)
[08:04:07.017] Build status: STARTED
[08:04:07.017] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:15:0) after 2m30s
[08:06:36.996] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:15:0)
[08:06:37.019] Build status: STARTED
[08:06:37.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:16:0) after 9m34s
[08:16:11.220] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:16:0)
[08:16:11.289] Build status: STARTED
[08:16:11.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:17:0) after 2m21s
[08:18:32.406] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:17:0)
[08:18:32.423] Build status: STARTED
[08:18:32.423] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:18:0) after 3m56s
[08:22:28.769] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:18:0)
[08:22:28.792] Build status: STARTED
[08:22:28.792] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:19:0) after 7m31s
[08:29:59.971] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:19:0)
[08:29:59.999] Build status: STARTED
[08:29:59.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:20:0) after 1m33s
[08:31:33.082] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:20:0)
[08:31:33.101] Build status: STARTED
[08:31:33.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:21:0) after 5m10s
[08:36:43.156] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:21:0)
[08:36:43.236] Build status: STARTED
[08:36:43.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:22:0) after 4m49s
[08:41:32.254] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:22:0)
[08:41:32.286] Build status: STARTED
[08:41:32.286] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:23:0) after 5m35s
[08:47:07.310] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:23:0)
[08:47:07.327] Build status: STARTED
[08:47:07.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:24:0) after 2m20s
[08:49:27.392] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:24:0)
[08:49:27.407] Build status: STARTED
[08:49:27.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:25:0) after 2m9s
[08:51:36.437] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:25:0)
[08:51:36.457] Build status: STARTED
[08:51:36.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:26:0) after 1m33s
[08:53:09.582] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:26:0)
[08:53:09.665] Build status: STARTED
[08:53:09.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:27:0) after 6m44s
[08:59:53.682] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:27:0)
[08:59:53.703] Build status: STARTED
[08:59:53.703] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:28:0) after 9m48s
[09:09:41.733] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:28:0)
[09:09:41.758] Build status: STARTED
[09:09:41.758] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:29:0) after 3m52s
[09:13:34.047] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:29:0)
[09:13:34.067] Build status: STARTED
[09:13:34.067] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:30:0) after 9m53s
[09:23:27.086] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:30:0)
[09:23:27.184] Build status: STARTED
[09:23:27.184] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:31:0) after 2m19s
[09:25:46.641] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:31:0)
[09:25:46.659] Build status: STARTED
[09:25:46.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:32:0) after 1m34s
[09:27:20.808] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:32:0)
[09:27:20.840] Build status: STARTED
[09:27:20.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:33:0) after 7m52s
[09:35:12.874] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:33:0)
[09:35:12.893] Build status: STARTED
[09:35:12.893] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:34:0) after 1m16s
[09:36:29.196] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:34:0)
[09:36:29.241] Build status: STARTED
[09:36:29.241] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:35:0) after 5m58s
[09:42:27.426] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:35:0)
[09:42:27.454] Build status: STARTED
[09:42:27.454] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:36:0) after 5m1s
[09:47:28.479] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:36:0)
[09:47:28.514] Build status: STARTED
[09:47:28.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:37:0) after 8m6s
[09:55:34.679] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:37:0)
[09:55:34.717] Build status: STARTED
[09:55:34.717] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:38:0) after 5m40s
[10:01:14.933] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:38:0)
[10:01:14.955] Build status: STARTED
[10:01:14.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:39:0) after 1m51s
[10:03:05.972] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:39:0)
[10:03:06.019] Build status: STARTED
[10:03:06.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:40:0) after 1m13s
[10:04:19.093] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:40:0)
[10:04:19.127] Build status: STARTED
[10:04:19.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:41:0) after 3m48s
[10:08:07.200] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:41:0)
[10:08:07.256] Build status: STARTED
[10:08:07.256] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8914318660637251472:42:0) after 1m52s
[10:09:47.909] Received PubSub notification, asking Buildbucket for the build status
[10:09:47.939] Build:
{
"id": "8748888598541912225",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-04T07:11:08.679568301Z",
"startTime": "2024-05-04T07:14:48.771213552Z",
"endTime": "2024-05-04T10:09:47.462080213Z",
"updateTime": "2024-05-04T10:09:47.462080213Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a42a2ca19b2325fa6844d6b10e88eb53a3f2fde8",
"ref": "refs/heads/main"
}
},
"canary": true
}
[10:09:47.939] Invocation finished in 2h58m40.641459073s with status SUCCEEDED