[01:31:36.071] New invocation is queued and will start shortly
[01:31:36.071] Triggered by user:fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com
[01:31:37.179] Starting the invocation (attempt 1)
[01:31:37.208] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9eea7441831328a56bb0f91e7a15b7c575a42930"
[01:31:37.208] Reconstructed gitiles commit from tags
[01:31:37.208] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:31:37.208] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:31:37.208] Buildbucket request:
{
"requestId": "8928020163346187312",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.arm64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "81fc54f2e022a5faaf8131573c6cf212856f1d8d239c43714b562accf9f83f81/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "86c29ddb829aadda0a286bd7532fcb6025d82cb0",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8928020163346187312",
"job": "fuchsia/clang_toolchain.prod.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "81fc54f2e022a5faaf8131573c6cf212856f1d8d239c43714b562accf9f83f81/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "86c29ddb829aadda0a286bd7532fcb6025d82cb0",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "9eea7441831328a56bb0f91e7a15b7c575a42930"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9eea7441831328a56bb0f91e7a15b7c575a42930",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "d575b08b-feae-4ac6-bae4-cae389802d79",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "9eea7441831328a56bb0f91e7a15b7c575a42930"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9eea7441831328a56bb0f91e7a15b7c575a42930",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8928020163346187312"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.prod.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"
}
}
[01:31:37.801] Scheduled build:
{
"id": "8762590101441975361",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-05T01:31:37.267650375Z",
"updateTime": "2023-12-05T01:31:37.267650375Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9eea7441831328a56bb0f91e7a15b7c575a42930",
"ref": "refs/heads/main"
}
}
}
[01:31:37.801] Task URL: https://cr-buildbucket.appspot.com/build/8762590101441975361
[01:31:37.801] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:2:0) after 7m3s
[01:31:38.576] Received PubSub notification, asking Buildbucket for the build status
[01:31:38.595] Build status: SCHEDULED
[01:33:40.135] Received PubSub notification, asking Buildbucket for the build status
[01:33:40.171] Build status: STARTED
[01:38:40.886] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:2:0)
[01:38:40.919] Build status: STARTED
[01:38:40.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:5:0) after 3m16s
[01:41:56.989] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:5:0)
[01:41:57.026] Build status: STARTED
[01:41:57.026] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:6:0) after 4m53s
[01:46:50.079] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:6:0)
[01:46:50.098] Build status: STARTED
[01:46:50.098] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:7:0) after 4m0s
[01:50:50.158] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:7:0)
[01:50:50.190] Build status: STARTED
[01:50:50.190] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:8:0) after 9m18s
[02:00:08.205] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:8:0)
[02:00:08.231] Build status: STARTED
[02:00:08.231] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:9:0) after 6m17s
[02:06:25.246] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:9:0)
[02:06:25.276] Build status: STARTED
[02:06:25.276] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:10:0) after 4m15s
[02:10:40.289] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:10:0)
[02:10:40.310] Build status: STARTED
[02:10:40.310] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:11:0) after 7m7s
[02:17:47.326] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:11:0)
[02:17:47.349] Build status: STARTED
[02:17:47.349] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:12:0) after 4m44s
[02:22:31.376] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:12:0)
[02:22:31.394] Build status: STARTED
[02:22:31.394] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:13:0) after 2m56s
[02:25:27.413] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:13:0)
[02:25:27.438] Build status: STARTED
[02:25:27.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:14:0) after 9m58s
[02:35:25.573] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:14:0)
[02:35:25.593] Build status: STARTED
[02:35:25.593] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:15:0) after 3m2s
[02:38:27.889] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:15:0)
[02:38:27.908] Build status: STARTED
[02:38:27.908] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:16:0) after 4m39s
[02:43:06.960] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:16:0)
[02:43:06.979] Build status: STARTED
[02:43:06.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:17:0) after 3m2s
[02:46:09.035] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:17:0)
[02:46:09.121] Build status: STARTED
[02:46:09.121] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:18:0) after 6m45s
[02:52:54.135] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:18:0)
[02:52:54.158] Build status: STARTED
[02:52:54.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:19:0) after 2m17s
[02:55:11.219] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:19:0)
[02:55:11.303] Build status: STARTED
[02:55:11.303] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:20:0) after 2m8s
[02:57:19.358] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:20:0)
[02:57:19.375] Build status: STARTED
[02:57:19.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:21:0) after 3m26s
[03:00:45.389] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:21:0)
[03:00:45.413] Build status: STARTED
[03:00:45.413] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:22:0) after 7m15s
[03:08:00.429] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:22:0)
[03:08:00.455] Build status: STARTED
[03:08:00.455] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:23:0) after 8m53s
[03:16:53.470] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:23:0)
[03:16:53.489] Build status: STARTED
[03:16:53.489] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:24:0) after 4m54s
[03:21:47.493] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:24:0)
[03:21:47.638] Build status: STARTED
[03:21:47.638] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:25:0) after 8m51s
[03:30:38.654] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:25:0)
[03:30:38.675] Build status: STARTED
[03:30:38.675] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8928020163346187312:26:0) after 5m49s
[03:35:36.733] Received PubSub notification, asking Buildbucket for the build status
[03:35:36.752] Build:
{
"id": "8762590101441975361",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-05T01:31:37.267650375Z",
"startTime": "2023-12-05T01:33:39.485557Z",
"endTime": "2023-12-05T03:35:35.624269Z",
"updateTime": "2023-12-05T03:35:35.624269Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9eea7441831328a56bb0f91e7a15b7c575a42930",
"ref": "refs/heads/main"
}
}
}
[03:35:36.752] Invocation finished in 2h4m0.685158918s with status SUCCEEDED