[21:32:21.010] New invocation is queued and will start shortly
[21:32:22.080] Starting the invocation (attempt 1)
[21:32:22.106] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ecbbe5b431892820b442aa36e06ab66ae94d52e9"
[21:32:22.106] Popped gitiles commit info from properties and tags
[21:32:22.106] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:32:22.107] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:32:22.108] Buildbucket request:
{
"requestId": "8905204780188522400",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8905204780188522400",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8ea8f1f2fe501e0be5d0142d79651f490fb2ae2c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8ea8f1f2fe501e0be5d0142d79651f490fb2ae2c",
"title": "8ea8f1f2fe501e0be5d0142d79651f490fb2ae2c",
"url": "https://llvm.googlesource.com/llvm-project/+/8ea8f1f2fe501e0be5d0142d79651f490fb2ae2c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "123b6fcc70af17d81c903b839ffb55afc9a9728f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@123b6fcc70af17d81c903b839ffb55afc9a9728f",
"title": "123b6fcc70af17d81c903b839ffb55afc9a9728f",
"url": "https://llvm.googlesource.com/llvm-project/+/123b6fcc70af17d81c903b839ffb55afc9a9728f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a2acea5c380534430a01843698d4bf46b018110f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a2acea5c380534430a01843698d4bf46b018110f",
"title": "a2acea5c380534430a01843698d4bf46b018110f",
"url": "https://llvm.googlesource.com/llvm-project/+/a2acea5c380534430a01843698d4bf46b018110f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "93f754c10099d08df34ff6b9562d545e300d55ab"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@93f754c10099d08df34ff6b9562d545e300d55ab",
"title": "93f754c10099d08df34ff6b9562d545e300d55ab",
"url": "https://llvm.googlesource.com/llvm-project/+/93f754c10099d08df34ff6b9562d545e300d55ab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "91c3a718b28c92c95343e7073fbddc39a181a801"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@91c3a718b28c92c95343e7073fbddc39a181a801",
"title": "91c3a718b28c92c95343e7073fbddc39a181a801",
"url": "https://llvm.googlesource.com/llvm-project/+/91c3a718b28c92c95343e7073fbddc39a181a801"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "652707a6457eeb3927a1fe82e6b2cbc2a1fa22f5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@652707a6457eeb3927a1fe82e6b2cbc2a1fa22f5",
"title": "652707a6457eeb3927a1fe82e6b2cbc2a1fa22f5",
"url": "https://llvm.googlesource.com/llvm-project/+/652707a6457eeb3927a1fe82e6b2cbc2a1fa22f5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "05901e980590f721cdc9fbcf1f99353942d0d5d8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@05901e980590f721cdc9fbcf1f99353942d0d5d8",
"title": "05901e980590f721cdc9fbcf1f99353942d0d5d8",
"url": "https://llvm.googlesource.com/llvm-project/+/05901e980590f721cdc9fbcf1f99353942d0d5d8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "825dbbbb94c985da4fd18da3e6e3baac05b11e23"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@825dbbbb94c985da4fd18da3e6e3baac05b11e23",
"title": "825dbbbb94c985da4fd18da3e6e3baac05b11e23",
"url": "https://llvm.googlesource.com/llvm-project/+/825dbbbb94c985da4fd18da3e6e3baac05b11e23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6b7afaa9db8f904ebf0262774e38e54b36598782"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6b7afaa9db8f904ebf0262774e38e54b36598782",
"title": "6b7afaa9db8f904ebf0262774e38e54b36598782",
"url": "https://llvm.googlesource.com/llvm-project/+/6b7afaa9db8f904ebf0262774e38e54b36598782"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b368404dee8c341dc022a9e9a868f5a268e92033"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b368404dee8c341dc022a9e9a868f5a268e92033",
"title": "b368404dee8c341dc022a9e9a868f5a268e92033",
"url": "https://llvm.googlesource.com/llvm-project/+/b368404dee8c341dc022a9e9a868f5a268e92033"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ecbbe5b431892820b442aa36e06ab66ae94d52e9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ecbbe5b431892820b442aa36e06ab66ae94d52e9",
"title": "ecbbe5b431892820b442aa36e06ab66ae94d52e9",
"url": "https://llvm.googlesource.com/llvm-project/+/ecbbe5b431892820b442aa36e06ab66ae94d52e9"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ecbbe5b431892820b442aa36e06ab66ae94d52e9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8905204780188522400"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:32:22.528] Scheduled build:
{
"id": "8739774718310256721",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-12T21:32:22.178077890Z",
"updateTime": "2024-08-12T21:32:22.178077890Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ecbbe5b431892820b442aa36e06ab66ae94d52e9",
"ref": "refs/heads/main"
}
}
}
[21:32:22.528] Task URL: https://cr-buildbucket.appspot.com/build/8739774718310256721
[21:32:22.528] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:2:0) after 7m4s
[21:32:23.514] Received PubSub notification, asking Buildbucket for the build status
[21:32:23.548] Build status: SCHEDULED
[21:32:26.786] Received PubSub notification, asking Buildbucket for the build status
[21:32:26.848] Build status: STARTED
[21:39:26.557] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:2:0)
[21:39:26.577] Build status: STARTED
[21:39:26.577] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:5:0) after 9m30s
[21:48:56.596] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:5:0)
[21:48:56.621] Build status: STARTED
[21:48:56.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:6:0) after 9m39s
[21:58:35.606] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:6:0)
[21:58:35.625] Build status: STARTED
[21:58:35.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:7:0) after 1m41s
[22:00:16.644] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:7:0)
[22:00:16.661] Build status: STARTED
[22:00:16.663] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:8:0) after 9m28s
[22:09:44.679] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:8:0)
[22:09:44.696] Build status: STARTED
[22:09:44.696] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:9:0) after 8m10s
[22:17:54.737] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:9:0)
[22:17:54.759] Build status: STARTED
[22:17:54.759] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:10:0) after 2m28s
[22:20:22.802] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:10:0)
[22:20:22.818] Build status: STARTED
[22:20:22.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:11:0) after 8m27s
[22:28:49.934] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:11:0)
[22:28:49.950] Build status: STARTED
[22:28:49.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:12:0) after 4m5s
[22:32:54.981] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:12:0)
[22:32:55.003] Build status: STARTED
[22:32:55.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:13:0) after 1m15s
[22:34:10.030] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:13:0)
[22:34:10.051] Build status: STARTED
[22:34:10.051] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:14:0) after 2m3s
[22:36:13.068] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:14:0)
[22:36:13.216] Build status: STARTED
[22:36:13.216] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:15:0) after 6m30s
[22:42:43.249] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:15:0)
[22:42:43.273] Build status: STARTED
[22:42:43.273] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:16:0) after 8m55s
[22:51:38.441] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:16:0)
[22:51:38.459] Build status: STARTED
[22:51:38.459] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:17:0) after 2m14s
[22:53:52.477] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:17:0)
[22:53:52.496] Build status: STARTED
[22:53:52.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:18:0) after 4m6s
[22:57:58.527] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:18:0)
[22:57:58.546] Build status: STARTED
[22:57:58.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8905204780188522400:19:0) after 1m10s
[22:58:50.339] Received PubSub notification, asking Buildbucket for the build status
[22:58:50.359] Build:
{
"id": "8739774718310256721",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-12T21:32:22.178077890Z",
"startTime": "2024-08-12T21:32:26.454585125Z",
"endTime": "2024-08-12T22:58:49.869004398Z",
"updateTime": "2024-08-12T22:58:49.869004398Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ecbbe5b431892820b442aa36e06ab66ae94d52e9",
"ref": "refs/heads/main"
}
}
}
[22:58:50.359] Invocation finished in 1h26m29.354787261s with status SUCCEEDED