[00:38:06.651] New invocation is queued and will start shortly
[00:38:08.253] Starting the invocation (attempt 1)
[00:38:08.277] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9cdc3aab3eae55be30003cb486f290f3ee3df3a8"
[00:38:08.277] Popped gitiles commit info from properties and tags
[00:38:08.277] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:38:08.277] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:38:08.278] Buildbucket request:
{
"requestId": "8882996836385719472",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8882996836385719472",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a9f73ae4494437c606c2b2e869358b75d8e2d45c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a9f73ae4494437c606c2b2e869358b75d8e2d45c",
"title": "a9f73ae4494437c606c2b2e869358b75d8e2d45c",
"url": "https://llvm.googlesource.com/llvm-project/+/a9f73ae4494437c606c2b2e869358b75d8e2d45c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "76db259080fa134579f31d76fe9ab462f47eca87"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@76db259080fa134579f31d76fe9ab462f47eca87",
"title": "76db259080fa134579f31d76fe9ab462f47eca87",
"url": "https://llvm.googlesource.com/llvm-project/+/76db259080fa134579f31d76fe9ab462f47eca87"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b9a3e998b1921f7d1e3093f27d288ee1a121ba4b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b9a3e998b1921f7d1e3093f27d288ee1a121ba4b",
"title": "b9a3e998b1921f7d1e3093f27d288ee1a121ba4b",
"url": "https://llvm.googlesource.com/llvm-project/+/b9a3e998b1921f7d1e3093f27d288ee1a121ba4b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "23e92c985de96ec2f06be1c94228ad5dff2d9097"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@23e92c985de96ec2f06be1c94228ad5dff2d9097",
"title": "23e92c985de96ec2f06be1c94228ad5dff2d9097",
"url": "https://llvm.googlesource.com/llvm-project/+/23e92c985de96ec2f06be1c94228ad5dff2d9097"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7491ff74d2b99c0e5e879ec7fd370fe9654528c4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7491ff74d2b99c0e5e879ec7fd370fe9654528c4",
"title": "7491ff74d2b99c0e5e879ec7fd370fe9654528c4",
"url": "https://llvm.googlesource.com/llvm-project/+/7491ff74d2b99c0e5e879ec7fd370fe9654528c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3633de702985e1580d72223ae38a31d0e6fd480b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3633de702985e1580d72223ae38a31d0e6fd480b",
"title": "3633de702985e1580d72223ae38a31d0e6fd480b",
"url": "https://llvm.googlesource.com/llvm-project/+/3633de702985e1580d72223ae38a31d0e6fd480b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "15932624537ddba61efae19c9af212d3e47a4c21"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@15932624537ddba61efae19c9af212d3e47a4c21",
"title": "15932624537ddba61efae19c9af212d3e47a4c21",
"url": "https://llvm.googlesource.com/llvm-project/+/15932624537ddba61efae19c9af212d3e47a4c21"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8fe5ac896f049020c739769c5186b472c639fd30"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8fe5ac896f049020c739769c5186b472c639fd30",
"title": "8fe5ac896f049020c739769c5186b472c639fd30",
"url": "https://llvm.googlesource.com/llvm-project/+/8fe5ac896f049020c739769c5186b472c639fd30"
},
{
"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"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9cdc3aab3eae55be30003cb486f290f3ee3df3a8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882996836385719472"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-clang-ci-trigger-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:38:08.708] Scheduled build:
{
"id": "8717566773927528161",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-15T00:38:08.356678635Z",
"updateTime": "2025-04-15T00:38:08.356678635Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9cdc3aab3eae55be30003cb486f290f3ee3df3a8",
"ref": "refs/heads/main"
}
}
}
[00:38:08.708] Task URL: https://cr-buildbucket.appspot.com/build/8717566773927528161
[00:38:08.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:2:0) after 1m17s
[00:38:09.690] Received PubSub notification, asking Buildbucket for the build status
[00:38:09.707] Build status: SCHEDULED
[00:39:25.698] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:2:0)
[00:39:25.715] Build status: SCHEDULED
[00:39:25.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:4:0) after 6m22s
[00:45:47.752] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:4:0)
[00:45:47.775] Build status: SCHEDULED
[00:45:47.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:5:0) after 4m48s
[00:50:35.902] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:5:0)
[00:50:35.925] Build status: SCHEDULED
[00:50:35.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:6:0) after 5m44s
[00:56:19.929] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:6:0)
[00:56:19.947] Build status: SCHEDULED
[00:56:19.947] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:7:0) after 1m0s
[00:57:19.973] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:7:0)
[00:57:20.020] Build status: SCHEDULED
[00:57:20.020] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:8:0) after 9m0s
[01:06:20.042] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:8:0)
[01:06:20.074] Build status: SCHEDULED
[01:06:20.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:9:0) after 9m27s
[01:15:47.097] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:9:0)
[01:15:47.120] Build status: SCHEDULED
[01:15:47.120] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:10:0) after 1m15s
[01:17:02.156] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:10:0)
[01:17:02.205] Build status: SCHEDULED
[01:17:02.205] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:11:0) after 3m9s
[01:20:11.423] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:11:0)
[01:20:11.463] Build status: SCHEDULED
[01:20:11.463] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:12:0) after 3m44s
[01:23:56.073] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:12:0)
[01:23:56.092] Build status: SCHEDULED
[01:23:56.092] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:13:0) after 8m53s
[01:32:49.156] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:13:0)
[01:32:49.190] Build status: SCHEDULED
[01:32:49.193] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:14:0) after 1m47s
[01:34:36.345] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:14:0)
[01:34:36.368] Build status: STARTED
[01:34:36.368] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:15:0) after 8m50s
[01:34:50.127] Received PubSub notification, asking Buildbucket for the build status
[01:34:50.191] Build status: STARTED
[01:43:26.724] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:15:0)
[01:43:26.740] Build status: STARTED
[01:43:26.740] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:17:0) after 8m3s
[01:51:30.019] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:17:0)
[01:51:30.040] Build status: STARTED
[01:51:30.040] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:18:0) after 6m38s
[01:58:08.423] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:18:0)
[01:58:08.451] Build status: STARTED
[01:58:08.451] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:19:0) after 6m6s
[02:04:14.519] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:19:0)
[02:04:14.540] Build status: STARTED
[02:04:14.540] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:20:0) after 3m26s
[02:07:40.658] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:20:0)
[02:07:40.706] Build status: STARTED
[02:07:40.706] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:21:0) after 3m33s
[02:11:13.819] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:21:0)
[02:11:13.866] Build status: STARTED
[02:11:13.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:22:0) after 9m41s
[02:20:54.891] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:22:0)
[02:20:54.962] Build status: STARTED
[02:20:54.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:23:0) after 5m0s
[02:25:55.483] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:23:0)
[02:25:55.511] Build status: STARTED
[02:25:55.511] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:24:0) after 8m36s
[02:34:31.532] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:24:0)
[02:34:31.557] Build status: STARTED
[02:34:31.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:25:0) after 1m44s
[02:36:16.340] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:25:0)
[02:36:16.356] Build status: STARTED
[02:36:16.356] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:26:0) after 2m1s
[02:38:17.454] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:26:0)
[02:38:17.473] Build status: STARTED
[02:38:17.473] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882996836385719472:27:0) after 5m51s
[02:42:46.260] Received PubSub notification, asking Buildbucket for the build status
[02:42:46.280] Build:
{
"id": "8717566773927528161",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-15T00:38:08.356678635Z",
"startTime": "2025-04-15T01:33:56.596507540Z",
"endTime": "2025-04-15T02:42:46.001105598Z",
"updateTime": "2025-04-15T02:42:46.001105598Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9cdc3aab3eae55be30003cb486f290f3ee3df3a8",
"ref": "refs/heads/main"
}
}
}
[02:42:46.280] Invocation finished in 2h4m39.651579273s with status SUCCEEDED