[01:35:43.019] New invocation is queued and will start shortly
[01:35:44.471] Starting the invocation (attempt 1)
[01:35:44.502] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f1dd6b3cf8d957f28e06f475c8a652f201fc830b"
[01:35:44.502] Popped gitiles commit info from properties and tags
[01:35:44.502] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:35:44.502] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:35:44.503] Buildbucket request:
{
"requestId": "8882993212106963312",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8882993212106963312",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8e8d04870dbc3248301534796b4370f75e33f7c0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8e8d04870dbc3248301534796b4370f75e33f7c0",
"title": "8e8d04870dbc3248301534796b4370f75e33f7c0",
"url": "https://llvm.googlesource.com/llvm-project/+/8e8d04870dbc3248301534796b4370f75e33f7c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "07fe9c6461dbdde6f619fc56bd021cd30b3f6327"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@07fe9c6461dbdde6f619fc56bd021cd30b3f6327",
"title": "07fe9c6461dbdde6f619fc56bd021cd30b3f6327",
"url": "https://llvm.googlesource.com/llvm-project/+/07fe9c6461dbdde6f619fc56bd021cd30b3f6327"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fe9e2090be79a2b807d381a0a045bc606d59c33c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fe9e2090be79a2b807d381a0a045bc606d59c33c",
"title": "fe9e2090be79a2b807d381a0a045bc606d59c33c",
"url": "https://llvm.googlesource.com/llvm-project/+/fe9e2090be79a2b807d381a0a045bc606d59c33c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a686b783ce244a6dfebd17b717532c516419fc32"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a686b783ce244a6dfebd17b717532c516419fc32",
"title": "a686b783ce244a6dfebd17b717532c516419fc32",
"url": "https://llvm.googlesource.com/llvm-project/+/a686b783ce244a6dfebd17b717532c516419fc32"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6ba32e8eb203ebabd3fc9fffcea2762500f82e3a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6ba32e8eb203ebabd3fc9fffcea2762500f82e3a",
"title": "6ba32e8eb203ebabd3fc9fffcea2762500f82e3a",
"url": "https://llvm.googlesource.com/llvm-project/+/6ba32e8eb203ebabd3fc9fffcea2762500f82e3a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cc354d6a6da542515fbd6f39dcb9665b7c26a008"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cc354d6a6da542515fbd6f39dcb9665b7c26a008",
"title": "cc354d6a6da542515fbd6f39dcb9665b7c26a008",
"url": "https://llvm.googlesource.com/llvm-project/+/cc354d6a6da542515fbd6f39dcb9665b7c26a008"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e96111d3e9ac67b14cab32925717a62258a2bd60"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e96111d3e9ac67b14cab32925717a62258a2bd60",
"title": "e96111d3e9ac67b14cab32925717a62258a2bd60",
"url": "https://llvm.googlesource.com/llvm-project/+/e96111d3e9ac67b14cab32925717a62258a2bd60"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9cdc3aab3eae55be30003cb486f290f3ee3df3a8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9cdc3aab3eae55be30003cb486f290f3ee3df3a8",
"title": "9cdc3aab3eae55be30003cb486f290f3ee3df3a8",
"url": "https://llvm.googlesource.com/llvm-project/+/9cdc3aab3eae55be30003cb486f290f3ee3df3a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5df9658d4009e500be1421231b48b210e8c2cd69"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5df9658d4009e500be1421231b48b210e8c2cd69",
"title": "5df9658d4009e500be1421231b48b210e8c2cd69",
"url": "https://llvm.googlesource.com/llvm-project/+/5df9658d4009e500be1421231b48b210e8c2cd69"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f4ff209e4384d8073f36fb7da9916b33f1140edf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f4ff209e4384d8073f36fb7da9916b33f1140edf",
"title": "f4ff209e4384d8073f36fb7da9916b33f1140edf",
"url": "https://llvm.googlesource.com/llvm-project/+/f4ff209e4384d8073f36fb7da9916b33f1140edf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a6b424e1e7e6aa83ae49e7e12454998d3b195054"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a6b424e1e7e6aa83ae49e7e12454998d3b195054",
"title": "a6b424e1e7e6aa83ae49e7e12454998d3b195054",
"url": "https://llvm.googlesource.com/llvm-project/+/a6b424e1e7e6aa83ae49e7e12454998d3b195054"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "83344da69145a648aad3e0cd88eab4aaf60b2142"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@83344da69145a648aad3e0cd88eab4aaf60b2142",
"title": "83344da69145a648aad3e0cd88eab4aaf60b2142",
"url": "https://llvm.googlesource.com/llvm-project/+/83344da69145a648aad3e0cd88eab4aaf60b2142"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f1dd6b3cf8d957f28e06f475c8a652f201fc830b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f1dd6b3cf8d957f28e06f475c8a652f201fc830b",
"title": "f1dd6b3cf8d957f28e06f475c8a652f201fc830b",
"url": "https://llvm.googlesource.com/llvm-project/+/f1dd6b3cf8d957f28e06f475c8a652f201fc830b"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f1dd6b3cf8d957f28e06f475c8a652f201fc830b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882993212106963312"
},
{
"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"
}
}
[01:35:44.943] Scheduled build:
{
"id": "8717563149790997809",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-15T01:35:44.602518349Z",
"updateTime": "2025-04-15T01:35:44.602518349Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f1dd6b3cf8d957f28e06f475c8a652f201fc830b",
"ref": "refs/heads/main"
}
}
}
[01:35:44.943] Task URL: https://cr-buildbucket.appspot.com/build/8717563149790997809
[01:35:44.943] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:2:0) after 1m4s
[01:35:57.936] Received PubSub notification, asking Buildbucket for the build status
[01:35:57.971] Build status: SCHEDULED
[01:36:49.391] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:2:0)
[01:36:49.418] Build status: SCHEDULED
[01:36:49.418] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:4:0) after 5m39s
[01:42:28.471] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:4:0)
[01:42:28.495] Build status: SCHEDULED
[01:42:28.495] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:5:0) after 1m35s
[01:44:03.618] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:5:0)
[01:44:03.643] Build status: SCHEDULED
[01:44:03.643] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:6:0) after 3m14s
[01:47:17.770] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:6:0)
[01:47:17.796] Build status: SCHEDULED
[01:47:17.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:7:0) after 5m23s
[01:52:40.812] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:7:0)
[01:52:40.834] Build status: SCHEDULED
[01:52:40.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:8:0) after 9m2s
[01:52:54.806] Received PubSub notification, asking Buildbucket for the build status
[01:52:54.822] Build status: STARTED
[02:01:43.011] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:8:0)
[02:01:43.033] Build status: STARTED
[02:01:43.033] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:10:0) after 2m39s
[02:04:22.108] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:10:0)
[02:04:22.137] Build status: STARTED
[02:04:22.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:11:0) after 3m30s
[02:07:52.255] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:11:0)
[02:07:52.285] Build status: STARTED
[02:07:52.286] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:12:0) after 6m41s
[02:14:33.307] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:12:0)
[02:14:33.329] Build status: STARTED
[02:14:33.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:13:0) after 8m55s
[02:23:28.443] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:13:0)
[02:23:28.465] Build status: STARTED
[02:23:28.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:14:0) after 6m41s
[02:30:09.487] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:14:0)
[02:30:09.511] Build status: STARTED
[02:30:09.511] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:15:0) after 8m0s
[02:38:09.670] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:15:0)
[02:38:09.692] Build status: STARTED
[02:38:09.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:16:0) after 1m25s
[02:39:34.790] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:16:0)
[02:39:34.817] Build status: STARTED
[02:39:34.817] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:17:0) after 4m58s
[02:44:33.346] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:17:0)
[02:44:33.373] Build status: STARTED
[02:44:33.373] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:18:0) after 5m15s
[02:49:48.641] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:18:0)
[02:49:48.656] Build status: STARTED
[02:49:48.656] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:19:0) after 4m10s
[02:53:58.682] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:19:0)
[02:53:58.699] Build status: STARTED
[02:53:58.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:20:0) after 4m41s
[02:58:39.716] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:20:0)
[02:58:39.739] Build status: STARTED
[02:58:39.739] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:21:0) after 3m34s
[03:02:13.865] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:21:0)
[03:02:13.887] Build status: STARTED
[03:02:13.887] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:22:0) after 7m31s
[03:09:44.907] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:22:0)
[03:09:44.932] Build status: STARTED
[03:09:44.932] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:23:0) after 4m18s
[03:14:03.542] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:23:0)
[03:14:03.604] Build status: STARTED
[03:14:03.604] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:24:0) after 5m53s
[03:19:56.784] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:24:0)
[03:19:56.805] Build status: STARTED
[03:19:56.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:25:0) after 6m35s
[03:26:31.816] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:25:0)
[03:26:31.840] Build status: STARTED
[03:26:31.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882993212106963312:26:0) after 7m57s
[03:33:52.498] Received PubSub notification, asking Buildbucket for the build status
[03:33:52.523] Build:
{
"id": "8717563149790997809",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-15T01:35:44.602518349Z",
"startTime": "2025-04-15T01:52:54.499292484Z",
"endTime": "2025-04-15T03:33:52.097410627Z",
"updateTime": "2025-04-15T03:33:52.097410627Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f1dd6b3cf8d957f28e06f475c8a652f201fc830b",
"ref": "refs/heads/main"
}
}
}
[03:33:52.523] Invocation finished in 1h58m9.513267384s with status SUCCEEDED