[22:00:18.419] New invocation is queued and will start shortly
[22:00:18.419] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[22:00:19.593] Starting the invocation (attempt 1)
[22:00:19.618] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a9ea11b694c17a5f94077036f8bb5d21ea922863"
[22:00:19.618] Reconstructed gitiles commit from tags
[22:00:19.618] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:00:19.618] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:00:19.618] Buildbucket request:
{
"requestId": "8934375244478756736",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "fe56894d689eada9c179299885fed4ee7ca8fc5e6047fef2d3cebce66e7022be/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "187b40a086b8266d482577d460ff6d539a6bc75e",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8934375244478756736",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "73af5019c489e231ff868d736be450d21aaa621a50406d43599d8c91307c8e5d/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "187b40a086b8266d482577d460ff6d539a6bc75e",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a677a173273f7735a3a5447a47851591b984e7aa"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a677a173273f7735a3a5447a47851591b984e7aa",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "d4d43a94-f9ab-4fec-b0e0-38955ef95de1",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "40fa072c64d0f30b49de47d7830618a0ac2e9786e373ad0a4501367c9facce1d/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "187b40a086b8266d482577d460ff6d539a6bc75e",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "d3505c28a770fabd77d7483afbca383d453bef02"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d3505c28a770fabd77d7483afbca383d453bef02",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "86fb8c78-582b-4dec-b131-02a0b6e97fc1",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "b316fc78009751e5c0001f4f7322ec0a9b098f2ba0cd7a03244061bff328905a/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "187b40a086b8266d482577d460ff6d539a6bc75e",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "62f5636838ac80ebe8db9c31cdf9c5566db8f0c9"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/62f5636838ac80ebe8db9c31cdf9c5566db8f0c9",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "05351f65-692f-42e3-a21a-afc5d0fd5e85",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "fe56894d689eada9c179299885fed4ee7ca8fc5e6047fef2d3cebce66e7022be/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "187b40a086b8266d482577d460ff6d539a6bc75e",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a9ea11b694c17a5f94077036f8bb5d21ea922863"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a9ea11b694c17a5f94077036f8bb5d21ea922863",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "7700259b-11bb-4d29-92ed-abc72bf291a9",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a9ea11b694c17a5f94077036f8bb5d21ea922863"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a9ea11b694c17a5f94077036f8bb5d21ea922863",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8934375244478756736"
},
{
"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"
}
}
[22:00:20.739] Scheduled build:
{
"id": "8768945182465835825",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-25T22:00:19.716363567Z",
"updateTime": "2023-09-25T22:00:19.716363567Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a9ea11b694c17a5f94077036f8bb5d21ea922863",
"ref": "refs/heads/main"
}
}
}
[22:00:20.739] Task URL: https://cr-buildbucket.appspot.com/build/8768945182465835825
[22:00:20.739] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:2:0) after 1m33s
[22:00:21.326] Received PubSub notification, asking Buildbucket for the build status
[22:00:21.359] Build status: SCHEDULED
[22:01:47.444] Received PubSub notification, asking Buildbucket for the build status
[22:01:47.467] Build status: STARTED
[22:01:54.240] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:2:0)
[22:01:54.268] Build status: STARTED
[22:01:54.268] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:5:0) after 1m53s
[22:03:47.297] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:5:0)
[22:03:47.321] Build status: STARTED
[22:03:47.321] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:6:0) after 8m23s
[22:12:10.756] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:6:0)
[22:12:10.785] Build status: STARTED
[22:12:10.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:7:0) after 5m3s
[22:17:14.099] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:7:0)
[22:17:14.122] Build status: STARTED
[22:17:14.122] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:8:0) after 5m0s
[22:24:43.731] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:8:0)
[22:24:43.752] Build status: STARTED
[22:24:43.752] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:9:0) after 3m42s
[22:30:16.976] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:9:0)
[22:30:16.999] Build status: STARTED
[22:30:16.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:10:0) after 8m56s
[22:39:13.919] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:10:0)
[22:39:13.937] Build status: STARTED
[22:39:13.937] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:11:0) after 5m31s
[22:44:45.024] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:11:0)
[22:44:45.044] Build status: STARTED
[22:44:45.045] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:12:0) after 3m22s
[22:48:07.255] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:12:0)
[22:48:07.276] Build status: STARTED
[22:48:07.276] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:13:0) after 1m43s
[22:49:50.535] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:13:0)
[22:49:50.554] Build status: STARTED
[22:49:50.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:14:0) after 1m31s
[22:51:21.577] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:14:0)
[22:51:21.594] Build status: STARTED
[22:51:21.594] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:15:0) after 1m41s
[22:53:02.799] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:15:0)
[22:53:02.825] Build status: STARTED
[22:53:02.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:16:0) after 8m8s
[23:01:10.959] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:16:0)
[23:01:10.992] Build status: STARTED
[23:01:10.992] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:17:0) after 2m14s
[23:03:25.174] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:17:0)
[23:03:25.194] Build status: STARTED
[23:03:25.194] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:18:0) after 6m45s
[23:10:10.502] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:18:0)
[23:10:10.526] Build status: STARTED
[23:10:10.526] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:19:0) after 2m58s
[23:13:09.138] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:19:0)
[23:13:09.158] Build status: STARTED
[23:13:09.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:20:0) after 8m36s
[23:21:45.352] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:20:0)
[23:21:45.372] Build status: STARTED
[23:21:45.372] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:21:0) after 1m44s
[23:23:29.388] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:21:0)
[23:23:29.407] Build status: STARTED
[23:23:29.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:22:0) after 7m19s
[23:30:48.427] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:22:0)
[23:30:48.447] Build status: STARTED
[23:30:48.447] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:23:0) after 7m8s
[23:37:56.590] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:23:0)
[23:37:56.613] Build status: STARTED
[23:37:56.614] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:24:0) after 3m36s
[23:41:32.636] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:24:0)
[23:41:32.654] Build status: STARTED
[23:41:32.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:25:0) after 2m57s
[23:44:29.668] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:25:0)
[23:44:29.690] Build status: STARTED
[23:44:29.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:26:0) after 6m47s
[23:51:16.950] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:26:0)
[23:51:16.969] Build status: STARTED
[23:51:16.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8934375244478756736:27:0) after 1m2s
[23:52:03.001] Received PubSub notification, asking Buildbucket for the build status
[23:52:03.026] Build:
{
"id": "8768945182465835825",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-25T22:00:19.716363567Z",
"startTime": "2023-09-25T22:01:46.705630Z",
"endTime": "2023-09-25T23:52:02.216125995Z",
"updateTime": "2023-09-25T23:52:02.216125995Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a9ea11b694c17a5f94077036f8bb5d21ea922863",
"ref": "refs/heads/main"
}
}
}
[23:52:03.026] Invocation finished in 1h51m44.613647854s with status SUCCEEDED