[02:52:26.218] New invocation is queued and will start shortly
[02:52:26.219] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[02:52:27.380] Starting the invocation (attempt 1)
[02:52:27.413] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/6642cc60a21f857bddde8ec2c81008a83a54b4d3"
[02:52:27.413] Reconstructed gitiles commit from tags
[02:52:27.413] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:52:27.413] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:52:27.414] Buildbucket request:
{
"requestId": "8913338369051487088",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "78bab27286edb89c549a7d41c58ebe37bb4d958ba413378b59e9194dd40a8a26/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "52b225259789ee1b5a45879af6bde22ec5e4b41b",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8913338369051487088",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "5f661b416bc97850ad189fded6a0da9e8d3ef01851277ba513e3bb3529fb587f/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "52b225259789ee1b5a45879af6bde22ec5e4b41b",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "c5cd049566a795ba5de88dfbb2eb563cad4a9d8a"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c5cd049566a795ba5de88dfbb2eb563cad4a9d8a",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "1d8c4363-8d13-4c9d-9d0d-41a211e8ae3a",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "ea66fa17c88fc136d77c60bade73926cbda1ab278d0d11210ee49ea1bf1a7ae0/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "52b225259789ee1b5a45879af6bde22ec5e4b41b",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "dfdc3dcbe7f38bde64bc83a74b9c3451c50e1ad4"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/dfdc3dcbe7f38bde64bc83a74b9c3451c50e1ad4",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "7d93c474-9d51-4518-9348-f015e2a7a456",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "d9c50455d5a2ac56fe33201961a1d6b87b3faa1c5dce16dc021452fbf349379a/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "52b225259789ee1b5a45879af6bde22ec5e4b41b",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "4d1ecf192313b612090d60181937eff03c1a966b"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4d1ecf192313b612090d60181937eff03c1a966b",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "d2f76134-491f-443e-82d9-361e74aa4dc8",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "78bab27286edb89c549a7d41c58ebe37bb4d958ba413378b59e9194dd40a8a26/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "52b225259789ee1b5a45879af6bde22ec5e4b41b",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "6642cc60a21f857bddde8ec2c81008a83a54b4d3"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/6642cc60a21f857bddde8ec2c81008a83a54b4d3",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "e5939c79-68a8-4903-a94a-d570c57c09ab",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "6642cc60a21f857bddde8ec2c81008a83a54b4d3"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6642cc60a21f857bddde8ec2c81008a83a54b4d3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8913338369051487088"
},
{
"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"
}
}
[02:52:27.876] Scheduled build:
{
"id": "8747908307018016305",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-15T02:52:27.528210714Z",
"updateTime": "2024-05-15T02:52:27.528210714Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6642cc60a21f857bddde8ec2c81008a83a54b4d3",
"ref": "refs/heads/main"
}
}
}
[02:52:27.876] Task URL: https://cr-buildbucket.appspot.com/build/8747908307018016305
[02:52:27.877] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:2:0) after 3m44s
[02:52:36.481] Received PubSub notification, asking Buildbucket for the build status
[02:52:36.499] Build status: SCHEDULED
[02:53:35.922] Received PubSub notification, asking Buildbucket for the build status
[02:53:35.949] Build status: STARTED
[02:56:11.897] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:2:0)
[02:56:11.920] Build status: STARTED
[02:56:11.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:5:0) after 6m29s
[03:02:40.945] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:5:0)
[03:02:40.962] Build status: STARTED
[03:02:40.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:6:0) after 6m52s
[03:09:32.979] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:6:0)
[03:09:33.003] Build status: STARTED
[03:09:33.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:7:0) after 2m55s
[03:12:28.034] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:7:0)
[03:12:28.059] Build status: STARTED
[03:12:28.059] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:8:0) after 1m15s
[03:13:43.156] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:8:0)
[03:13:43.174] Build status: STARTED
[03:13:43.174] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:9:0) after 4m7s
[03:17:50.270] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:9:0)
[03:17:50.288] Build status: STARTED
[03:17:50.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:10:0) after 5m51s
[03:23:41.276] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:10:0)
[03:23:41.325] Build status: STARTED
[03:23:41.326] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:11:0) after 6m48s
[03:30:29.370] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:11:0)
[03:30:29.393] Build status: STARTED
[03:30:29.393] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:12:0) after 7m28s
[03:37:57.414] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:12:0)
[03:37:57.434] Build status: STARTED
[03:37:57.435] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:13:0) after 4m40s
[03:42:37.542] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:13:0)
[03:42:37.596] Build status: STARTED
[03:42:37.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:14:0) after 7m10s
[03:49:47.628] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:14:0)
[03:49:47.645] Build status: STARTED
[03:49:47.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:15:0) after 7m27s
[03:57:14.734] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:15:0)
[03:57:14.758] Build status: STARTED
[03:57:14.758] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:16:0) after 6m53s
[04:04:07.798] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:16:0)
[04:04:07.816] Build status: STARTED
[04:04:07.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:17:0) after 7m24s
[04:11:31.972] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:17:0)
[04:11:31.991] Build status: STARTED
[04:11:31.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:18:0) after 8m0s
[04:19:32.035] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:18:0)
[04:19:32.123] Build status: STARTED
[04:19:32.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:19:0) after 1m5s
[04:20:37.240] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:19:0)
[04:20:37.257] Build status: STARTED
[04:20:37.257] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:20:0) after 1m21s
[04:21:58.268] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:20:0)
[04:21:58.285] Build status: STARTED
[04:21:58.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:21:0) after 4m5s
[04:26:03.327] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:21:0)
[04:26:03.363] Build status: STARTED
[04:26:03.363] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:22:0) after 7m59s
[04:34:02.443] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:22:0)
[04:34:02.489] Build status: STARTED
[04:34:02.489] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:23:0) after 9m5s
[04:43:07.591] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:23:0)
[04:43:07.611] Build status: STARTED
[04:43:07.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:24:0) after 6m50s
[04:49:57.628] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:24:0)
[04:49:57.671] Build status: STARTED
[04:49:57.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:25:0) after 9m2s
[04:58:59.771] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:25:0)
[04:58:59.790] Build status: STARTED
[04:58:59.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:26:0) after 2m20s
[05:01:19.811] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:26:0)
[05:01:20.064] Build status: STARTED
[05:01:20.064] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:27:0) after 7m47s
[05:09:07.087] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:27:0)
[05:09:07.166] Build status: STARTED
[05:09:07.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:28:0) after 2m34s
[05:11:41.200] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:28:0)
[05:11:41.222] Build status: STARTED
[05:11:41.222] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:29:0) after 8m25s
[05:20:06.280] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:29:0)
[05:20:06.314] Build status: STARTED
[05:20:06.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:30:0) after 2m18s
[05:22:24.314] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:30:0)
[05:22:24.334] Build status: STARTED
[05:22:24.334] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:31:0) after 2m1s
[05:24:25.386] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:31:0)
[05:24:25.404] Build status: STARTED
[05:24:25.404] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:32:0) after 5m42s
[05:30:07.448] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:32:0)
[05:30:07.476] Build status: STARTED
[05:30:07.476] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:33:0) after 8m13s
[05:38:20.827] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:33:0)
[05:38:20.846] Build status: STARTED
[05:38:20.846] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:34:0) after 5m58s
[05:44:18.974] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:34:0)
[05:44:18.996] Build status: STARTED
[05:44:18.996] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:35:0) after 8m22s
[05:52:41.071] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:35:0)
[05:52:41.103] Build status: STARTED
[05:52:41.103] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:36:0) after 6m50s
[05:59:31.134] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:36:0)
[05:59:31.151] Build status: STARTED
[05:59:31.151] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:37:0) after 5m15s
[06:04:46.434] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:37:0)
[06:04:46.467] Build status: STARTED
[06:04:46.467] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:38:0) after 7m22s
[06:12:08.469] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:38:0)
[06:12:08.536] Build status: STARTED
[06:12:08.536] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:39:0) after 2m33s
[06:14:41.576] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:39:0)
[06:14:41.637] Build status: STARTED
[06:14:41.637] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:40:0) after 3m42s
[06:18:23.667] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:40:0)
[06:18:23.690] Build status: STARTED
[06:18:23.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:41:0) after 1m20s
[06:19:43.720] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:41:0)
[06:19:43.742] Build status: STARTED
[06:19:43.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:42:0) after 6m48s
[06:26:31.818] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:42:0)
[06:26:31.839] Build status: STARTED
[06:26:31.839] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:43:0) after 2m1s
[06:28:32.862] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:43:0)
[06:28:32.878] Build status: STARTED
[06:28:32.878] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:44:0) after 1m24s
[06:29:57.207] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:44:0)
[06:29:57.224] Build status: STARTED
[06:29:57.224] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913338369051487088:45:0) after 3m47s
[06:33:25.954] Received PubSub notification, asking Buildbucket for the build status
[06:33:25.970] Build:
{
"id": "8747908307018016305",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-15T02:52:27.528210714Z",
"startTime": "2024-05-15T02:53:35.643321058Z",
"endTime": "2024-05-15T06:33:24.187781193Z",
"updateTime": "2024-05-15T06:33:24.187781193Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6642cc60a21f857bddde8ec2c81008a83a54b4d3",
"ref": "refs/heads/main"
}
}
}
[06:33:25.970] Invocation finished in 3h40m59.765612716s with status SUCCEEDED