[03:59:37.059] New invocation is queued and will start shortly
[03:59:37.059] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[03:59:38.226] Starting the invocation (attempt 1)
[03:59:38.256] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a3f61c8bfd277e0e6d65695f739f4432fb1fd721"
[03:59:38.256] Reconstructed gitiles commit from tags
[03:59:38.256] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:59:38.257] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:59:38.258] Buildbucket request:
{
"requestId": "8921578466350560112",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "f0cd973cb6d313448c925fe6190ce1c6cc6e4ee435c41b03a508d494abbe94b6/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "6d155b1fa75cf61fd9b4086228c66b6c8b95974f",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8921578466350560112",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "9a2867a38ed5e9432dfff30defad504c6b61a4d12603a918ed4ba948c80e1e3a/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "01019d57b469fab6a18814f115763ca0e7abb676",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "29d1aca05caa06e30d7a76ee15fd166fa32e1043"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/29d1aca05caa06e30d7a76ee15fd166fa32e1043",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "2675183c-0a82-4560-b297-f5bc4d042e58",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "29aa826f9a462fa79eb25823f5413138af23f483bc85816464d62bfda8bc6779/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "01019d57b469fab6a18814f115763ca0e7abb676",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "22d2f3aa3097feb9a91c6d7b8ef611a1cde6d0d5"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/22d2f3aa3097feb9a91c6d7b8ef611a1cde6d0d5",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "56d1bffb-2c6e-46ec-88d1-31e30ea6c29d",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "f0cd973cb6d313448c925fe6190ce1c6cc6e4ee435c41b03a508d494abbe94b6/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "6d155b1fa75cf61fd9b4086228c66b6c8b95974f",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a3f61c8bfd277e0e6d65695f739f4432fb1fd721"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a3f61c8bfd277e0e6d65695f739f4432fb1fd721",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "0ed0681c-6d6b-48ba-9848-ec8b48328f21",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a3f61c8bfd277e0e6d65695f739f4432fb1fd721"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a3f61c8bfd277e0e6d65695f739f4432fb1fd721",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8921578466350560112"
},
{
"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:59:38.701] Scheduled build:
{
"id": "8756148404362747873",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-14T03:59:38.325198325Z",
"updateTime": "2024-02-14T03:59:38.325198325Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a3f61c8bfd277e0e6d65695f739f4432fb1fd721",
"ref": "refs/heads/main"
}
}
}
[03:59:38.702] Task URL: https://cr-buildbucket.appspot.com/build/8756148404362747873
[03:59:38.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:2:0) after 5m39s
[03:59:46.130] Received PubSub notification, asking Buildbucket for the build status
[03:59:46.197] Build status: SCHEDULED
[04:00:44.823] Received PubSub notification, asking Buildbucket for the build status
[04:00:44.857] Build status: STARTED
[04:05:17.765] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:2:0)
[04:05:17.819] Build status: STARTED
[04:05:17.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:5:0) after 8m19s
[04:13:36.814] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:5:0)
[04:13:36.857] Build status: STARTED
[04:13:36.857] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:6:0) after 1m1s
[04:14:38.080] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:6:0)
[04:14:38.101] Build status: STARTED
[04:14:38.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:7:0) after 3m15s
[04:17:53.117] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:7:0)
[04:17:53.150] Build status: STARTED
[04:17:53.151] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:8:0) after 7m39s
[04:25:32.500] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:8:0)
[04:25:32.527] Build status: STARTED
[04:25:32.527] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:9:0) after 6m25s
[04:31:57.793] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:9:0)
[04:31:57.883] Build status: STARTED
[04:31:57.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:10:0) after 8m52s
[04:40:49.922] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:10:0)
[04:40:49.959] Build status: STARTED
[04:40:49.959] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:11:0) after 9m4s
[04:49:54.493] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:11:0)
[04:49:54.524] Build status: STARTED
[04:49:54.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:12:0) after 6m34s
[04:56:28.676] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:12:0)
[04:56:28.702] Build status: STARTED
[04:56:28.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:13:0) after 7m13s
[05:03:41.865] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:13:0)
[05:03:41.887] Build status: STARTED
[05:03:41.887] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:14:0) after 1m9s
[05:04:51.251] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:14:0)
[05:04:51.304] Build status: STARTED
[05:04:51.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:15:0) after 1m3s
[05:05:54.344] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:15:0)
[05:05:54.370] Build status: STARTED
[05:05:54.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:16:0) after 7m29s
[05:13:23.398] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:16:0)
[05:13:23.418] Build status: STARTED
[05:13:23.418] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:17:0) after 4m36s
[05:17:59.671] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:17:0)
[05:17:59.759] Build status: STARTED
[05:17:59.759] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:18:0) after 5m29s
[05:23:28.786] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:18:0)
[05:23:28.969] Build status: STARTED
[05:23:28.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:19:0) after 6m27s
[05:29:55.995] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:19:0)
[05:29:56.015] Build status: STARTED
[05:29:56.015] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:20:0) after 9m42s
[05:39:38.046] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:20:0)
[05:39:38.064] Build status: STARTED
[05:39:38.064] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:21:0) after 4m19s
[05:43:57.080] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:21:0)
[05:43:57.140] Build status: STARTED
[05:43:57.140] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:22:0) after 1m5s
[05:45:02.350] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:22:0)
[05:45:02.373] Build status: STARTED
[05:45:02.373] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:23:0) after 3m17s
[05:48:19.352] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:23:0)
[05:48:19.370] Build status: STARTED
[05:48:19.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:24:0) after 3m39s
[05:51:58.703] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:24:0)
[05:51:58.722] Build status: STARTED
[05:51:58.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:25:0) after 1m27s
[05:53:25.961] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:25:0)
[05:53:25.988] Build status: STARTED
[05:53:25.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:26:0) after 2m39s
[05:56:05.006] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:26:0)
[05:56:05.026] Build status: STARTED
[05:56:05.026] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921578466350560112:27:0) after 7m23s
[05:58:24.330] Received PubSub notification, asking Buildbucket for the build status
[05:58:24.354] Build:
{
"id": "8756148404362747873",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-14T03:59:38.325198325Z",
"startTime": "2024-02-14T04:00:21.439182Z",
"endTime": "2024-02-14T05:58:22.671174Z",
"updateTime": "2024-02-14T05:58:22.671174Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a3f61c8bfd277e0e6d65695f739f4432fb1fd721",
"ref": "refs/heads/main"
}
}
}
[05:58:24.354] Invocation finished in 1h58m47.308453839s with status SUCCEEDED