[19:36:10.996] New invocation is queued and will start shortly
[19:36:12.048] Starting the invocation (attempt 1)
[19:36:12.077] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e9866d5d149706eac26f45bf0cab933c51d6d1cd"
[19:36:12.077] Popped gitiles commit info from properties and tags
[19:36:12.077] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:36:12.077] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:36:12.077] Buildbucket request:
{
"requestId": "8894340452817235456",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8894340452817235456",
"job": "fuchsia/clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "faebeddac078f647f74a318fb2fbd2e7962cd493"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@faebeddac078f647f74a318fb2fbd2e7962cd493",
"title": "faebeddac078f647f74a318fb2fbd2e7962cd493",
"url": "https://llvm.googlesource.com/llvm-project/+/faebeddac078f647f74a318fb2fbd2e7962cd493"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f6012a209dca6b1866d00e6b4f96279469884320"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f6012a209dca6b1866d00e6b4f96279469884320",
"title": "f6012a209dca6b1866d00e6b4f96279469884320",
"url": "https://llvm.googlesource.com/llvm-project/+/f6012a209dca6b1866d00e6b4f96279469884320"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "806a936b36553f284c2c68e67fd60abc75b200e6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@806a936b36553f284c2c68e67fd60abc75b200e6",
"title": "806a936b36553f284c2c68e67fd60abc75b200e6",
"url": "https://llvm.googlesource.com/llvm-project/+/806a936b36553f284c2c68e67fd60abc75b200e6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dc04d414df9c243bb90d7cfc683a632a2c032c62"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dc04d414df9c243bb90d7cfc683a632a2c032c62",
"title": "dc04d414df9c243bb90d7cfc683a632a2c032c62",
"url": "https://llvm.googlesource.com/llvm-project/+/dc04d414df9c243bb90d7cfc683a632a2c032c62"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff42a9012ae8c99b85a2f44e48daa06ba998f265"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff42a9012ae8c99b85a2f44e48daa06ba998f265",
"title": "ff42a9012ae8c99b85a2f44e48daa06ba998f265",
"url": "https://llvm.googlesource.com/llvm-project/+/ff42a9012ae8c99b85a2f44e48daa06ba998f265"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9c509a0c6a5184d7ce32e7f15c1241fac9eac1ef"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9c509a0c6a5184d7ce32e7f15c1241fac9eac1ef",
"title": "9c509a0c6a5184d7ce32e7f15c1241fac9eac1ef",
"url": "https://llvm.googlesource.com/llvm-project/+/9c509a0c6a5184d7ce32e7f15c1241fac9eac1ef"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3376bad13216da8950bcdeb564df26d5ce4c12bc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3376bad13216da8950bcdeb564df26d5ce4c12bc",
"title": "3376bad13216da8950bcdeb564df26d5ce4c12bc",
"url": "https://llvm.googlesource.com/llvm-project/+/3376bad13216da8950bcdeb564df26d5ce4c12bc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4c04bf81163459404dd3b444ab462ed07e71771a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4c04bf81163459404dd3b444ab462ed07e71771a",
"title": "4c04bf81163459404dd3b444ab462ed07e71771a",
"url": "https://llvm.googlesource.com/llvm-project/+/4c04bf81163459404dd3b444ab462ed07e71771a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b347b477858b10cf63f3e1455fe2592e91076b86"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b347b477858b10cf63f3e1455fe2592e91076b86",
"title": "b347b477858b10cf63f3e1455fe2592e91076b86",
"url": "https://llvm.googlesource.com/llvm-project/+/b347b477858b10cf63f3e1455fe2592e91076b86"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e0f3410be9ae7e62a4ec7c3676e46afc81120dbb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e0f3410be9ae7e62a4ec7c3676e46afc81120dbb",
"title": "e0f3410be9ae7e62a4ec7c3676e46afc81120dbb",
"url": "https://llvm.googlesource.com/llvm-project/+/e0f3410be9ae7e62a4ec7c3676e46afc81120dbb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ffb19f4018e38ba7ff034b78914d5a8d2890a603"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ffb19f4018e38ba7ff034b78914d5a8d2890a603",
"title": "ffb19f4018e38ba7ff034b78914d5a8d2890a603",
"url": "https://llvm.googlesource.com/llvm-project/+/ffb19f4018e38ba7ff034b78914d5a8d2890a603"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e9866d5d149706eac26f45bf0cab933c51d6d1cd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e9866d5d149706eac26f45bf0cab933c51d6d1cd",
"title": "e9866d5d149706eac26f45bf0cab933c51d6d1cd",
"url": "https://llvm.googlesource.com/llvm-project/+/e9866d5d149706eac26f45bf0cab933c51d6d1cd"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e9866d5d149706eac26f45bf0cab933c51d6d1cd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8894340452817235456"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang-ci-trigger-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:36:12.596] Scheduled build:
{
"id": "8728910390899898641",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-10T19:36:12.195961451Z",
"updateTime": "2024-12-10T19:36:12.195961451Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e9866d5d149706eac26f45bf0cab933c51d6d1cd",
"ref": "refs/heads/main"
}
}
}
[19:36:12.596] Task URL: https://cr-buildbucket.appspot.com/build/8728910390899898641
[19:36:12.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:2:0) after 7m7s
[19:36:13.561] Received PubSub notification, asking Buildbucket for the build status
[19:36:13.588] Build status: SCHEDULED
[19:36:24.576] Received PubSub notification, asking Buildbucket for the build status
[19:36:24.599] Build status: STARTED
[19:43:19.754] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:2:0)
[19:43:20.405] Build status: STARTED
[19:43:20.405] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:5:0) after 4m24s
[19:47:44.471] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:5:0)
[19:47:44.495] Build status: STARTED
[19:47:44.495] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:6:0) after 2m19s
[19:50:03.559] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:6:0)
[19:50:03.580] Build status: STARTED
[19:50:03.580] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:7:0) after 4m42s
[19:54:45.597] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:7:0)
[19:54:45.627] Build status: STARTED
[19:54:45.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:8:0) after 5m52s
[20:00:37.672] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:8:0)
[20:00:37.692] Build status: STARTED
[20:00:37.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:9:0) after 9m55s
[20:10:32.845] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:9:0)
[20:10:32.876] Build status: STARTED
[20:10:32.876] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:10:0) after 3m51s
[20:14:23.942] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:10:0)
[20:14:24.003] Build status: STARTED
[20:14:24.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:11:0) after 3m45s
[20:18:09.139] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:11:0)
[20:18:09.161] Build status: STARTED
[20:18:09.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:12:0) after 4m58s
[20:23:07.220] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:12:0)
[20:23:07.238] Build status: STARTED
[20:23:07.238] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:13:0) after 8m24s
[20:31:31.304] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:13:0)
[20:31:31.323] Build status: STARTED
[20:31:31.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:14:0) after 5m27s
[20:36:58.342] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:14:0)
[20:36:58.369] Build status: STARTED
[20:36:58.369] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:15:0) after 5m34s
[20:42:32.660] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:15:0)
[20:42:32.718] Build status: STARTED
[20:42:32.718] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:16:0) after 2m14s
[20:44:46.849] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:16:0)
[20:44:46.895] Build status: STARTED
[20:44:46.895] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:17:0) after 5m11s
[20:49:57.880] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:17:0)
[20:49:57.900] Build status: STARTED
[20:49:57.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8894340452817235456:18:0) after 7m24s
[20:50:05.813] Received PubSub notification, asking Buildbucket for the build status
[20:50:05.838] Build:
{
"id": "8728910390899898641",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-10T19:36:12.195961451Z",
"startTime": "2024-12-10T19:36:22.263644698Z",
"endTime": "2024-12-10T20:50:05.568011130Z",
"updateTime": "2024-12-10T20:50:05.568011130Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e9866d5d149706eac26f45bf0cab933c51d6d1cd",
"ref": "refs/heads/main"
}
}
}
[20:50:05.838] Invocation finished in 1h13m54.855886281s with status SUCCEEDED