[16:10:26.234] New invocation is queued and will start shortly
[16:10:27.473] Starting the invocation (attempt 1)
[16:10:27.503] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/54c6ee922abbaea7d2f138a209f320c414c1657b"
[16:10:27.503] Popped gitiles commit info from properties and tags
[16:10:27.503] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:10:27.504] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:10:27.505] Buildbucket request:
{
"requestId": "8913288163218838080",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8913288163218838080",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dceaa0f4491ebe30c0b0f1bc7fa5ec365b60ced6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dceaa0f4491ebe30c0b0f1bc7fa5ec365b60ced6",
"title": "dceaa0f4491ebe30c0b0f1bc7fa5ec365b60ced6",
"url": "https://llvm.googlesource.com/llvm-project/+/dceaa0f4491ebe30c0b0f1bc7fa5ec365b60ced6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8ab753c121447c1388c4cb1af08ab27b2cd62a82"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8ab753c121447c1388c4cb1af08ab27b2cd62a82",
"title": "8ab753c121447c1388c4cb1af08ab27b2cd62a82",
"url": "https://llvm.googlesource.com/llvm-project/+/8ab753c121447c1388c4cb1af08ab27b2cd62a82"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "413aaf11cd74f422f05b990613f822dc10db4391"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@413aaf11cd74f422f05b990613f822dc10db4391",
"title": "413aaf11cd74f422f05b990613f822dc10db4391",
"url": "https://llvm.googlesource.com/llvm-project/+/413aaf11cd74f422f05b990613f822dc10db4391"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "28d5f7907e8c3adb6f0e2e16c9673a99f5e07522"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@28d5f7907e8c3adb6f0e2e16c9673a99f5e07522",
"title": "28d5f7907e8c3adb6f0e2e16c9673a99f5e07522",
"url": "https://llvm.googlesource.com/llvm-project/+/28d5f7907e8c3adb6f0e2e16c9673a99f5e07522"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4527adc500ea0dc4b942a51dc7209da4ea26d9a2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4527adc500ea0dc4b942a51dc7209da4ea26d9a2",
"title": "4527adc500ea0dc4b942a51dc7209da4ea26d9a2",
"url": "https://llvm.googlesource.com/llvm-project/+/4527adc500ea0dc4b942a51dc7209da4ea26d9a2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b576a6b0452b9bfb634feaa215506d8a1afe857d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b576a6b0452b9bfb634feaa215506d8a1afe857d",
"title": "b576a6b0452b9bfb634feaa215506d8a1afe857d",
"url": "https://llvm.googlesource.com/llvm-project/+/b576a6b0452b9bfb634feaa215506d8a1afe857d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bed5546bb53bdb231b62f569b67f449019426ce8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bed5546bb53bdb231b62f569b67f449019426ce8",
"title": "bed5546bb53bdb231b62f569b67f449019426ce8",
"url": "https://llvm.googlesource.com/llvm-project/+/bed5546bb53bdb231b62f569b67f449019426ce8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dcf3102be8458fe7588f9d11315beddfca4323b0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dcf3102be8458fe7588f9d11315beddfca4323b0",
"title": "dcf3102be8458fe7588f9d11315beddfca4323b0",
"url": "https://llvm.googlesource.com/llvm-project/+/dcf3102be8458fe7588f9d11315beddfca4323b0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8e00703be9ceb41d9b80c2bc8f024a9610b9aaa1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8e00703be9ceb41d9b80c2bc8f024a9610b9aaa1",
"title": "8e00703be9ceb41d9b80c2bc8f024a9610b9aaa1",
"url": "https://llvm.googlesource.com/llvm-project/+/8e00703be9ceb41d9b80c2bc8f024a9610b9aaa1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff313ee70a4f27e3555ee4baef53b9b51c5aa27e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff313ee70a4f27e3555ee4baef53b9b51c5aa27e",
"title": "ff313ee70a4f27e3555ee4baef53b9b51c5aa27e",
"url": "https://llvm.googlesource.com/llvm-project/+/ff313ee70a4f27e3555ee4baef53b9b51c5aa27e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "74218a9c8fc4b0bdb4b2a4839455cf2f211a2a30"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@74218a9c8fc4b0bdb4b2a4839455cf2f211a2a30",
"title": "74218a9c8fc4b0bdb4b2a4839455cf2f211a2a30",
"url": "https://llvm.googlesource.com/llvm-project/+/74218a9c8fc4b0bdb4b2a4839455cf2f211a2a30"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3a8d176af519e4385652e762c615ace9b80ef045"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3a8d176af519e4385652e762c615ace9b80ef045",
"title": "3a8d176af519e4385652e762c615ace9b80ef045",
"url": "https://llvm.googlesource.com/llvm-project/+/3a8d176af519e4385652e762c615ace9b80ef045"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ba3447601c435bb2b24ad9e3c8d146c578f00568"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ba3447601c435bb2b24ad9e3c8d146c578f00568",
"title": "ba3447601c435bb2b24ad9e3c8d146c578f00568",
"url": "https://llvm.googlesource.com/llvm-project/+/ba3447601c435bb2b24ad9e3c8d146c578f00568"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "54c6ee922abbaea7d2f138a209f320c414c1657b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@54c6ee922abbaea7d2f138a209f320c414c1657b",
"title": "54c6ee922abbaea7d2f138a209f320c414c1657b",
"url": "https://llvm.googlesource.com/llvm-project/+/54c6ee922abbaea7d2f138a209f320c414c1657b"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "54c6ee922abbaea7d2f138a209f320c414c1657b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8913288163218838080"
},
{
"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"
}
}
[16:10:28.072] Scheduled build:
{
"id": "8747858101118656433",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-15T16:10:27.604677967Z",
"updateTime": "2024-05-15T16:10:27.604677967Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "54c6ee922abbaea7d2f138a209f320c414c1657b",
"ref": "refs/heads/main"
}
}
}
[16:10:28.072] Task URL: https://cr-buildbucket.appspot.com/build/8747858101118656433
[16:10:28.072] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:2:0) after 7m33s
[16:10:28.974] Received PubSub notification, asking Buildbucket for the build status
[16:10:29.005] Build status: SCHEDULED
[16:18:01.119] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:2:0)
[16:18:01.179] Build status: SCHEDULED
[16:18:01.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:4:0) after 5m31s
[16:18:42.354] Received PubSub notification, asking Buildbucket for the build status
[16:18:42.374] Build status: STARTED
[16:23:32.232] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:4:0)
[16:23:32.257] Build status: STARTED
[16:23:32.257] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:6:0) after 5m2s
[16:28:34.273] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:6:0)
[16:28:34.293] Build status: STARTED
[16:28:34.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:7:0) after 7m43s
[16:36:17.281] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:7:0)
[16:36:17.354] Build status: STARTED
[16:36:17.354] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:8:0) after 3m10s
[16:39:27.433] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:8:0)
[16:39:27.464] Build status: STARTED
[16:39:27.464] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:9:0) after 4m29s
[16:43:56.487] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:9:0)
[16:43:56.503] Build status: STARTED
[16:43:56.503] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:10:0) after 2m17s
[16:46:13.521] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:10:0)
[16:46:13.546] Build status: STARTED
[16:46:13.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:11:0) after 2m35s
[16:48:48.560] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:11:0)
[16:48:48.590] Build status: STARTED
[16:48:48.590] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:12:0) after 5m24s
[16:54:12.614] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:12:0)
[16:54:12.634] Build status: STARTED
[16:54:12.635] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:13:0) after 2m6s
[16:56:18.693] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:13:0)
[16:56:18.733] Build status: STARTED
[16:56:18.733] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:14:0) after 6m43s
[17:03:01.957] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:14:0)
[17:03:02.148] Build status: STARTED
[17:03:02.148] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:15:0) after 4m24s
[17:07:26.230] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:15:0)
[17:07:26.291] Build status: STARTED
[17:07:26.292] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:16:0) after 5m45s
[17:13:11.308] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:16:0)
[17:13:11.336] Build status: STARTED
[17:13:11.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:17:0) after 6m13s
[17:19:24.332] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:17:0)
[17:19:24.394] Build status: STARTED
[17:19:24.394] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:18:0) after 9m59s
[17:29:23.416] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:18:0)
[17:29:23.441] Build status: STARTED
[17:29:23.441] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:19:0) after 6m47s
[17:36:10.511] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:19:0)
[17:36:10.539] Build status: STARTED
[17:36:10.539] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:20:0) after 3m7s
[17:39:17.563] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:20:0)
[17:39:17.586] Build status: STARTED
[17:39:17.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:21:0) after 3m15s
[17:42:32.721] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:21:0)
[17:42:32.788] Build status: STARTED
[17:42:32.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913288163218838080:22:0) after 3m14s
[17:42:46.417] Received PubSub notification, asking Buildbucket for the build status
[17:42:46.435] Build:
{
"id": "8747858101118656433",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-15T16:10:27.604677967Z",
"startTime": "2024-05-15T16:18:42.162790068Z",
"endTime": "2024-05-15T17:42:46.010969770Z",
"updateTime": "2024-05-15T17:42:46.010969770Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "54c6ee922abbaea7d2f138a209f320c414c1657b",
"ref": "refs/heads/main"
}
}
}
[17:42:46.435] Invocation finished in 1h32m20.217277524s with status SUCCEEDED