[23:18:22.881] New invocation is queued and will start shortly
[23:18:24.218] Starting the invocation (attempt 1)
[23:18:24.253] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b89bb7775d155fc787ab3170f3fa38449069ecb3"
[23:18:24.253] Popped gitiles commit info from properties and tags
[23:18:24.253] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:18:24.253] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:18:24.254] Buildbucket request:
{
"requestId": "8901936618493445392",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8901936618493445392",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0ea40bf02138c02e7680ce6fa8169502f2a8bd42"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0ea40bf02138c02e7680ce6fa8169502f2a8bd42",
"title": "0ea40bf02138c02e7680ce6fa8169502f2a8bd42",
"url": "https://llvm.googlesource.com/llvm-project/+/0ea40bf02138c02e7680ce6fa8169502f2a8bd42"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "905de9b0fe06d960e7f60175e6c96b955f334a66"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@905de9b0fe06d960e7f60175e6c96b955f334a66",
"title": "905de9b0fe06d960e7f60175e6c96b955f334a66",
"url": "https://llvm.googlesource.com/llvm-project/+/905de9b0fe06d960e7f60175e6c96b955f334a66"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "38333f4161037d2587157e36b5cb994d1b2c36e5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@38333f4161037d2587157e36b5cb994d1b2c36e5",
"title": "38333f4161037d2587157e36b5cb994d1b2c36e5",
"url": "https://llvm.googlesource.com/llvm-project/+/38333f4161037d2587157e36b5cb994d1b2c36e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "08bba6503b918c97d9d1a0cde97f4b3c64d5f2c3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@08bba6503b918c97d9d1a0cde97f4b3c64d5f2c3",
"title": "08bba6503b918c97d9d1a0cde97f4b3c64d5f2c3",
"url": "https://llvm.googlesource.com/llvm-project/+/08bba6503b918c97d9d1a0cde97f4b3c64d5f2c3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "04575dce434de38e0b28a2b71dd44e29caaee685"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@04575dce434de38e0b28a2b71dd44e29caaee685",
"title": "04575dce434de38e0b28a2b71dd44e29caaee685",
"url": "https://llvm.googlesource.com/llvm-project/+/04575dce434de38e0b28a2b71dd44e29caaee685"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9c9a627190b67a435a9735ee1aead20cbb708f2b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9c9a627190b67a435a9735ee1aead20cbb708f2b",
"title": "9c9a627190b67a435a9735ee1aead20cbb708f2b",
"url": "https://llvm.googlesource.com/llvm-project/+/9c9a627190b67a435a9735ee1aead20cbb708f2b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b84663854859903c7b457b084d255a77405bd7a2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b84663854859903c7b457b084d255a77405bd7a2",
"title": "b84663854859903c7b457b084d255a77405bd7a2",
"url": "https://llvm.googlesource.com/llvm-project/+/b84663854859903c7b457b084d255a77405bd7a2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "790f2eb16a279f4cb4b57397fcafd5cadb49d6b7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@790f2eb16a279f4cb4b57397fcafd5cadb49d6b7",
"title": "790f2eb16a279f4cb4b57397fcafd5cadb49d6b7",
"url": "https://llvm.googlesource.com/llvm-project/+/790f2eb16a279f4cb4b57397fcafd5cadb49d6b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3aecf41c2b384ab65a327db91632ff0c148df721"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3aecf41c2b384ab65a327db91632ff0c148df721",
"title": "3aecf41c2b384ab65a327db91632ff0c148df721",
"url": "https://llvm.googlesource.com/llvm-project/+/3aecf41c2b384ab65a327db91632ff0c148df721"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aa2e6b87341de18a88688c1ac345754d4553bb3d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aa2e6b87341de18a88688c1ac345754d4553bb3d",
"title": "aa2e6b87341de18a88688c1ac345754d4553bb3d",
"url": "https://llvm.googlesource.com/llvm-project/+/aa2e6b87341de18a88688c1ac345754d4553bb3d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "da03d17698f205fe8ebc54c32994c8ce2c51a81e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@da03d17698f205fe8ebc54c32994c8ce2c51a81e",
"title": "da03d17698f205fe8ebc54c32994c8ce2c51a81e",
"url": "https://llvm.googlesource.com/llvm-project/+/da03d17698f205fe8ebc54c32994c8ce2c51a81e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4a0bf8377e1038d6cf9454c7c6740bd759729938"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4a0bf8377e1038d6cf9454c7c6740bd759729938",
"title": "4a0bf8377e1038d6cf9454c7c6740bd759729938",
"url": "https://llvm.googlesource.com/llvm-project/+/4a0bf8377e1038d6cf9454c7c6740bd759729938"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b89bb7775d155fc787ab3170f3fa38449069ecb3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b89bb7775d155fc787ab3170f3fa38449069ecb3",
"title": "b89bb7775d155fc787ab3170f3fa38449069ecb3",
"url": "https://llvm.googlesource.com/llvm-project/+/b89bb7775d155fc787ab3170f3fa38449069ecb3"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b89bb7775d155fc787ab3170f3fa38449069ecb3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901936618493445392"
},
{
"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"
}
}
[23:18:24.667] Scheduled build:
{
"id": "8736506556336744785",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-17T23:18:24.314625607Z",
"updateTime": "2024-09-17T23:18:24.314625607Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b89bb7775d155fc787ab3170f3fa38449069ecb3",
"ref": "refs/heads/main"
}
}
}
[23:18:24.667] Task URL: https://cr-buildbucket.appspot.com/build/8736506556336744785
[23:18:24.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:2:0) after 7m56s
[23:18:25.625] Received PubSub notification, asking Buildbucket for the build status
[23:18:25.643] Build status: SCHEDULED
[23:18:35.135] Received PubSub notification, asking Buildbucket for the build status
[23:18:35.238] Build status: STARTED
[23:26:20.678] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:2:0)
[23:26:20.711] Build status: STARTED
[23:26:20.711] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:5:0) after 9m42s
[23:36:02.834] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:5:0)
[23:36:02.854] Build status: STARTED
[23:36:02.854] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:6:0) after 2m0s
[23:38:02.871] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:6:0)
[23:38:02.902] Build status: STARTED
[23:38:02.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:7:0) after 1m37s
[23:39:39.972] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:7:0)
[23:39:39.999] Build status: STARTED
[23:39:39.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:8:0) after 3m43s
[23:43:23.032] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:8:0)
[23:43:23.195] Build status: STARTED
[23:43:23.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:9:0) after 5m40s
[23:49:03.218] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:9:0)
[23:49:03.247] Build status: STARTED
[23:49:03.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:10:0) after 2m47s
[23:51:50.283] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:10:0)
[23:51:50.301] Build status: STARTED
[23:51:50.301] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:11:0) after 1m4s
[23:52:54.345] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:11:0)
[23:52:54.374] Build status: STARTED
[23:52:54.374] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:12:0) after 2m41s
[23:55:35.393] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:12:0)
[23:55:35.418] Build status: STARTED
[23:55:35.418] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:13:0) after 8m40s
[00:04:15.483] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:13:0)
[00:04:15.529] Build status: STARTED
[00:04:15.529] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:14:0) after 8m46s
[00:13:01.601] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:14:0)
[00:13:01.620] Build status: STARTED
[00:13:01.620] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:15:0) after 3m26s
[00:16:27.638] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:15:0)
[00:16:27.661] Build status: STARTED
[00:16:27.661] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:16:0) after 5m21s
[00:21:48.696] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:16:0)
[00:21:48.717] Build status: STARTED
[00:21:48.717] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:17:0) after 9m49s
[00:31:37.784] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:17:0)
[00:31:37.805] Build status: STARTED
[00:31:37.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:18:0) after 4m26s
[00:36:03.835] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:18:0)
[00:36:03.855] Build status: STARTED
[00:36:03.855] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:19:0) after 8m20s
[00:44:23.874] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:19:0)
[00:44:23.901] Build status: STARTED
[00:44:23.901] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:20:0) after 1m27s
[00:45:50.968] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:20:0)
[00:45:50.986] Build status: STARTED
[00:45:50.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:21:0) after 3m29s
[00:49:19.960] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:21:0)
[00:49:19.979] Build status: STARTED
[00:49:19.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901936618493445392:22:0) after 5m31s
[00:50:33.772] Received PubSub notification, asking Buildbucket for the build status
[00:50:33.792] Build:
{
"id": "8736506556336744785",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-17T23:18:24.314625607Z",
"startTime": "2024-09-17T23:18:34.828441325Z",
"endTime": "2024-09-18T00:50:33.410519604Z",
"updateTime": "2024-09-18T00:50:33.410519604Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b89bb7775d155fc787ab3170f3fa38449069ecb3",
"ref": "refs/heads/main"
}
}
}
[00:50:33.792] Invocation finished in 1h32m10.917179409s with status SUCCEEDED