[12:28:56.495] New invocation is queued and will start shortly
[12:28:57.937] Starting the invocation (attempt 1)
[12:28:57.966] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b358f218a114c1495cfb356b1b95c866c32f72c4"
[12:28:57.966] Popped gitiles commit info from properties and tags
[12:28:57.966] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:28:57.966] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:28:57.967] Buildbucket request:
{
"requestId": "8897357032425168336",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8897357032425168336",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1361c19c04d0b3d9156fe0c5393d158cf69c14e7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1361c19c04d0b3d9156fe0c5393d158cf69c14e7",
"title": "1361c19c04d0b3d9156fe0c5393d158cf69c14e7",
"url": "https://llvm.googlesource.com/llvm-project/+/1361c19c04d0b3d9156fe0c5393d158cf69c14e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dd98ae358b187be32a2e255eba5f91568524b86a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dd98ae358b187be32a2e255eba5f91568524b86a",
"title": "dd98ae358b187be32a2e255eba5f91568524b86a",
"url": "https://llvm.googlesource.com/llvm-project/+/dd98ae358b187be32a2e255eba5f91568524b86a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9f02950a1589ebfc542f4f5a2475c2cc03e4e2e9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9f02950a1589ebfc542f4f5a2475c2cc03e4e2e9",
"title": "9f02950a1589ebfc542f4f5a2475c2cc03e4e2e9",
"url": "https://llvm.googlesource.com/llvm-project/+/9f02950a1589ebfc542f4f5a2475c2cc03e4e2e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4fa1e8f970235918da8e7c467cdcd227c2f87536"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4fa1e8f970235918da8e7c467cdcd227c2f87536",
"title": "4fa1e8f970235918da8e7c467cdcd227c2f87536",
"url": "https://llvm.googlesource.com/llvm-project/+/4fa1e8f970235918da8e7c467cdcd227c2f87536"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f43ef53dd20b83ea0db6fdba69025c9a76a1de08"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f43ef53dd20b83ea0db6fdba69025c9a76a1de08",
"title": "f43ef53dd20b83ea0db6fdba69025c9a76a1de08",
"url": "https://llvm.googlesource.com/llvm-project/+/f43ef53dd20b83ea0db6fdba69025c9a76a1de08"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d87dbcbf137ab1c6b6c2db1fd3fe7d91a3142fa1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d87dbcbf137ab1c6b6c2db1fd3fe7d91a3142fa1",
"title": "d87dbcbf137ab1c6b6c2db1fd3fe7d91a3142fa1",
"url": "https://llvm.googlesource.com/llvm-project/+/d87dbcbf137ab1c6b6c2db1fd3fe7d91a3142fa1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "abe0cd4621ccee26196ceb7506e908d4134f630e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@abe0cd4621ccee26196ceb7506e908d4134f630e",
"title": "abe0cd4621ccee26196ceb7506e908d4134f630e",
"url": "https://llvm.googlesource.com/llvm-project/+/abe0cd4621ccee26196ceb7506e908d4134f630e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fef6613e9fc05bca8e315c65e8f8da796860a3cf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fef6613e9fc05bca8e315c65e8f8da796860a3cf",
"title": "fef6613e9fc05bca8e315c65e8f8da796860a3cf",
"url": "https://llvm.googlesource.com/llvm-project/+/fef6613e9fc05bca8e315c65e8f8da796860a3cf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dafbc97594c26da67e34ba0301a6126419ae4604"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dafbc97594c26da67e34ba0301a6126419ae4604",
"title": "dafbc97594c26da67e34ba0301a6126419ae4604",
"url": "https://llvm.googlesource.com/llvm-project/+/dafbc97594c26da67e34ba0301a6126419ae4604"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9470945b6695cf526df9249c3787d225f95eaf03"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9470945b6695cf526df9249c3787d225f95eaf03",
"title": "9470945b6695cf526df9249c3787d225f95eaf03",
"url": "https://llvm.googlesource.com/llvm-project/+/9470945b6695cf526df9249c3787d225f95eaf03"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3d0b283dcd6d9fbe41618fd476c14bc00b62b3e5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3d0b283dcd6d9fbe41618fd476c14bc00b62b3e5",
"title": "3d0b283dcd6d9fbe41618fd476c14bc00b62b3e5",
"url": "https://llvm.googlesource.com/llvm-project/+/3d0b283dcd6d9fbe41618fd476c14bc00b62b3e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "16cd5cdf4d6387e34d2bb723bc26c331c8d89d75"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@16cd5cdf4d6387e34d2bb723bc26c331c8d89d75",
"title": "16cd5cdf4d6387e34d2bb723bc26c331c8d89d75",
"url": "https://llvm.googlesource.com/llvm-project/+/16cd5cdf4d6387e34d2bb723bc26c331c8d89d75"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e40a31b7baef8c39b9e03ebf94ddfefdba52601e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e40a31b7baef8c39b9e03ebf94ddfefdba52601e",
"title": "e40a31b7baef8c39b9e03ebf94ddfefdba52601e",
"url": "https://llvm.googlesource.com/llvm-project/+/e40a31b7baef8c39b9e03ebf94ddfefdba52601e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b358f218a114c1495cfb356b1b95c866c32f72c4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b358f218a114c1495cfb356b1b95c866c32f72c4",
"title": "b358f218a114c1495cfb356b1b95c866c32f72c4",
"url": "https://llvm.googlesource.com/llvm-project/+/b358f218a114c1495cfb356b1b95c866c32f72c4"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b358f218a114c1495cfb356b1b95c866c32f72c4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8897357032425168336"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:28:58.398] Scheduled build:
{
"id": "8731926970130089553",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-07T12:28:58.059094704Z",
"updateTime": "2024-11-07T12:28:58.059094704Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b358f218a114c1495cfb356b1b95c866c32f72c4",
"ref": "refs/heads/main"
}
},
"canary": true
}
[12:28:58.398] Task URL: https://cr-buildbucket.appspot.com/build/8731926970130089553
[12:28:58.398] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:2:0) after 9m54s
[12:28:59.380] Received PubSub notification, asking Buildbucket for the build status
[12:28:59.433] Build status: SCHEDULED
[12:29:02.309] Received PubSub notification, asking Buildbucket for the build status
[12:29:02.326] Build status: STARTED
[12:38:52.423] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:2:0)
[12:38:52.497] Build status: STARTED
[12:38:52.497] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:5:0) after 4m48s
[12:43:40.514] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:5:0)
[12:43:40.537] Build status: STARTED
[12:43:40.537] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:6:0) after 3m5s
[12:46:45.603] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:6:0)
[12:46:45.625] Build status: STARTED
[12:46:45.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:7:0) after 9m5s
[12:55:50.733] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:7:0)
[12:55:50.760] Build status: STARTED
[12:55:50.760] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:8:0) after 1m57s
[12:57:47.800] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:8:0)
[12:57:47.816] Build status: STARTED
[12:57:47.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:9:0) after 4m59s
[13:02:47.234] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:9:0)
[13:02:47.255] Build status: STARTED
[13:02:47.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:10:0) after 3m1s
[13:05:48.331] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:10:0)
[13:05:48.348] Build status: STARTED
[13:05:48.349] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:11:0) after 1m50s
[13:07:38.383] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:11:0)
[13:07:38.403] Build status: STARTED
[13:07:38.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:12:0) after 6m8s
[13:13:46.601] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:12:0)
[13:13:46.621] Build status: STARTED
[13:13:46.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:13:0) after 5m50s
[13:19:36.712] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:13:0)
[13:19:36.728] Build status: STARTED
[13:19:36.728] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:14:0) after 2m31s
[13:22:08.030] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:14:0)
[13:22:08.062] Build status: STARTED
[13:22:08.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:15:0) after 1m23s
[13:23:31.694] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:15:0)
[13:23:31.716] Build status: STARTED
[13:23:31.716] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:16:0) after 6m26s
[13:29:58.182] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:16:0)
[13:29:58.210] Build status: STARTED
[13:29:58.210] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:17:0) after 2m5s
[13:32:03.423] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:17:0)
[13:32:03.447] Build status: STARTED
[13:32:03.447] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:18:0) after 7m59s
[13:40:02.660] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:18:0)
[13:40:02.683] Build status: STARTED
[13:40:02.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:19:0) after 9m26s
[13:49:28.705] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:19:0)
[13:49:28.731] Build status: STARTED
[13:49:28.731] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:20:0) after 7m13s
[13:56:41.752] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:20:0)
[13:56:41.781] Build status: STARTED
[13:56:41.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8897357032425168336:21:0) after 9m22s
[13:58:30.201] Received PubSub notification, asking Buildbucket for the build status
[13:58:30.225] Build:
{
"id": "8731926970130089553",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-07T12:28:58.059094704Z",
"startTime": "2024-11-07T12:29:02.034776406Z",
"endTime": "2024-11-07T13:58:29.836098650Z",
"updateTime": "2024-11-07T13:58:29.836098650Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b358f218a114c1495cfb356b1b95c866c32f72c4",
"ref": "refs/heads/main"
}
},
"canary": true
}
[13:58:30.225] Invocation finished in 1h29m33.737539804s with status SUCCEEDED