[00:33:35.154] New invocation is queued and will start shortly
[00:33:36.239] Starting the invocation (attempt 1)
[00:33:36.262] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d7398a355461b3a9f1685b0d2bf42c157b159e8f"
[00:33:36.262] Popped gitiles commit info from properties and tags
[00:33:36.262] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:33:36.262] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:33:36.263] Buildbucket request:
{
"requestId": "8938623658427307520",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8938623658427307520",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9ef6cffbb019e06b40d89b9d413cc29e788a9365"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9ef6cffbb019e06b40d89b9d413cc29e788a9365",
"title": "9ef6cffbb019e06b40d89b9d413cc29e788a9365",
"url": "https://llvm.googlesource.com/llvm-project/+/9ef6cffbb019e06b40d89b9d413cc29e788a9365"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f88de010ba68b5e30292f6fab6759579a8441df3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f88de010ba68b5e30292f6fab6759579a8441df3",
"title": "f88de010ba68b5e30292f6fab6759579a8441df3",
"url": "https://llvm.googlesource.com/llvm-project/+/f88de010ba68b5e30292f6fab6759579a8441df3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "be7b385f3649ab885b61a37b171599827e1d4995"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@be7b385f3649ab885b61a37b171599827e1d4995",
"title": "be7b385f3649ab885b61a37b171599827e1d4995",
"url": "https://llvm.googlesource.com/llvm-project/+/be7b385f3649ab885b61a37b171599827e1d4995"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6dbd458128dd24d35c0fe9121bde62f0c4da92f8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6dbd458128dd24d35c0fe9121bde62f0c4da92f8",
"title": "6dbd458128dd24d35c0fe9121bde62f0c4da92f8",
"url": "https://llvm.googlesource.com/llvm-project/+/6dbd458128dd24d35c0fe9121bde62f0c4da92f8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ec129c28af58d8200538184cab0ec659c437095d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ec129c28af58d8200538184cab0ec659c437095d",
"title": "ec129c28af58d8200538184cab0ec659c437095d",
"url": "https://llvm.googlesource.com/llvm-project/+/ec129c28af58d8200538184cab0ec659c437095d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8d60e10ce4bd428577ef441eb77b260ec3c14088"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8d60e10ce4bd428577ef441eb77b260ec3c14088",
"title": "8d60e10ce4bd428577ef441eb77b260ec3c14088",
"url": "https://llvm.googlesource.com/llvm-project/+/8d60e10ce4bd428577ef441eb77b260ec3c14088"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "20c77a5789331956cd47d1804df7885a82094964"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@20c77a5789331956cd47d1804df7885a82094964",
"title": "20c77a5789331956cd47d1804df7885a82094964",
"url": "https://llvm.googlesource.com/llvm-project/+/20c77a5789331956cd47d1804df7885a82094964"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f2d32ddcec82c20582c6aa32558b82ca7c3d3c50"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f2d32ddcec82c20582c6aa32558b82ca7c3d3c50",
"title": "f2d32ddcec82c20582c6aa32558b82ca7c3d3c50",
"url": "https://llvm.googlesource.com/llvm-project/+/f2d32ddcec82c20582c6aa32558b82ca7c3d3c50"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a0a610fc7f538f6af0eaa16f5bce26ad22122efc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a0a610fc7f538f6af0eaa16f5bce26ad22122efc",
"title": "a0a610fc7f538f6af0eaa16f5bce26ad22122efc",
"url": "https://llvm.googlesource.com/llvm-project/+/a0a610fc7f538f6af0eaa16f5bce26ad22122efc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f9ebcb4814d0c7b23d0c503069bd058a09edea96"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f9ebcb4814d0c7b23d0c503069bd058a09edea96",
"title": "f9ebcb4814d0c7b23d0c503069bd058a09edea96",
"url": "https://llvm.googlesource.com/llvm-project/+/f9ebcb4814d0c7b23d0c503069bd058a09edea96"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2b5b2bfef102b1021d91f2b9485e2443bdea9df5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2b5b2bfef102b1021d91f2b9485e2443bdea9df5",
"title": "2b5b2bfef102b1021d91f2b9485e2443bdea9df5",
"url": "https://llvm.googlesource.com/llvm-project/+/2b5b2bfef102b1021d91f2b9485e2443bdea9df5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d7398a355461b3a9f1685b0d2bf42c157b159e8f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d7398a355461b3a9f1685b0d2bf42c157b159e8f",
"title": "d7398a355461b3a9f1685b0d2bf42c157b159e8f",
"url": "https://llvm.googlesource.com/llvm-project/+/d7398a355461b3a9f1685b0d2bf42c157b159e8f"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d7398a355461b3a9f1685b0d2bf42c157b159e8f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8938623658427307520"
},
{
"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"
}
}
[00:33:36.707] Scheduled build:
{
"id": "8773193596548200881",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-10T00:33:36.320117581Z",
"updateTime": "2023-08-10T00:33:36.320117581Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d7398a355461b3a9f1685b0d2bf42c157b159e8f",
"ref": "refs/heads/main"
}
}
}
[00:33:36.707] Task URL: https://cr-buildbucket.appspot.com/build/8773193596548200881
[00:33:36.707] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:2:0) after 9m15s
[00:33:37.624] Received PubSub notification, asking Buildbucket for the build status
[00:33:37.645] Build status: SCHEDULED
[00:42:52.126] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:2:0)
[00:42:52.155] Build status: SCHEDULED
[00:42:52.155] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:4:0) after 5m45s
[00:47:07.859] Received PubSub notification, asking Buildbucket for the build status
[00:47:07.919] Build status: STARTED
[00:48:37.178] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:4:0)
[00:48:37.197] Build status: STARTED
[00:48:37.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:6:0) after 5m21s
[00:53:58.314] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:6:0)
[00:53:58.344] Build status: STARTED
[00:53:58.344] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:7:0) after 3m7s
[00:57:05.371] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:7:0)
[00:57:05.479] Build status: STARTED
[00:57:05.479] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:8:0) after 2m26s
[00:59:32.222] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:8:0)
[00:59:32.257] Build status: STARTED
[00:59:32.257] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:9:0) after 4m9s
[01:03:41.324] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:9:0)
[01:03:41.375] Build status: STARTED
[01:03:41.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:10:0) after 8m43s
[01:12:24.410] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:10:0)
[01:12:24.430] Build status: STARTED
[01:12:24.430] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:11:0) after 1m34s
[01:13:58.843] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:11:0)
[01:13:58.875] Build status: STARTED
[01:13:58.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:12:0) after 7m34s
[01:21:32.943] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:12:0)
[01:21:32.992] Build status: STARTED
[01:21:32.992] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:13:0) after 1m13s
[01:22:46.079] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:13:0)
[01:22:46.104] Build status: STARTED
[01:22:46.104] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:14:0) after 3m58s
[01:26:44.311] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:14:0)
[01:26:44.350] Build status: STARTED
[01:26:44.350] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:15:0) after 2m52s
[01:29:36.538] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:15:0)
[01:29:36.562] Build status: STARTED
[01:29:36.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:16:0) after 2m35s
[01:32:11.580] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:16:0)
[01:32:11.603] Build status: STARTED
[01:32:11.603] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:17:0) after 3m1s
[01:35:12.641] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:17:0)
[01:35:12.660] Build status: STARTED
[01:35:12.660] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:18:0) after 2m32s
[01:37:44.783] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:18:0)
[01:37:44.798] Build status: STARTED
[01:37:44.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:19:0) after 6m17s
[01:44:01.877] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:19:0)
[01:44:01.898] Build status: STARTED
[01:44:01.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:20:0) after 3m25s
[01:47:27.277] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:20:0)
[01:47:27.319] Build status: STARTED
[01:47:27.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938623658427307520:21:0) after 4m56s
[01:49:39.665] Received PubSub notification, asking Buildbucket for the build status
[01:49:39.689] Build:
{
"id": "8773193596548200881",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-10T00:33:36.320117581Z",
"startTime": "2023-08-10T00:47:07.325342Z",
"endTime": "2023-08-10T01:49:39.386656354Z",
"updateTime": "2023-08-10T01:49:39.386656354Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d7398a355461b3a9f1685b0d2bf42c157b159e8f",
"ref": "refs/heads/main"
}
}
}
[01:49:39.689] Invocation finished in 1h16m4.545022843s with status SUCCEEDED