[14:48:26.388] New invocation is queued and will start shortly
[14:48:26.388] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[14:48:27.481] Starting the invocation (attempt 1)
[14:48:27.511] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f445be9790f9998e9048fc2a12402f3e213c079f"
[14:48:27.511] Reconstructed gitiles commit from tags
[14:48:27.511] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:48:27.514] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:48:27.514] Buildbucket request:
{
"requestId": "8932862266793451536",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "e362ec35b1da010095dc3df44f18f420d038570ff0285c994d57338af582a25e/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a664b950d34a7dbc0b654baf0200235558caa0b5",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8932862266793451536",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "a4686ce02ecaec0d8831c31cb1f862f063e3fbf53b59fe50b87c2c8f1d473d53/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f5ebcab5f61cfb841926809c0fab1ce0fbd2449b",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "e44c9fd197a2209b6b7b266fb0a381ee8fcec12b"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e44c9fd197a2209b6b7b266fb0a381ee8fcec12b",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "94c9abc0-05da-4d4c-86b5-16fa7fedbd06",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "c96961f17b9f83f956397d41394b3e983ee86bd124af8f6ca1a398ce41008e6f/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f5ebcab5f61cfb841926809c0fab1ce0fbd2449b",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "30240e428f0ec7d4a6d1b84f9f807ce12b46cfd1"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/30240e428f0ec7d4a6d1b84f9f807ce12b46cfd1",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "88e6f330-230e-4a3a-b881-611d6287c15e",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "e362ec35b1da010095dc3df44f18f420d038570ff0285c994d57338af582a25e/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a664b950d34a7dbc0b654baf0200235558caa0b5",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f445be9790f9998e9048fc2a12402f3e213c079f"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f445be9790f9998e9048fc2a12402f3e213c079f",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "36612e93-ac24-4267-ab52-1b87b71321e8",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f445be9790f9998e9048fc2a12402f3e213c079f"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f445be9790f9998e9048fc2a12402f3e213c079f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8932862266793451536"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.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"
}
}
[14:48:28.115] Scheduled build:
{
"id": "8767432204882721953",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-12T14:48:27.578295638Z",
"updateTime": "2023-10-12T14:48:27.578295638Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f445be9790f9998e9048fc2a12402f3e213c079f",
"ref": "refs/heads/main"
}
}
}
[14:48:28.115] Task URL: https://cr-buildbucket.appspot.com/build/8767432204882721953
[14:48:28.115] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:2:0) after 2m35s
[14:48:29.006] Received PubSub notification, asking Buildbucket for the build status
[14:48:29.100] Build status: SCHEDULED
[14:48:29.366] Received PubSub notification, asking Buildbucket for the build status
[14:48:29.393] Build status: STARTED
[14:51:03.185] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:2:0)
[14:51:03.202] Build status: STARTED
[14:51:03.202] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:5:0) after 3m11s
[14:54:14.246] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:5:0)
[14:54:14.271] Build status: STARTED
[14:54:14.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:6:0) after 6m26s
[15:00:40.392] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:6:0)
[15:00:40.507] Build status: STARTED
[15:00:40.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:7:0) after 2m51s
[15:03:31.527] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:7:0)
[15:03:31.551] Build status: STARTED
[15:03:31.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:8:0) after 3m48s
[15:07:19.586] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:8:0)
[15:07:19.611] Build status: STARTED
[15:07:19.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:9:0) after 5m0s
[15:12:19.631] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:9:0)
[15:12:19.671] Build status: STARTED
[15:12:19.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:10:0) after 8m1s
[15:20:20.778] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:10:0)
[15:20:20.855] Build status: STARTED
[15:20:20.855] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:11:0) after 3m34s
[15:23:54.917] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:11:0)
[15:23:54.945] Build status: STARTED
[15:23:54.946] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:12:0) after 4m34s
[15:28:28.970] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:12:0)
[15:28:29.010] Build status: STARTED
[15:28:29.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:13:0) after 8m18s
[15:36:47.149] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:13:0)
[15:36:47.189] Build status: STARTED
[15:36:47.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:14:0) after 4m7s
[15:40:54.207] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:14:0)
[15:40:54.235] Build status: STARTED
[15:40:54.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:15:0) after 6m52s
[15:47:46.236] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:15:0)
[15:47:46.257] Build status: STARTED
[15:47:46.257] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:16:0) after 4m8s
[15:51:54.295] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:16:0)
[15:51:57.088] Build status: STARTED
[15:51:57.088] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:17:0) after 4m39s
[15:56:36.126] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:17:0)
[15:56:36.157] Build status: STARTED
[15:56:36.157] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:18:0) after 8m4s
[16:04:40.259] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:18:0)
[16:04:40.301] Build status: STARTED
[16:04:40.302] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:19:0) after 8m18s
[16:12:58.453] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:19:0)
[16:12:58.474] Build status: STARTED
[16:12:58.474] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:20:0) after 7m40s
[16:20:38.728] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:20:0)
[16:20:38.748] Build status: STARTED
[16:20:38.748] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:21:0) after 5m29s
[16:26:07.847] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:21:0)
[16:26:07.891] Build status: STARTED
[16:26:07.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:22:0) after 5m27s
[16:31:35.017] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:22:0)
[16:31:35.044] Build status: STARTED
[16:31:35.044] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:23:0) after 3m15s
[16:34:50.152] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:23:0)
[16:34:50.176] Build status: STARTED
[16:34:50.176] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8932862266793451536:24:0) after 9m15s
[16:40:24.115] Received PubSub notification, asking Buildbucket for the build status
[16:40:24.134] Build:
{
"id": "8767432204882721953",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-12T14:48:27.578295638Z",
"startTime": "2023-10-12T14:48:28.679881Z",
"endTime": "2023-10-12T16:40:23.434130687Z",
"updateTime": "2023-10-12T16:40:23.434130687Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f445be9790f9998e9048fc2a12402f3e213c079f",
"ref": "refs/heads/main"
}
}
}
[16:40:24.134] Invocation finished in 1h51m57.761575501s with status FAILED