[09:46:53.236] New invocation is queued and will start shortly
[09:46:54.581] Starting the invocation (attempt 1)
[09:46:54.612] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d49776634e3c4bd62649e8e0fc0ff44951413c69"
[09:46:54.612] Popped gitiles commit info from properties and tags
[09:46:54.612] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:46:54.612] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:46:54.612] Buildbucket request:
{
"requestId": "8888126337431787840",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8888126337431787840",
"job": "fuchsia/clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "153dd19e3057169e6935027ffbc84b62b392aa35"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@153dd19e3057169e6935027ffbc84b62b392aa35",
"title": "153dd19e3057169e6935027ffbc84b62b392aa35",
"url": "https://llvm.googlesource.com/llvm-project/+/153dd19e3057169e6935027ffbc84b62b392aa35"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b16ce8fc24f32aa0614562de0a2d0916118398fb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b16ce8fc24f32aa0614562de0a2d0916118398fb",
"title": "b16ce8fc24f32aa0614562de0a2d0916118398fb",
"url": "https://llvm.googlesource.com/llvm-project/+/b16ce8fc24f32aa0614562de0a2d0916118398fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6684a5970e74b8b4c0c83361a90e25dae9646db0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6684a5970e74b8b4c0c83361a90e25dae9646db0",
"title": "6684a5970e74b8b4c0c83361a90e25dae9646db0",
"url": "https://llvm.googlesource.com/llvm-project/+/6684a5970e74b8b4c0c83361a90e25dae9646db0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "94585dc59de23c52274fc542df7b821c7e6bb326"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@94585dc59de23c52274fc542df7b821c7e6bb326",
"title": "94585dc59de23c52274fc542df7b821c7e6bb326",
"url": "https://llvm.googlesource.com/llvm-project/+/94585dc59de23c52274fc542df7b821c7e6bb326"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "948a8477c6a966ee8509400d2857706e933f4149"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@948a8477c6a966ee8509400d2857706e933f4149",
"title": "948a8477c6a966ee8509400d2857706e933f4149",
"url": "https://llvm.googlesource.com/llvm-project/+/948a8477c6a966ee8509400d2857706e933f4149"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ea7897a617b897f87f148db48cda9fcc7c1c53dc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ea7897a617b897f87f148db48cda9fcc7c1c53dc",
"title": "ea7897a617b897f87f148db48cda9fcc7c1c53dc",
"url": "https://llvm.googlesource.com/llvm-project/+/ea7897a617b897f87f148db48cda9fcc7c1c53dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e0545b5c6d54dcf3e3ef84cbf9695bb1aecd87db"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e0545b5c6d54dcf3e3ef84cbf9695bb1aecd87db",
"title": "e0545b5c6d54dcf3e3ef84cbf9695bb1aecd87db",
"url": "https://llvm.googlesource.com/llvm-project/+/e0545b5c6d54dcf3e3ef84cbf9695bb1aecd87db"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b9c6d3ed26789c33fc7f959198e4459ec4e1d3ac"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b9c6d3ed26789c33fc7f959198e4459ec4e1d3ac",
"title": "b9c6d3ed26789c33fc7f959198e4459ec4e1d3ac",
"url": "https://llvm.googlesource.com/llvm-project/+/b9c6d3ed26789c33fc7f959198e4459ec4e1d3ac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff4e21fccc439085f6381076a2ac7d9fa371ab29"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff4e21fccc439085f6381076a2ac7d9fa371ab29",
"title": "ff4e21fccc439085f6381076a2ac7d9fa371ab29",
"url": "https://llvm.googlesource.com/llvm-project/+/ff4e21fccc439085f6381076a2ac7d9fa371ab29"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fb14638817004dc96c9401d7f704d7e5cd0ef3fc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fb14638817004dc96c9401d7f704d7e5cd0ef3fc",
"title": "fb14638817004dc96c9401d7f704d7e5cd0ef3fc",
"url": "https://llvm.googlesource.com/llvm-project/+/fb14638817004dc96c9401d7f704d7e5cd0ef3fc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d49776634e3c4bd62649e8e0fc0ff44951413c69"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d49776634e3c4bd62649e8e0fc0ff44951413c69",
"title": "d49776634e3c4bd62649e8e0fc0ff44951413c69",
"url": "https://llvm.googlesource.com/llvm-project/+/d49776634e3c4bd62649e8e0fc0ff44951413c69"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d49776634e3c4bd62649e8e0fc0ff44951413c69",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8888126337431787840"
},
{
"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"
}
}
[09:46:55.071] Scheduled build:
{
"id": "8722696275263152913",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-17T09:46:54.677713335Z",
"updateTime": "2025-02-17T09:46:54.677713335Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d49776634e3c4bd62649e8e0fc0ff44951413c69",
"ref": "refs/heads/main"
}
}
}
[09:46:55.071] Task URL: https://cr-buildbucket.appspot.com/build/8722696275263152913
[09:46:55.071] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:2:0) after 5m15s
[09:46:56.107] Received PubSub notification, asking Buildbucket for the build status
[09:46:56.133] Build status: SCHEDULED
[09:47:00.810] Received PubSub notification, asking Buildbucket for the build status
[09:47:00.836] Build status: STARTED
[09:52:10.256] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:2:0)
[09:52:10.293] Build status: STARTED
[09:52:10.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:5:0) after 5m19s
[09:57:29.383] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:5:0)
[09:57:29.403] Build status: STARTED
[09:57:29.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:6:0) after 3m7s
[10:00:36.423] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:6:0)
[10:00:36.449] Build status: STARTED
[10:00:36.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:7:0) after 1m30s
[10:02:06.473] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:7:0)
[10:02:06.500] Build status: STARTED
[10:02:06.500] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:8:0) after 9m38s
[10:11:44.531] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:8:0)
[10:11:44.561] Build status: STARTED
[10:11:44.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:9:0) after 8m54s
[10:20:38.719] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:9:0)
[10:20:38.738] Build status: STARTED
[10:20:38.738] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:10:0) after 5m7s
[10:25:45.815] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:10:0)
[10:25:45.869] Build status: STARTED
[10:25:45.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:11:0) after 2m32s
[10:28:17.890] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:11:0)
[10:28:17.919] Build status: STARTED
[10:28:17.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:12:0) after 8m5s
[10:36:23.219] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:12:0)
[10:36:23.254] Build status: STARTED
[10:36:23.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:13:0) after 1m54s
[10:38:17.486] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:13:0)
[10:38:17.507] Build status: STARTED
[10:38:17.507] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:14:0) after 8m32s
[10:46:49.775] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:14:0)
[10:46:49.801] Build status: STARTED
[10:46:49.801] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:15:0) after 2m20s
[10:49:10.181] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:15:0)
[10:49:10.201] Build status: STARTED
[10:49:10.201] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:16:0) after 8m9s
[10:57:19.393] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:16:0)
[10:57:19.418] Build status: STARTED
[10:57:19.418] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:17:0) after 8m43s
[11:06:02.441] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:17:0)
[11:06:02.465] Build status: STARTED
[11:06:02.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:18:0) after 1m5s
[11:07:07.487] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:18:0)
[11:07:07.505] Build status: STARTED
[11:07:07.505] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:19:0) after 9m10s
[11:16:17.523] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:19:0)
[11:16:17.542] Build status: STARTED
[11:16:17.542] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888126337431787840:20:0) after 2m19s
[11:16:47.022] Received PubSub notification, asking Buildbucket for the build status
[11:16:47.050] Build:
{
"id": "8722696275263152913",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-17T09:46:54.677713335Z",
"startTime": "2025-02-17T09:47:00.509580046Z",
"endTime": "2025-02-17T11:16:46.750037916Z",
"updateTime": "2025-02-17T11:16:46.750037916Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d49776634e3c4bd62649e8e0fc0ff44951413c69",
"ref": "refs/heads/main"
}
}
}
[11:16:47.050] Invocation finished in 1h29m53.824274473s with status SUCCEEDED