[13:45:26.620] New invocation is queued and will start shortly
[13:45:26.620] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[13:45:27.953] Starting the invocation (attempt 1)
[13:45:27.978] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/be2388c0d9923ed02fa4723fe9a06f07a0491fe5"
[13:45:27.978] Reconstructed gitiles commit from tags
[13:45:27.978] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:45:27.978] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:45:27.979] Buildbucket request:
{
"requestId": "8929695336341755104",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "7fad429785beb1f81d78e6dfa690c5c000b39306366969a1614f089739e83afa/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "89e2530fcecbfd4a377941330fa5ec0a9a88548c",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8929695336341755104",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "e74fb8c14d2b98721f67171553cb1a9184cbdce69f757c1ffb5d20ef395f0570/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "89e2530fcecbfd4a377941330fa5ec0a9a88548c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "5edf58614625873782b4574a714b90d3822b06dc"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/5edf58614625873782b4574a714b90d3822b06dc",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "f91d5b08-585e-4be5-b59e-2800fe8b1b90",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "97775fdc76b2c069f9a9f87e58560f683c15164a5960de658aa5635e9d1ed9e2/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "89e2530fcecbfd4a377941330fa5ec0a9a88548c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "865f54e501739f382d33866baebfd0f9aaad01bb"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/865f54e501739f382d33866baebfd0f9aaad01bb",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "f38226bb-6043-45a9-b48c-974560ed92fc",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "1d9d209ea599e3c89b3ac6f103710c0cc5554c7d5f5f4809bf26933c43e71c9e/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "89e2530fcecbfd4a377941330fa5ec0a9a88548c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "95eaaa7d7157fcf5d920eff9aff9b67789322a58"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/95eaaa7d7157fcf5d920eff9aff9b67789322a58",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "62a863ca-fa6e-4611-8fd2-0a6f31b82e96",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "7fad429785beb1f81d78e6dfa690c5c000b39306366969a1614f089739e83afa/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "89e2530fcecbfd4a377941330fa5ec0a9a88548c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "be2388c0d9923ed02fa4723fe9a06f07a0491fe5"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/be2388c0d9923ed02fa4723fe9a06f07a0491fe5",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "fb2b5950-4529-4f60-bc8c-8fec03de14e0",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "be2388c0d9923ed02fa4723fe9a06f07a0491fe5"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "be2388c0d9923ed02fa4723fe9a06f07a0491fe5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8929695336341755104"
},
{
"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"
}
}
[13:45:28.577] Scheduled build:
{
"id": "8764265274189235153",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-16T13:45:28.042362058Z",
"updateTime": "2023-11-16T13:45:28.042362058Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "be2388c0d9923ed02fa4723fe9a06f07a0491fe5",
"ref": "refs/heads/main"
}
}
}
[13:45:28.577] Task URL: https://cr-buildbucket.appspot.com/build/8764265274189235153
[13:45:28.577] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:2:0) after 7m11s
[13:45:29.660] Received PubSub notification, asking Buildbucket for the build status
[13:45:29.738] Build status: STARTED
[13:45:30.025] Received PubSub notification, asking Buildbucket for the build status
[13:45:30.054] Build status: STARTED
[13:52:39.701] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:2:0)
[13:52:39.729] Build status: STARTED
[13:52:39.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:5:0) after 2m27s
[13:55:06.869] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:5:0)
[13:55:06.890] Build status: STARTED
[13:55:06.890] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:6:0) after 3m21s
[13:58:27.986] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:6:0)
[13:58:28.031] Build status: STARTED
[13:58:28.034] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:7:0) after 7m57s
[14:06:25.076] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:7:0)
[14:06:25.102] Build status: STARTED
[14:06:25.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:8:0) after 2m42s
[14:09:07.199] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:8:0)
[14:09:07.247] Build status: STARTED
[14:09:07.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:9:0) after 4m23s
[14:13:30.525] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:9:0)
[14:13:30.552] Build status: STARTED
[14:13:30.552] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:10:0) after 2m49s
[14:16:19.736] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:10:0)
[14:16:19.817] Build status: STARTED
[14:16:19.817] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:11:0) after 8m20s
[14:24:39.877] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:11:0)
[14:24:39.963] Build status: STARTED
[14:24:39.963] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:12:0) after 1m56s
[14:26:36.070] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:12:0)
[14:26:36.169] Build status: STARTED
[14:26:36.169] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:13:0) after 3m44s
[14:30:20.368] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:13:0)
[14:30:20.415] Build status: STARTED
[14:30:20.415] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:14:0) after 4m8s
[14:34:28.948] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:14:0)
[14:34:28.990] Build status: STARTED
[14:34:28.990] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:15:0) after 4m18s
[14:38:47.016] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:15:0)
[14:38:47.061] Build status: STARTED
[14:38:47.061] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:16:0) after 1m21s
[14:40:08.106] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:16:0)
[14:40:08.139] Build status: STARTED
[14:40:08.139] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:17:0) after 4m53s
[14:45:01.161] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:17:0)
[14:45:01.211] Build status: STARTED
[14:45:01.211] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:18:0) after 8m38s
[14:53:39.319] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:18:0)
[14:53:39.342] Build status: STARTED
[14:53:39.342] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:19:0) after 7m49s
[15:01:28.637] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:19:0)
[15:01:28.720] Build status: STARTED
[15:01:28.720] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:20:0) after 4m36s
[15:06:04.740] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:20:0)
[15:06:04.772] Build status: STARTED
[15:06:04.773] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:21:0) after 6m49s
[15:12:53.890] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:21:0)
[15:12:53.968] Build status: STARTED
[15:12:53.968] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:22:0) after 7m2s
[15:19:55.989] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:22:0)
[15:19:56.024] Build status: STARTED
[15:19:56.024] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:23:0) after 8m40s
[15:28:36.228] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:23:0)
[15:28:36.252] Build status: STARTED
[15:28:36.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:24:0) after 4m19s
[15:32:55.285] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:24:0)
[15:32:55.307] Build status: STARTED
[15:32:55.307] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:25:0) after 5m13s
[15:38:08.903] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:25:0)
[15:38:08.928] Build status: STARTED
[15:38:08.928] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:26:0) after 6m56s
[15:45:06.029] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:26:0)
[15:45:06.048] Build status: STARTED
[15:45:06.048] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:27:0) after 6m17s
[15:51:23.356] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:27:0)
[15:51:23.397] Build status: STARTED
[15:51:23.397] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:28:0) after 3m23s
[15:54:46.420] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:28:0)
[15:54:46.474] Build status: STARTED
[15:54:46.474] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8929695336341755104:29:0) after 8m57s
[16:00:11.653] Received PubSub notification, asking Buildbucket for the build status
[16:00:11.778] Build:
{
"id": "8764265274189235153",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-16T13:45:28.042362058Z",
"startTime": "2023-11-16T13:45:29.200153Z",
"endTime": "2023-11-16T16:00:09.387673Z",
"updateTime": "2023-11-16T16:00:09.387673Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "be2388c0d9923ed02fa4723fe9a06f07a0491fe5",
"ref": "refs/heads/main"
}
}
}
[16:00:11.778] Invocation finished in 2h14m45.172172062s with status FAILED