[07:51:12.854] New invocation is queued and will start shortly
[07:51:12.854] Triggered by user:fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com
[07:51:14.121] Starting the invocation (attempt 1)
[07:51:14.150] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/0502d83470202de6412d4b310692c7b06f1791cb"
[07:51:14.150] Reconstructed gitiles commit from tags
[07:51:14.150] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:51:14.150] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:51:14.150] Buildbucket request:
{
"requestId": "8933703889047494240",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.arm64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "d1a008f32bb81acf68aa0c3669f6d23ff64bdab60d0545d8535fdf169ea6a314/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "45c6d98a38b1c70196b31344a161aa470c54b313",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8933703889047494240",
"job": "fuchsia/clang_toolchain.prod.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "d1a008f32bb81acf68aa0c3669f6d23ff64bdab60d0545d8535fdf169ea6a314/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "45c6d98a38b1c70196b31344a161aa470c54b313",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "0502d83470202de6412d4b310692c7b06f1791cb"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/0502d83470202de6412d4b310692c7b06f1791cb",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "decaf867-4f57-4abf-88f4-6d28881a8488",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "0502d83470202de6412d4b310692c7b06f1791cb"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0502d83470202de6412d4b310692c7b06f1791cb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8933703889047494240"
},
{
"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"
}
}
[07:51:14.658] Scheduled build:
{
"id": "8768273826928304337",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-03T07:51:14.249452010Z",
"updateTime": "2023-10-03T07:51:14.249452010Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0502d83470202de6412d4b310692c7b06f1791cb",
"ref": "refs/heads/main"
}
}
}
[07:51:14.658] Task URL: https://cr-buildbucket.appspot.com/build/8768273826928304337
[07:51:14.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:2:0) after 9m36s
[07:51:15.579] Received PubSub notification, asking Buildbucket for the build status
[07:51:15.604] Build status: SCHEDULED
[07:51:16.549] Received PubSub notification, asking Buildbucket for the build status
[07:51:16.589] Build status: STARTED
[08:00:50.696] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:2:0)
[08:00:50.717] Build status: STARTED
[08:00:50.717] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:5:0) after 4m6s
[08:04:56.824] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:5:0)
[08:04:56.847] Build status: STARTED
[08:04:56.847] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:6:0) after 8m38s
[08:13:34.832] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:6:0)
[08:13:34.853] Build status: STARTED
[08:13:34.853] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:7:0) after 8m40s
[08:22:14.873] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:7:0)
[08:22:14.891] Build status: STARTED
[08:22:14.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:8:0) after 8m22s
[08:30:36.926] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:8:0)
[08:30:36.996] Build status: STARTED
[08:30:36.996] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:9:0) after 1m23s
[08:32:00.102] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:9:0)
[08:32:00.124] Build status: STARTED
[08:32:00.124] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:10:0) after 6m27s
[08:38:27.200] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:10:0)
[08:38:27.233] Build status: STARTED
[08:38:27.233] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:11:0) after 2m52s
[08:41:19.356] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:11:0)
[08:41:19.386] Build status: STARTED
[08:41:19.386] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:12:0) after 4m21s
[08:45:40.423] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:12:0)
[08:45:40.468] Build status: STARTED
[08:45:40.468] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:13:0) after 6m32s
[08:52:12.647] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:13:0)
[08:52:12.717] Build status: STARTED
[08:52:12.717] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:14:0) after 6m41s
[08:58:53.904] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:14:0)
[08:58:53.919] Build status: STARTED
[08:58:53.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:15:0) after 7m27s
[09:06:20.936] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:15:0)
[09:06:20.980] Build status: STARTED
[09:06:20.980] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:16:0) after 4m27s
[09:10:48.005] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:16:0)
[09:10:48.026] Build status: STARTED
[09:10:48.026] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:17:0) after 7m24s
[09:18:12.139] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:17:0)
[09:18:12.157] Build status: STARTED
[09:18:12.157] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:18:0) after 2m3s
[09:20:15.185] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:18:0)
[09:20:15.271] Build status: STARTED
[09:20:15.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:19:0) after 8m46s
[09:29:01.306] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:19:0)
[09:29:01.332] Build status: STARTED
[09:29:01.332] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:20:0) after 8m15s
[09:37:16.356] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:20:0)
[09:37:16.376] Build status: STARTED
[09:37:16.376] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8933703889047494240:21:0) after 6m7s
[09:40:26.614] Received PubSub notification, asking Buildbucket for the build status
[09:40:26.663] Build:
{
"id": "8768273826928304337",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-03T07:51:14.249452010Z",
"startTime": "2023-10-03T07:51:15.891850Z",
"endTime": "2023-10-03T09:40:26.190581487Z",
"updateTime": "2023-10-03T09:40:26.190581487Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0502d83470202de6412d4b310692c7b06f1791cb",
"ref": "refs/heads/main"
}
}
}
[09:40:26.663] Invocation finished in 1h49m13.819102932s with status SUCCEEDED