[10:14:13.197] New invocation is queued and will start shortly
[10:14:13.197] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[10:14:14.337] Starting the invocation (attempt 1)
[10:14:14.373] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/69d740e5d64257524914aabd6dfead7565185d4f"
[10:14:14.373] Reconstructed gitiles commit from tags
[10:14:14.373] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:14:14.373] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:14:14.373] Buildbucket request:
{
"requestId": "8914125947168786912",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "20696189af93aa34db0958ff53ac5c4c07757f99cd19c9077380da92df0bbe0b/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "b27ec1792919f6bb5be4814d95c29dddb7a78ca0",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8914125947168786912",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "c260aa84026d2eef68fccbe8ae47f3c38e9af3bf2767b50ead3a6475daa5e018/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "b27ec1792919f6bb5be4814d95c29dddb7a78ca0",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "0140ba031c9b6a4028b36adb292fb37eb62f3dc0"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/0140ba031c9b6a4028b36adb292fb37eb62f3dc0",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "b40e2a56-cd5c-4f5b-8265-0fecabe0d123",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "1047417550d3f377864cc3c0a0abbdfcf0cf9bf045aa412698304e87b7b189b4/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "b27ec1792919f6bb5be4814d95c29dddb7a78ca0",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "30367cb5982dfdab2655401f020711311e7d78b9"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/30367cb5982dfdab2655401f020711311e7d78b9",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "2238e421-5d5c-4a45-8725-bcd6803d5d5f",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "0160192db930d9f60c1f4532fe2ffc7e6ccef637e18a3108b9d5f2e57e5116fe/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "b27ec1792919f6bb5be4814d95c29dddb7a78ca0",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "d98a78590f4f9e43fdfb69fde7d154a985e4560f"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d98a78590f4f9e43fdfb69fde7d154a985e4560f",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "c9cfd60b-300b-47c8-860d-4e46fb2ee9ad",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "20696189af93aa34db0958ff53ac5c4c07757f99cd19c9077380da92df0bbe0b/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "b27ec1792919f6bb5be4814d95c29dddb7a78ca0",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "69d740e5d64257524914aabd6dfead7565185d4f"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/69d740e5d64257524914aabd6dfead7565185d4f",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "f846f2f6-4908-46f1-9c09-c0fae35f0f31",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "69d740e5d64257524914aabd6dfead7565185d4f"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "69d740e5d64257524914aabd6dfead7565185d4f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914125947168786912"
},
{
"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"
}
}
[10:14:14.788] Scheduled build:
{
"id": "8748695885216795185",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-06T10:14:14.427277385Z",
"updateTime": "2024-05-06T10:14:14.427277385Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "69d740e5d64257524914aabd6dfead7565185d4f",
"ref": "refs/heads/main"
}
}
}
[10:14:14.788] Task URL: https://cr-buildbucket.appspot.com/build/8748695885216795185
[10:14:14.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:2:0) after 1m53s
[10:14:15.801] Received PubSub notification, asking Buildbucket for the build status
[10:14:15.856] Build status: SCHEDULED
[10:14:22.301] Received PubSub notification, asking Buildbucket for the build status
[10:14:22.336] Build status: STARTED
[10:16:08.135] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:2:0)
[10:16:08.155] Build status: STARTED
[10:16:08.155] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:5:0) after 7m45s
[10:23:53.361] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:5:0)
[10:23:53.387] Build status: STARTED
[10:23:53.387] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:6:0) after 6m45s
[10:30:38.795] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:6:0)
[10:30:38.837] Build status: STARTED
[10:30:38.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:7:0) after 3m17s
[10:33:55.967] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:7:0)
[10:33:55.984] Build status: STARTED
[10:33:55.985] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:8:0) after 6m2s
[10:39:58.014] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:8:0)
[10:39:58.042] Build status: STARTED
[10:39:58.043] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:9:0) after 6m43s
[10:46:41.198] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:9:0)
[10:46:41.218] Build status: STARTED
[10:46:41.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:10:0) after 2m4s
[10:48:45.459] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:10:0)
[10:48:45.483] Build status: STARTED
[10:48:45.483] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:11:0) after 6m7s
[10:54:52.559] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:11:0)
[10:54:52.611] Build status: STARTED
[10:54:52.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:12:0) after 2m39s
[10:57:31.688] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:12:0)
[10:57:31.709] Build status: STARTED
[10:57:31.709] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:13:0) after 1m21s
[10:58:52.790] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:13:0)
[10:58:52.816] Build status: STARTED
[10:58:52.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:14:0) after 8m30s
[11:07:22.944] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:14:0)
[11:07:22.965] Build status: STARTED
[11:07:22.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:15:0) after 1m41s
[11:09:04.169] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:15:0)
[11:09:04.198] Build status: STARTED
[11:09:04.198] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:16:0) after 4m9s
[11:13:13.252] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:16:0)
[11:13:13.293] Build status: STARTED
[11:13:13.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:17:0) after 6m18s
[11:19:31.420] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:17:0)
[11:19:31.470] Build status: STARTED
[11:19:31.470] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:18:0) after 2m32s
[11:22:03.832] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:18:0)
[11:22:03.852] Build status: STARTED
[11:22:03.853] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:19:0) after 8m19s
[11:30:23.073] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:19:0)
[11:30:23.144] Build status: STARTED
[11:30:23.145] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:20:0) after 2m49s
[11:33:12.170] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:20:0)
[11:33:12.199] Build status: STARTED
[11:33:12.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:21:0) after 7m55s
[11:41:07.309] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:21:0)
[11:41:07.331] Build status: STARTED
[11:41:07.331] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:22:0) after 4m12s
[11:45:19.351] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:22:0)
[11:45:19.374] Build status: STARTED
[11:45:19.374] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:23:0) after 7m45s
[11:53:04.446] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:23:0)
[11:53:04.515] Build status: STARTED
[11:53:04.515] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:24:0) after 2m55s
[11:55:59.570] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:24:0)
[11:55:59.855] Build status: STARTED
[11:55:59.855] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:25:0) after 1m52s
[11:57:51.876] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:25:0)
[11:57:51.902] Build status: STARTED
[11:57:51.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:26:0) after 6m1s
[12:03:53.076] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:26:0)
[12:03:53.098] Build status: STARTED
[12:03:53.098] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:27:0) after 8m29s
[12:12:22.128] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:27:0)
[12:12:22.160] Build status: STARTED
[12:12:22.160] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:28:0) after 2m25s
[12:14:47.188] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:28:0)
[12:14:47.213] Build status: STARTED
[12:14:47.213] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:29:0) after 7m19s
[12:22:06.306] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:29:0)
[12:22:06.349] Build status: STARTED
[12:22:06.349] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:30:0) after 5m25s
[12:27:31.601] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:30:0)
[12:27:31.619] Build status: STARTED
[12:27:31.619] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:31:0) after 3m27s
[12:30:58.656] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:31:0)
[12:30:58.682] Build status: STARTED
[12:30:58.682] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:32:0) after 3m43s
[12:34:41.849] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:32:0)
[12:34:41.915] Build status: STARTED
[12:34:41.915] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:33:0) after 4m46s
[12:39:28.007] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:33:0)
[12:39:28.055] Build status: STARTED
[12:39:28.055] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:34:0) after 1m45s
[12:41:13.082] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:34:0)
[12:41:13.148] Build status: STARTED
[12:41:13.148] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914125947168786912:35:0) after 5m6s
[12:41:42.206] Received PubSub notification, asking Buildbucket for the build status
[12:41:42.225] Build:
{
"id": "8748695885216795185",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-06T10:14:14.427277385Z",
"startTime": "2024-05-06T10:14:22.055871163Z",
"endTime": "2024-05-06T12:41:41.772453767Z",
"updateTime": "2024-05-06T12:41:41.772453767Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "69d740e5d64257524914aabd6dfead7565185d4f",
"ref": "refs/heads/main"
}
}
}
[12:41:42.225] Invocation finished in 2h27m29.043104179s with status SUCCEEDED