[04:27:58.229] New invocation is queued and will start shortly
[04:27:58.229] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[04:27:59.306] Starting the invocation (attempt 1)
[04:27:59.334] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/39cf8803391e695c7ec3a85fc1b2c4622f52b481"
[04:27:59.334] Reconstructed gitiles commit from tags
[04:27:59.334] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:27:59.334] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:27:59.335] Buildbucket request:
{
"requestId": "8910886240503639456",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "b9a2be80f4a61b355b74c169c7e23efd9e87c1aa450c76416c1b316da9b894ed/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "855121c12cff3b9cc114112f44489515c6665dd4",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8910886240503639456",
"job": "fuchsia/clang_toolchain.ci.core.x64-release",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "4d3482713e08723817aaca75fd6d74e597c6c57e115111d0331330b972493448/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "db4ebe4598b751888f67f7f49c1503166784d880",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "cb63abca27e1813ae58ded466cd81ba3952ab888"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/cb63abca27e1813ae58ded466cd81ba3952ab888",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "5599444e-de97-4305-af39-fe3ca113e760",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "603ac763c43ac30c0c127c1de6b6321d50e925e40d2b1c94fd20c98e195b4172/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "db4ebe4598b751888f67f7f49c1503166784d880",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "69e9e779b783bb34a3c1f73c93ca63ee6b89ab09"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/69e9e779b783bb34a3c1f73c93ca63ee6b89ab09",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "dc2cee15-1e5a-4753-88d2-267fb6552718",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "b9a2be80f4a61b355b74c169c7e23efd9e87c1aa450c76416c1b316da9b894ed/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "855121c12cff3b9cc114112f44489515c6665dd4",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "39cf8803391e695c7ec3a85fc1b2c4622f52b481"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/39cf8803391e695c7ec3a85fc1b2c4622f52b481",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "73b9f9b9-7daa-469f-bc1a-5c5d2e28e091",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "39cf8803391e695c7ec3a85fc1b2c4622f52b481"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "39cf8803391e695c7ec3a85fc1b2c4622f52b481",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8910886240503639456"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.x64-release"
},
{
"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"
}
}
[04:28:00.113] Scheduled build:
{
"id": "8745456178581434561",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-11T04:27:59.438323560Z",
"updateTime": "2024-06-11T04:27:59.438323560Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "39cf8803391e695c7ec3a85fc1b2c4622f52b481",
"ref": "refs/heads/main"
}
}
}
[04:28:00.114] Task URL: https://cr-buildbucket.appspot.com/build/8745456178581434561
[04:28:00.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:2:0) after 2m42s
[04:28:00.982] Received PubSub notification, asking Buildbucket for the build status
[04:28:00.998] Build status: SCHEDULED
[04:28:06.049] Received PubSub notification, asking Buildbucket for the build status
[04:28:06.077] Build status: STARTED
[04:30:42.297] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:2:0)
[04:30:42.314] Build status: STARTED
[04:30:42.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:5:0) after 2m4s
[04:32:46.378] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:5:0)
[04:32:46.401] Build status: STARTED
[04:32:46.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:6:0) after 2m8s
[04:34:54.669] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:6:0)
[04:34:54.698] Build status: STARTED
[04:34:54.698] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:7:0) after 4m10s
[04:39:04.715] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:7:0)
[04:39:04.751] Build status: STARTED
[04:39:04.751] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:8:0) after 2m34s
[04:41:38.815] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:8:0)
[04:41:38.834] Build status: STARTED
[04:41:38.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:9:0) after 5m56s
[04:47:35.045] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:9:0)
[04:47:35.136] Build status: STARTED
[04:47:35.136] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:10:0) after 6m56s
[04:54:31.304] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:10:0)
[04:54:31.336] Build status: STARTED
[04:54:31.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:11:0) after 5m36s
[05:00:07.384] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:11:0)
[05:00:07.403] Build status: STARTED
[05:00:07.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:12:0) after 9m35s
[05:09:42.528] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:12:0)
[05:09:42.618] Build status: STARTED
[05:09:42.618] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:13:0) after 6m34s
[05:16:16.649] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:13:0)
[05:16:16.670] Build status: STARTED
[05:16:16.670] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:14:0) after 7m21s
[05:23:37.688] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:14:0)
[05:23:37.906] Build status: STARTED
[05:23:37.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:15:0) after 1m57s
[05:25:34.977] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:15:0)
[05:25:34.997] Build status: STARTED
[05:25:34.997] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:16:0) after 1m9s
[05:26:44.024] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:16:0)
[05:26:44.042] Build status: STARTED
[05:26:44.042] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:17:0) after 6m31s
[05:33:15.057] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:17:0)
[05:33:15.090] Build status: STARTED
[05:33:15.090] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:18:0) after 8m7s
[05:41:22.120] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:18:0)
[05:41:22.145] Build status: STARTED
[05:41:22.145] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:19:0) after 3m53s
[05:45:15.155] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:19:0)
[05:45:15.178] Build status: STARTED
[05:45:15.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:20:0) after 2m57s
[05:48:12.501] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:20:0)
[05:48:12.521] Build status: STARTED
[05:48:12.521] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:21:0) after 9m8s
[05:57:20.825] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:21:0)
[05:57:20.866] Build status: STARTED
[05:57:20.866] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:22:0) after 5m33s
[06:02:53.985] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:22:0)
[06:02:54.005] Build status: STARTED
[06:02:54.006] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:23:0) after 5m48s
[06:08:42.027] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:23:0)
[06:08:42.060] Build status: STARTED
[06:08:42.060] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:24:0) after 3m34s
[06:12:16.468] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:24:0)
[06:12:16.498] Build status: STARTED
[06:12:16.498] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:25:0) after 2m41s
[06:14:57.519] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:25:0)
[06:14:57.537] Build status: STARTED
[06:14:57.537] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:26:0) after 6m59s
[06:21:56.771] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:26:0)
[06:21:56.819] Build status: STARTED
[06:21:56.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:27:0) after 4m53s
[06:26:49.903] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:27:0)
[06:26:50.020] Build status: STARTED
[06:26:50.020] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:28:0) after 3m4s
[06:29:54.065] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:28:0)
[06:29:54.095] Build status: STARTED
[06:29:54.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:29:0) after 2m7s
[06:32:01.122] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:29:0)
[06:32:01.144] Build status: STARTED
[06:32:01.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:30:0) after 3m50s
[06:35:51.263] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:30:0)
[06:35:51.318] Build status: STARTED
[06:35:51.318] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:31:0) after 3m56s
[06:39:47.397] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:31:0)
[06:39:47.473] Build status: STARTED
[06:39:47.473] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:32:0) after 3m28s
[06:43:15.493] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:32:0)
[06:43:15.518] Build status: STARTED
[06:43:15.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:33:0) after 1m15s
[06:44:30.534] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:33:0)
[06:44:30.570] Build status: STARTED
[06:44:30.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:34:0) after 4m44s
[06:49:14.619] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:34:0)
[06:49:14.637] Build status: STARTED
[06:49:14.637] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:35:0) after 5m1s
[06:54:15.806] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:35:0)
[06:54:15.829] Build status: STARTED
[06:54:15.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:36:0) after 1m29s
[06:55:44.839] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:36:0)
[06:55:44.865] Build status: STARTED
[06:55:44.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:37:0) after 9m1s
[07:04:45.980] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:37:0)
[07:04:45.998] Build status: STARTED
[07:04:45.998] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:38:0) after 8m39s
[07:13:25.024] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:38:0)
[07:13:25.045] Build status: STARTED
[07:13:25.045] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8910886240503639456:39:0) after 4m32s
[07:13:48.650] Received PubSub notification, asking Buildbucket for the build status
[07:13:48.664] Build:
{
"id": "8745456178581434561",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-11T04:27:59.438323560Z",
"startTime": "2024-06-11T04:28:05.215129026Z",
"endTime": "2024-06-11T07:13:48.248205234Z",
"updateTime": "2024-06-11T07:13:48.248205234Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "39cf8803391e695c7ec3a85fc1b2c4622f52b481",
"ref": "refs/heads/main"
}
}
}
[07:13:48.664] Invocation finished in 2h45m50.443805129s with status SUCCEEDED