[10:39:04.988] New invocation is queued and will start shortly
[10:39:06.050] Starting the invocation (attempt 1)
[10:39:06.079] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c19c71b90593dcbb94a9592d7cf75e58c99df6da"
[10:39:06.079] Popped gitiles commit info from properties and tags
[10:39:06.079] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:39:06.081] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:39:06.081] Buildbucket request:
{
"requestId": "8875439478255614176",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8875439478255614176",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5271f9fba9dd8cbb173123a51772e631459f116a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5271f9fba9dd8cbb173123a51772e631459f116a",
"title": "5271f9fba9dd8cbb173123a51772e631459f116a",
"url": "https://llvm.googlesource.com/llvm-project/+/5271f9fba9dd8cbb173123a51772e631459f116a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8a221a585ca70dede85f191992a0364e43cfdbf0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8a221a585ca70dede85f191992a0364e43cfdbf0",
"title": "8a221a585ca70dede85f191992a0364e43cfdbf0",
"url": "https://llvm.googlesource.com/llvm-project/+/8a221a585ca70dede85f191992a0364e43cfdbf0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "30836781e8019dc34995f7bb0ef163c4c3660c54"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@30836781e8019dc34995f7bb0ef163c4c3660c54",
"title": "30836781e8019dc34995f7bb0ef163c4c3660c54",
"url": "https://llvm.googlesource.com/llvm-project/+/30836781e8019dc34995f7bb0ef163c4c3660c54"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0860f7aaeb425dbeb790cb438355401766a2b5af"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0860f7aaeb425dbeb790cb438355401766a2b5af",
"title": "0860f7aaeb425dbeb790cb438355401766a2b5af",
"url": "https://llvm.googlesource.com/llvm-project/+/0860f7aaeb425dbeb790cb438355401766a2b5af"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "074ccde3b092ed231d344d4ffad50de93438196c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@074ccde3b092ed231d344d4ffad50de93438196c",
"title": "074ccde3b092ed231d344d4ffad50de93438196c",
"url": "https://llvm.googlesource.com/llvm-project/+/074ccde3b092ed231d344d4ffad50de93438196c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "08defcb6d3cdfbf58cfc07e3b16b3c9bed63ec4a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@08defcb6d3cdfbf58cfc07e3b16b3c9bed63ec4a",
"title": "08defcb6d3cdfbf58cfc07e3b16b3c9bed63ec4a",
"url": "https://llvm.googlesource.com/llvm-project/+/08defcb6d3cdfbf58cfc07e3b16b3c9bed63ec4a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ea685890b8b22c401bd7c5ec0b233349b479a029"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ea685890b8b22c401bd7c5ec0b233349b479a029",
"title": "ea685890b8b22c401bd7c5ec0b233349b479a029",
"url": "https://llvm.googlesource.com/llvm-project/+/ea685890b8b22c401bd7c5ec0b233349b479a029"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3e934dded0d988bdfd0975c117a302721130082a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3e934dded0d988bdfd0975c117a302721130082a",
"title": "3e934dded0d988bdfd0975c117a302721130082a",
"url": "https://llvm.googlesource.com/llvm-project/+/3e934dded0d988bdfd0975c117a302721130082a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b1a8c8a32c4b2453d526bcade145295966e90fda"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b1a8c8a32c4b2453d526bcade145295966e90fda",
"title": "b1a8c8a32c4b2453d526bcade145295966e90fda",
"url": "https://llvm.googlesource.com/llvm-project/+/b1a8c8a32c4b2453d526bcade145295966e90fda"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7cd179612d7af420f0025e754d0051a95ac1fd11"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7cd179612d7af420f0025e754d0051a95ac1fd11",
"title": "7cd179612d7af420f0025e754d0051a95ac1fd11",
"url": "https://llvm.googlesource.com/llvm-project/+/7cd179612d7af420f0025e754d0051a95ac1fd11"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "465f2b05712d18b32d5375c096f2406c6dcd700d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@465f2b05712d18b32d5375c096f2406c6dcd700d",
"title": "465f2b05712d18b32d5375c096f2406c6dcd700d",
"url": "https://llvm.googlesource.com/llvm-project/+/465f2b05712d18b32d5375c096f2406c6dcd700d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "52383956f8b7184aec14b5c8fe90aebd9f0a186f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@52383956f8b7184aec14b5c8fe90aebd9f0a186f",
"title": "52383956f8b7184aec14b5c8fe90aebd9f0a186f",
"url": "https://llvm.googlesource.com/llvm-project/+/52383956f8b7184aec14b5c8fe90aebd9f0a186f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b6b2561337f568aa434e1e837405e2bd2d9783e4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b6b2561337f568aa434e1e837405e2bd2d9783e4",
"title": "b6b2561337f568aa434e1e837405e2bd2d9783e4",
"url": "https://llvm.googlesource.com/llvm-project/+/b6b2561337f568aa434e1e837405e2bd2d9783e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "de7ff1f2248e76c7320b541eb5c082090c47390d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@de7ff1f2248e76c7320b541eb5c082090c47390d",
"title": "de7ff1f2248e76c7320b541eb5c082090c47390d",
"url": "https://llvm.googlesource.com/llvm-project/+/de7ff1f2248e76c7320b541eb5c082090c47390d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ded142671663c404f4d9fb9ef4867b4fc680409a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ded142671663c404f4d9fb9ef4867b4fc680409a",
"title": "ded142671663c404f4d9fb9ef4867b4fc680409a",
"url": "https://llvm.googlesource.com/llvm-project/+/ded142671663c404f4d9fb9ef4867b4fc680409a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e2aa8781e18a0091146f652935896fb6fb1963f7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e2aa8781e18a0091146f652935896fb6fb1963f7",
"title": "e2aa8781e18a0091146f652935896fb6fb1963f7",
"url": "https://llvm.googlesource.com/llvm-project/+/e2aa8781e18a0091146f652935896fb6fb1963f7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "84e54515bc4e9dd4938121f4df7cc27bb89a0a43"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@84e54515bc4e9dd4938121f4df7cc27bb89a0a43",
"title": "84e54515bc4e9dd4938121f4df7cc27bb89a0a43",
"url": "https://llvm.googlesource.com/llvm-project/+/84e54515bc4e9dd4938121f4df7cc27bb89a0a43"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "912ab5241379b4dd525080cd9a3e468d6779340c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@912ab5241379b4dd525080cd9a3e468d6779340c",
"title": "912ab5241379b4dd525080cd9a3e468d6779340c",
"url": "https://llvm.googlesource.com/llvm-project/+/912ab5241379b4dd525080cd9a3e468d6779340c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c19c71b90593dcbb94a9592d7cf75e58c99df6da"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c19c71b90593dcbb94a9592d7cf75e58c99df6da",
"title": "c19c71b90593dcbb94a9592d7cf75e58c99df6da",
"url": "https://llvm.googlesource.com/llvm-project/+/c19c71b90593dcbb94a9592d7cf75e58c99df6da"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c19c71b90593dcbb94a9592d7cf75e58c99df6da",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8875439478255614176"
},
{
"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"
}
}
[10:39:06.477] Scheduled build:
{
"id": "8710009416367621297",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-07T10:39:06.161313502Z",
"updateTime": "2025-07-07T10:39:06.161313502Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c19c71b90593dcbb94a9592d7cf75e58c99df6da",
"ref": "refs/heads/main"
}
}
}
[10:39:06.478] Task URL: https://cr-buildbucket.appspot.com/build/8710009416367621297
[10:39:06.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:2:0) after 7m31s
[10:39:07.478] Received PubSub notification, asking Buildbucket for the build status
[10:39:09.384] Build status: SCHEDULED
[10:39:58.740] Received PubSub notification, asking Buildbucket for the build status
[10:39:58.795] Build status: STARTED
[10:46:37.545] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:2:0)
[10:46:37.586] Build status: STARTED
[10:46:37.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:5:0) after 4m26s
[10:51:03.690] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:5:0)
[10:51:03.719] Build status: STARTED
[10:51:03.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:6:0) after 5m5s
[10:56:08.807] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:6:0)
[10:56:08.910] Build status: STARTED
[10:56:08.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:7:0) after 6m50s
[11:02:58.983] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:7:0)
[11:02:59.035] Build status: STARTED
[11:02:59.035] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:8:0) after 5m54s
[11:08:53.062] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:8:0)
[11:08:53.079] Build status: STARTED
[11:08:53.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:9:0) after 3m5s
[11:11:58.106] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:9:0)
[11:11:58.154] Build status: STARTED
[11:11:58.154] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:10:0) after 8m3s
[11:20:01.177] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:10:0)
[11:20:01.196] Build status: STARTED
[11:20:01.196] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:11:0) after 4m26s
[11:24:27.545] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:11:0)
[11:24:27.576] Build status: STARTED
[11:24:27.576] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:12:0) after 1m0s
[11:25:27.636] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:12:0)
[11:25:27.732] Build status: STARTED
[11:25:27.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:13:0) after 6m0s
[11:31:28.154] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:13:0)
[11:31:28.264] Build status: STARTED
[11:31:28.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:14:0) after 9m10s
[11:40:38.283] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:14:0)
[11:40:38.302] Build status: STARTED
[11:40:38.302] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:15:0) after 6m32s
[11:47:10.295] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:15:0)
[11:47:10.326] Build status: STARTED
[11:47:10.326] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:16:0) after 1m40s
[11:48:50.355] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:16:0)
[11:48:50.371] Build status: STARTED
[11:48:50.371] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:17:0) after 8m45s
[11:57:35.401] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:17:0)
[11:57:35.429] Build status: STARTED
[11:57:35.429] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:18:0) after 3m58s
[12:01:33.491] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:18:0)
[12:01:33.523] Build status: STARTED
[12:01:33.523] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:19:0) after 5m8s
[12:06:41.546] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:19:0)
[12:06:41.598] Build status: STARTED
[12:06:41.598] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875439478255614176:20:0) after 7m58s
[12:09:26.036] Received PubSub notification, asking Buildbucket for the build status
[12:09:26.058] Build:
{
"id": "8710009416367621297",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-07T10:39:06.161313502Z",
"startTime": "2025-07-07T10:39:58.264806161Z",
"endTime": "2025-07-07T12:09:25.665994114Z",
"updateTime": "2025-07-07T12:09:25.665994114Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c19c71b90593dcbb94a9592d7cf75e58c99df6da",
"ref": "refs/heads/main"
}
}
}
[12:09:26.058] Invocation finished in 1h30m21.08117739s with status SUCCEEDED