[20:20:43.497] New invocation is queued and will start shortly
[20:20:43.497] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[20:20:44.620] Starting the invocation (attempt 1)
[20:20:44.648] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1c81b4a8f237db286aae5b8893aea09676a41d68"
[20:20:44.648] Reconstructed gitiles commit from tags
[20:20:44.648] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:20:44.649] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:20:44.649] Buildbucket request:
{
"requestId": "8920882561649544368",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "9dde1a9f76b418a37d391a060e78409a6d36ea1b82b00f9bb26c46ac12558816/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "03025689f22bcd9d9fcf0373eb46a5647bcbd929",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8920882561649544368",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "63bd998c0fa99181d9fd82e2f109930da5ef3fcf7958029f9e76a3812e420fe7/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "03025689f22bcd9d9fcf0373eb46a5647bcbd929",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "cc13f3ba45015254075434f0f94a2ea6ff4bc1b4"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/cc13f3ba45015254075434f0f94a2ea6ff4bc1b4",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "4bd24998-0fec-481e-8c17-cc114a2776d3",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "ee24156a701ccfb6408de291c503d0c6253d20b374aad119eadabc8751aa8e66/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "03025689f22bcd9d9fcf0373eb46a5647bcbd929",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "579ae446375b2bec6d329b612adfa0a74f7126e3"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/579ae446375b2bec6d329b612adfa0a74f7126e3",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "979a3877-17f5-442d-8711-1cac67facced",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "e7873ab6e6f3876de82b84132bdb94f25a01c53b546df312c8460d8eaa647304/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "03025689f22bcd9d9fcf0373eb46a5647bcbd929",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "966b026785a09ec079e8b0ba79358892fcb958ad"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/966b026785a09ec079e8b0ba79358892fcb958ad",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "509ed12e-34f9-4d07-a815-b995581e83fe",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "9dde1a9f76b418a37d391a060e78409a6d36ea1b82b00f9bb26c46ac12558816/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "03025689f22bcd9d9fcf0373eb46a5647bcbd929",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "1c81b4a8f237db286aae5b8893aea09676a41d68"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1c81b4a8f237db286aae5b8893aea09676a41d68",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "d7fcfeab-bce6-43ae-b7e9-3fd25f5d06ea",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "1c81b4a8f237db286aae5b8893aea09676a41d68"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1c81b4a8f237db286aae5b8893aea09676a41d68",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8920882561649544368"
},
{
"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"
}
}
[20:20:45.335] Scheduled build:
{
"id": "8755452499545923601",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-21T20:20:44.876293486Z",
"updateTime": "2024-02-21T20:20:44.876293486Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1c81b4a8f237db286aae5b8893aea09676a41d68",
"ref": "refs/heads/main"
}
}
}
[20:20:45.335] Task URL: https://cr-buildbucket.appspot.com/build/8755452499545923601
[20:20:45.335] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:2:0) after 2m12s
[20:20:46.262] Received PubSub notification, asking Buildbucket for the build status
[20:20:46.282] Build status: SCHEDULED
[20:20:46.980] Received PubSub notification, asking Buildbucket for the build status
[20:20:46.998] Build status: STARTED
[20:22:57.360] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:2:0)
[20:22:57.384] Build status: STARTED
[20:22:57.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:5:0) after 9m45s
[20:32:42.456] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:5:0)
[20:32:42.489] Build status: STARTED
[20:32:42.489] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:6:0) after 3m4s
[20:35:46.612] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:6:0)
[20:35:46.646] Build status: STARTED
[20:35:46.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:7:0) after 3m22s
[20:39:08.713] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:7:0)
[20:39:08.733] Build status: STARTED
[20:39:08.733] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:8:0) after 1m25s
[20:40:33.758] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:8:0)
[20:40:33.797] Build status: STARTED
[20:40:33.797] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:9:0) after 1m18s
[20:41:51.817] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:9:0)
[20:41:51.856] Build status: STARTED
[20:41:51.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:10:0) after 4m22s
[20:46:13.877] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:10:0)
[20:46:13.945] Build status: STARTED
[20:46:13.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:11:0) after 9m26s
[20:55:40.010] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:11:0)
[20:55:40.056] Build status: STARTED
[20:55:40.056] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:12:0) after 3m44s
[20:59:24.126] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:12:0)
[20:59:24.187] Build status: STARTED
[20:59:24.187] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:13:0) after 1m32s
[21:00:56.232] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:13:0)
[21:00:56.267] Build status: STARTED
[21:00:56.267] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:14:0) after 9m43s
[21:10:39.335] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:14:0)
[21:10:39.363] Build status: STARTED
[21:10:39.363] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:15:0) after 6m3s
[21:16:42.419] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:15:0)
[21:16:42.578] Build status: STARTED
[21:16:42.579] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:16:0) after 5m15s
[21:21:57.637] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:16:0)
[21:21:57.658] Build status: STARTED
[21:21:57.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:17:0) after 2m28s
[21:24:25.683] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:17:0)
[21:24:25.702] Build status: STARTED
[21:24:25.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:18:0) after 4m41s
[21:29:06.729] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:18:0)
[21:29:06.755] Build status: STARTED
[21:29:06.755] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:19:0) after 7m38s
[21:36:44.803] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:19:0)
[21:36:44.840] Build status: STARTED
[21:36:44.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:20:0) after 5m3s
[21:41:47.923] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:20:0)
[21:41:47.945] Build status: STARTED
[21:41:47.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:21:0) after 4m6s
[21:45:54.032] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:21:0)
[21:45:54.086] Build status: STARTED
[21:45:54.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:22:0) after 5m28s
[21:51:22.160] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:22:0)
[21:51:22.191] Build status: STARTED
[21:51:22.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:23:0) after 3m36s
[21:54:58.223] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:23:0)
[21:54:58.247] Build status: STARTED
[21:54:58.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:24:0) after 9m20s
[22:04:18.244] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:24:0)
[22:04:18.295] Build status: STARTED
[22:04:18.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:25:0) after 9m13s
[22:13:31.338] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:25:0)
[22:13:31.356] Build status: STARTED
[22:13:31.356] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:26:0) after 8m41s
[22:22:12.381] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:26:0)
[22:22:12.468] Build status: STARTED
[22:22:12.468] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920882561649544368:27:0) after 8m35s
[22:26:54.816] Received PubSub notification, asking Buildbucket for the build status
[22:26:54.834] Build:
{
"id": "8755452499545923601",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-21T20:20:44.876293486Z",
"startTime": "2024-02-21T20:20:46.035298Z",
"endTime": "2024-02-21T22:26:54.050218Z",
"updateTime": "2024-02-21T22:26:54.050218Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1c81b4a8f237db286aae5b8893aea09676a41d68",
"ref": "refs/heads/main"
}
}
}
[22:26:54.834] Invocation finished in 2h6m11.348707105s with status SUCCEEDED