[17:32:00.141] New invocation is queued and will start shortly
[17:32:01.250] Starting the invocation (attempt 1)
[17:32:01.277] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7e4bdb427f7531a3d15c5aebb4cc94906404657b"
[17:32:01.277] Popped gitiles commit info from properties and tags
[17:32:01.277] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:32:01.277] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:32:01.278] Buildbucket request:
{
"requestId": "8879037378276056912",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8879037378276056912",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "219312c6238df66abcb33415186523207827bbe6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@219312c6238df66abcb33415186523207827bbe6",
"title": "219312c6238df66abcb33415186523207827bbe6",
"url": "https://llvm.googlesource.com/llvm-project/+/219312c6238df66abcb33415186523207827bbe6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "617cfedc43ae93960633909c00feed5345eeac6a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@617cfedc43ae93960633909c00feed5345eeac6a",
"title": "617cfedc43ae93960633909c00feed5345eeac6a",
"url": "https://llvm.googlesource.com/llvm-project/+/617cfedc43ae93960633909c00feed5345eeac6a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c3656afdf111901977792c1d9589cb32ee1b6015"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c3656afdf111901977792c1d9589cb32ee1b6015",
"title": "c3656afdf111901977792c1d9589cb32ee1b6015",
"url": "https://llvm.googlesource.com/llvm-project/+/c3656afdf111901977792c1d9589cb32ee1b6015"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4608df5b9fea7322714fc5fe7e6bcc5e5e3a666a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4608df5b9fea7322714fc5fe7e6bcc5e5e3a666a",
"title": "4608df5b9fea7322714fc5fe7e6bcc5e5e3a666a",
"url": "https://llvm.googlesource.com/llvm-project/+/4608df5b9fea7322714fc5fe7e6bcc5e5e3a666a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4ad230bebd1dcdf09f445181f34e8fa92e970412"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4ad230bebd1dcdf09f445181f34e8fa92e970412",
"title": "4ad230bebd1dcdf09f445181f34e8fa92e970412",
"url": "https://llvm.googlesource.com/llvm-project/+/4ad230bebd1dcdf09f445181f34e8fa92e970412"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f64cd30367e7cee4a0b82b405d96e9b37412b391"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f64cd30367e7cee4a0b82b405d96e9b37412b391",
"title": "f64cd30367e7cee4a0b82b405d96e9b37412b391",
"url": "https://llvm.googlesource.com/llvm-project/+/f64cd30367e7cee4a0b82b405d96e9b37412b391"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "caaca3298e4c08936d8f10df4ebc1749c8a66902"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@caaca3298e4c08936d8f10df4ebc1749c8a66902",
"title": "caaca3298e4c08936d8f10df4ebc1749c8a66902",
"url": "https://llvm.googlesource.com/llvm-project/+/caaca3298e4c08936d8f10df4ebc1749c8a66902"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a1191b48755a8ce651792ba06a430338f41af2f1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a1191b48755a8ce651792ba06a430338f41af2f1",
"title": "a1191b48755a8ce651792ba06a430338f41af2f1",
"url": "https://llvm.googlesource.com/llvm-project/+/a1191b48755a8ce651792ba06a430338f41af2f1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "63385e7fc94039e1af6a8f21bebf8974f9d4a2a7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@63385e7fc94039e1af6a8f21bebf8974f9d4a2a7",
"title": "63385e7fc94039e1af6a8f21bebf8974f9d4a2a7",
"url": "https://llvm.googlesource.com/llvm-project/+/63385e7fc94039e1af6a8f21bebf8974f9d4a2a7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1610d41d8397301c3c39486b7ed1d329f43aad5d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1610d41d8397301c3c39486b7ed1d329f43aad5d",
"title": "1610d41d8397301c3c39486b7ed1d329f43aad5d",
"url": "https://llvm.googlesource.com/llvm-project/+/1610d41d8397301c3c39486b7ed1d329f43aad5d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "61a98eb7d3a6e42b4a0a0c651bd62411f783c166"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@61a98eb7d3a6e42b4a0a0c651bd62411f783c166",
"title": "61a98eb7d3a6e42b4a0a0c651bd62411f783c166",
"url": "https://llvm.googlesource.com/llvm-project/+/61a98eb7d3a6e42b4a0a0c651bd62411f783c166"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff5095db93762412a1c09225b18f80b06b99ff68"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff5095db93762412a1c09225b18f80b06b99ff68",
"title": "ff5095db93762412a1c09225b18f80b06b99ff68",
"url": "https://llvm.googlesource.com/llvm-project/+/ff5095db93762412a1c09225b18f80b06b99ff68"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b8dcf53dc636239b82e2524d1cffc2c46ace751a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b8dcf53dc636239b82e2524d1cffc2c46ace751a",
"title": "b8dcf53dc636239b82e2524d1cffc2c46ace751a",
"url": "https://llvm.googlesource.com/llvm-project/+/b8dcf53dc636239b82e2524d1cffc2c46ace751a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a41e20a53ca28c93085e33469718450e7063e778"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a41e20a53ca28c93085e33469718450e7063e778",
"title": "a41e20a53ca28c93085e33469718450e7063e778",
"url": "https://llvm.googlesource.com/llvm-project/+/a41e20a53ca28c93085e33469718450e7063e778"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fc9ce037ef824a657f0e07f6d501dcc8fd0285c7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fc9ce037ef824a657f0e07f6d501dcc8fd0285c7",
"title": "fc9ce037ef824a657f0e07f6d501dcc8fd0285c7",
"url": "https://llvm.googlesource.com/llvm-project/+/fc9ce037ef824a657f0e07f6d501dcc8fd0285c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b14799e9e0ed2cae7cbce45c413233336b151fea"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b14799e9e0ed2cae7cbce45c413233336b151fea",
"title": "b14799e9e0ed2cae7cbce45c413233336b151fea",
"url": "https://llvm.googlesource.com/llvm-project/+/b14799e9e0ed2cae7cbce45c413233336b151fea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7e4bdb427f7531a3d15c5aebb4cc94906404657b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7e4bdb427f7531a3d15c5aebb4cc94906404657b",
"title": "7e4bdb427f7531a3d15c5aebb4cc94906404657b",
"url": "https://llvm.googlesource.com/llvm-project/+/7e4bdb427f7531a3d15c5aebb4cc94906404657b"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7e4bdb427f7531a3d15c5aebb4cc94906404657b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8879037378276056912"
},
{
"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"
}
}
[17:32:01.704] Scheduled build:
{
"id": "8713607316361210721",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-28T17:32:01.344342350Z",
"updateTime": "2025-05-28T17:32:01.344342350Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7e4bdb427f7531a3d15c5aebb4cc94906404657b",
"ref": "refs/heads/main"
}
},
"canary": true
}
[17:32:01.704] Task URL: https://cr-buildbucket.appspot.com/build/8713607316361210721
[17:32:01.704] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:2:0) after 8m16s
[17:32:02.165] Received PubSub notification, asking Buildbucket for the build status
[17:32:02.207] Build status: SCHEDULED
[17:40:17.769] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:2:0)
[17:40:17.802] Build status: SCHEDULED
[17:40:17.802] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:4:0) after 3m23s
[17:43:40.825] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:4:0)
[17:43:40.856] Build status: SCHEDULED
[17:43:40.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:5:0) after 6m13s
[17:47:02.195] Received PubSub notification, asking Buildbucket for the build status
[17:47:02.228] Build status: STARTED
[17:49:53.940] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:5:0)
[17:49:54.031] Build status: STARTED
[17:49:54.031] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:7:0) after 4m2s
[17:53:56.097] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:7:0)
[17:53:56.123] Build status: STARTED
[17:53:56.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:8:0) after 3m5s
[17:57:01.142] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:8:0)
[17:57:01.169] Build status: STARTED
[17:57:01.169] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:9:0) after 8m16s
[18:05:17.198] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:9:0)
[18:05:17.221] Build status: STARTED
[18:05:17.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:10:0) after 9m23s
[18:14:40.215] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:10:0)
[18:14:40.238] Build status: STARTED
[18:14:40.238] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:11:0) after 4m20s
[18:19:00.392] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:11:0)
[18:19:00.414] Build status: STARTED
[18:19:00.414] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:12:0) after 4m50s
[18:23:50.435] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:12:0)
[18:23:50.451] Build status: STARTED
[18:23:50.451] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:13:0) after 8m43s
[18:32:33.486] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:13:0)
[18:32:33.501] Build status: STARTED
[18:32:33.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:14:0) after 6m56s
[18:39:29.515] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:14:0)
[18:39:29.559] Build status: STARTED
[18:39:29.559] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:15:0) after 9m52s
[18:49:21.541] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:15:0)
[18:49:21.616] Build status: STARTED
[18:49:21.617] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:16:0) after 2m53s
[18:52:14.721] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:16:0)
[18:52:14.748] Build status: STARTED
[18:52:14.748] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:17:0) after 8m37s
[19:00:51.802] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:17:0)
[19:00:51.820] Build status: STARTED
[19:00:51.820] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:18:0) after 8m33s
[19:09:25.028] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:18:0)
[19:09:25.056] Build status: STARTED
[19:09:25.056] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:19:0) after 1m34s
[19:10:59.076] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:19:0)
[19:10:59.095] Build status: STARTED
[19:10:59.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:20:0) after 7m0s
[19:17:59.218] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:20:0)
[19:17:59.235] Build status: STARTED
[19:17:59.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879037378276056912:21:0) after 8m56s
[19:23:31.473] Received PubSub notification, asking Buildbucket for the build status
[19:23:31.489] Build:
{
"id": "8713607316361210721",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-28T17:32:01.344342350Z",
"startTime": "2025-05-28T17:47:01.953631563Z",
"endTime": "2025-05-28T19:23:29.805120940Z",
"updateTime": "2025-05-28T19:23:29.805120940Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7e4bdb427f7531a3d15c5aebb4cc94906404657b",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:23:31.489] Invocation finished in 1h51m31.353824823s with status SUCCEEDED