[18:11:02.931] New invocation is queued and will start shortly
[18:11:02.931] Triggered by user:fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com
[18:11:04.463] Starting the invocation (attempt 1)
[18:11:04.489] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/229f391f836c9250b7e0c3824e7152748bab220e"
[18:11:04.489] Reconstructed gitiles commit from tags
[18:11:04.489] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:11:04.489] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:11:04.489] Buildbucket request:
{
"requestId": "8902408939015956336",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "39d423cd06020bc28e42223a5f264bcacb6142560aaefb3731c47da6ae43e2c4/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0229ddaa2d1a6838c75f9de48f77cfbb894310e4",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8902408939015956336",
"job": "fuchsia/clang_toolchain.prod.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "39d423cd06020bc28e42223a5f264bcacb6142560aaefb3731c47da6ae43e2c4/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0229ddaa2d1a6838c75f9de48f77cfbb894310e4",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "229f391f836c9250b7e0c3824e7152748bab220e"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/229f391f836c9250b7e0c3824e7152748bab220e",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "178c3f1d-bc47-45c7-ae4f-971e71055ba5",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "229f391f836c9250b7e0c3824e7152748bab220e"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "229f391f836c9250b7e0c3824e7152748bab220e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8902408939015956336"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.prod.core.x64-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"
}
}
[18:11:04.996] Scheduled build:
{
"id": "8736978876663083393",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-12T18:11:04.550230872Z",
"updateTime": "2024-09-12T18:11:04.550230872Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "229f391f836c9250b7e0c3824e7152748bab220e",
"ref": "refs/heads/main"
}
}
}
[18:11:04.996] Task URL: https://cr-buildbucket.appspot.com/build/8736978876663083393
[18:11:04.996] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:2:0) after 1m20s
[18:11:05.931] Received PubSub notification, asking Buildbucket for the build status
[18:11:05.963] Build status: SCHEDULED
[18:11:13.715] Received PubSub notification, asking Buildbucket for the build status
[18:11:13.794] Build status: STARTED
[18:12:25.013] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:2:0)
[18:12:25.029] Build status: STARTED
[18:12:25.029] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:5:0) after 5m23s
[18:17:48.044] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:5:0)
[18:17:48.066] Build status: STARTED
[18:17:48.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:6:0) after 4m38s
[18:22:26.129] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:6:0)
[18:22:26.157] Build status: STARTED
[18:22:26.157] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:7:0) after 3m16s
[18:25:42.173] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:7:0)
[18:25:42.271] Build status: STARTED
[18:25:42.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:8:0) after 7m15s
[18:32:57.338] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:8:0)
[18:32:57.360] Build status: STARTED
[18:32:57.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:9:0) after 8m7s
[18:41:04.468] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:9:0)
[18:41:04.485] Build status: STARTED
[18:41:04.485] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:10:0) after 3m23s
[18:44:27.528] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:10:0)
[18:44:27.556] Build status: STARTED
[18:44:27.556] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:11:0) after 3m12s
[18:47:39.625] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:11:0)
[18:47:39.648] Build status: STARTED
[18:47:39.648] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:12:0) after 1m35s
[18:49:14.672] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:12:0)
[18:49:14.715] Build status: STARTED
[18:49:14.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:13:0) after 5m23s
[18:54:37.793] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:13:0)
[18:54:37.833] Build status: STARTED
[18:54:37.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:14:0) after 7m15s
[19:01:53.399] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:14:0)
[19:01:53.425] Build status: STARTED
[19:01:53.425] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:15:0) after 7m34s
[19:09:27.491] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:15:0)
[19:09:27.574] Build status: STARTED
[19:09:27.574] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:16:0) after 3m28s
[19:12:55.553] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:16:0)
[19:12:55.576] Build status: STARTED
[19:12:55.576] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:17:0) after 9m54s
[19:22:49.590] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:17:0)
[19:22:49.610] Build status: STARTED
[19:22:49.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:18:0) after 8m25s
[19:31:14.674] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:18:0)
[19:31:14.699] Build status: STARTED
[19:31:14.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:19:0) after 4m44s
[19:35:58.712] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:19:0)
[19:35:58.728] Build status: STARTED
[19:35:58.728] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:20:0) after 1m24s
[19:37:23.003] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:20:0)
[19:37:23.035] Build status: STARTED
[19:37:23.035] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:21:0) after 8m53s
[19:46:16.100] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:21:0)
[19:46:16.125] Build status: STARTED
[19:46:16.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:22:0) after 8m40s
[19:54:56.242] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:22:0)
[19:54:56.268] Build status: STARTED
[19:54:56.268] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:23:0) after 2m24s
[19:57:20.273] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:23:0)
[19:57:20.289] Build status: STARTED
[19:57:20.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:24:0) after 6m0s
[20:03:20.372] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:24:0)
[20:03:20.445] Build status: STARTED
[20:03:20.445] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:25:0) after 5m8s
[20:08:28.530] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:25:0)
[20:08:28.551] Build status: STARTED
[20:08:28.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:26:0) after 6m41s
[20:15:09.658] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:26:0)
[20:15:09.673] Build status: STARTED
[20:15:09.673] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:27:0) after 2m26s
[20:17:35.784] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:27:0)
[20:17:35.809] Build status: STARTED
[20:17:35.809] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:28:0) after 4m3s
[20:21:38.877] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:28:0)
[20:21:38.895] Build status: STARTED
[20:21:38.895] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:29:0) after 6m0s
[20:27:38.950] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:29:0)
[20:27:38.969] Build status: STARTED
[20:27:38.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:30:0) after 9m47s
[20:37:25.984] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:30:0)
[20:37:26.001] Build status: STARTED
[20:37:26.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902408939015956336:31:0) after 7m22s
[20:44:42.912] Received PubSub notification, asking Buildbucket for the build status
[20:44:42.935] Build:
{
"id": "8736978876663083393",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-12T18:11:04.550230872Z",
"startTime": "2024-09-12T18:11:13.482336877Z",
"endTime": "2024-09-12T20:44:42.225067559Z",
"updateTime": "2024-09-12T20:44:42.225067559Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "229f391f836c9250b7e0c3824e7152748bab220e",
"ref": "refs/heads/main"
}
}
}
[20:44:42.935] Invocation finished in 2h33m40.012219427s with status SUCCEEDED