[03:05:04.418] New invocation is queued and will start shortly
[03:05:04.418] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[03:05:05.622] Starting the invocation (attempt 1)
[03:05:05.653] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2abcbbd96ad731b05fae970a0abb23cda784dddd"
[03:05:05.653] Reconstructed gitiles commit from tags
[03:05:05.653] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:05:05.653] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:05:05.654] Buildbucket request:
{
"requestId": "8922850255499170656",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "deb4c1fd7d58b0d4bdee927dc4345b1f1f3fecd1d303d5886261e8aa4ed271a7/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "366b8e24363ec7de7eecec13c9db51f3764b9337",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8922850255499170656",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "be46d193472fad78cdadc2cb7dee3dc7a9fbe54809db01e0228a2e371ca38bbb/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "366b8e24363ec7de7eecec13c9db51f3764b9337",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "b21a2f9365b6c5fd464a97be5dfe7085742870ef"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b21a2f9365b6c5fd464a97be5dfe7085742870ef",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "24b88165-e870-4203-a82e-c65c9b77b151",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "509121ec1addbee525237ecaa552d7b002f9cb1b5065b5ac79f142985ae745bc/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "366b8e24363ec7de7eecec13c9db51f3764b9337",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "b91bba89edfb25d011e1f2366cda5dec605c87f6"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b91bba89edfb25d011e1f2366cda5dec605c87f6",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "7925abff-2c58-43f5-8d43-581ade0503ec",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "deb4c1fd7d58b0d4bdee927dc4345b1f1f3fecd1d303d5886261e8aa4ed271a7/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "366b8e24363ec7de7eecec13c9db51f3764b9337",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "2abcbbd96ad731b05fae970a0abb23cda784dddd"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2abcbbd96ad731b05fae970a0abb23cda784dddd",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "49546aeb-9ae5-4d19-87c3-b184c0baba2a",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "2abcbbd96ad731b05fae970a0abb23cda784dddd"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2abcbbd96ad731b05fae970a0abb23cda784dddd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8922850255499170656"
},
{
"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"
}
}
[03:05:06.129] Scheduled build:
{
"id": "8757420193477513857",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-31T03:05:05.711068314Z",
"updateTime": "2024-01-31T03:05:05.711068314Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2abcbbd96ad731b05fae970a0abb23cda784dddd",
"ref": "refs/heads/main"
}
}
}
[03:05:06.130] Task URL: https://cr-buildbucket.appspot.com/build/8757420193477513857
[03:05:06.130] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:2:0) after 7m1s
[03:05:06.268] Received PubSub notification, asking Buildbucket for the build status
[03:05:06.325] Build status: SCHEDULED
[03:05:12.261] Received PubSub notification, asking Buildbucket for the build status
[03:05:12.292] Build status: STARTED
[03:12:07.147] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:2:0)
[03:12:07.220] Build status: STARTED
[03:12:07.220] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:5:0) after 8m31s
[03:20:38.239] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:5:0)
[03:20:38.260] Build status: STARTED
[03:20:38.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:6:0) after 3m48s
[03:24:26.413] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:6:0)
[03:24:26.449] Build status: STARTED
[03:24:26.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:7:0) after 3m43s
[03:28:09.610] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:7:0)
[03:28:09.635] Build status: STARTED
[03:28:09.635] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:8:0) after 1m45s
[03:29:54.652] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:8:0)
[03:29:54.670] Build status: STARTED
[03:29:54.670] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:9:0) after 3m41s
[03:33:35.649] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:9:0)
[03:33:35.667] Build status: STARTED
[03:33:35.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:10:0) after 4m16s
[03:37:51.723] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:10:0)
[03:37:51.747] Build status: STARTED
[03:37:51.747] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:11:0) after 8m48s
[03:46:40.067] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:11:0)
[03:46:40.099] Build status: STARTED
[03:46:40.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:12:0) after 7m8s
[03:53:48.130] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:12:0)
[03:53:48.157] Build status: STARTED
[03:53:48.157] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:13:0) after 3m1s
[03:56:49.459] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:13:0)
[03:56:49.487] Build status: STARTED
[03:56:49.487] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:14:0) after 3m8s
[03:59:57.609] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:14:0)
[03:59:57.628] Build status: STARTED
[03:59:57.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:15:0) after 2m47s
[04:02:44.976] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:15:0)
[04:02:44.995] Build status: STARTED
[04:02:44.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:16:0) after 4m6s
[04:06:51.107] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:16:0)
[04:06:51.125] Build status: STARTED
[04:06:51.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:17:0) after 5m42s
[04:12:33.149] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:17:0)
[04:12:33.176] Build status: STARTED
[04:12:33.176] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:18:0) after 2m28s
[04:15:01.308] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:18:0)
[04:15:01.333] Build status: STARTED
[04:15:01.333] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:19:0) after 3m12s
[04:18:13.499] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:19:0)
[04:18:13.516] Build status: STARTED
[04:18:13.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:20:0) after 2m48s
[04:21:01.660] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:20:0)
[04:21:01.775] Build status: STARTED
[04:21:01.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:21:0) after 2m31s
[04:23:33.287] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:21:0)
[04:23:33.310] Build status: STARTED
[04:23:33.311] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:22:0) after 8m12s
[04:31:45.370] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:22:0)
[04:31:45.391] Build status: STARTED
[04:31:45.391] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:23:0) after 7m36s
[04:39:21.431] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:23:0)
[04:39:21.452] Build status: STARTED
[04:39:21.452] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:24:0) after 5m11s
[04:44:32.459] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:24:0)
[04:44:32.483] Build status: STARTED
[04:44:32.483] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:25:0) after 6m13s
[04:50:45.546] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:25:0)
[04:50:45.569] Build status: STARTED
[04:50:45.569] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:26:0) after 9m21s
[05:00:06.664] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:26:0)
[05:00:06.697] Build status: STARTED
[05:00:06.697] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922850255499170656:27:0) after 3m55s
[05:02:23.579] Received PubSub notification, asking Buildbucket for the build status
[05:02:23.599] Build:
{
"id": "8757420193477513857",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-31T03:05:05.711068314Z",
"startTime": "2024-01-31T03:05:11.724259841Z",
"endTime": "2024-01-31T05:02:22.936461Z",
"updateTime": "2024-01-31T05:02:22.936461Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2abcbbd96ad731b05fae970a0abb23cda784dddd",
"ref": "refs/heads/main"
}
}
}
[05:02:23.599] Invocation finished in 1h57m19.200097853s with status SUCCEEDED