[18:07:24.855] New invocation is queued and will start shortly
[18:07:26.972] Starting the invocation (attempt 1)
[18:07:26.999] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1f342f94b258bbf31efa2a6dc458229832fb5c6f"
[18:07:26.999] Popped gitiles commit info from properties and tags
[18:07:26.999] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:07:26.999] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:07:27.000] Buildbucket request:
{
"requestId": "8896157977007592192",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8896157977007592192",
"job": "fuchsia/clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9fb01fcd9fd5ccffa2421096e5e058156b86aa84"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9fb01fcd9fd5ccffa2421096e5e058156b86aa84",
"title": "9fb01fcd9fd5ccffa2421096e5e058156b86aa84",
"url": "https://llvm.googlesource.com/llvm-project/+/9fb01fcd9fd5ccffa2421096e5e058156b86aa84"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1b7f690a0b345f63020ef12e059f86240e6346b9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1b7f690a0b345f63020ef12e059f86240e6346b9",
"title": "1b7f690a0b345f63020ef12e059f86240e6346b9",
"url": "https://llvm.googlesource.com/llvm-project/+/1b7f690a0b345f63020ef12e059f86240e6346b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5bf017ca0c158316d9b060154a1e80304de970f3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5bf017ca0c158316d9b060154a1e80304de970f3",
"title": "5bf017ca0c158316d9b060154a1e80304de970f3",
"url": "https://llvm.googlesource.com/llvm-project/+/5bf017ca0c158316d9b060154a1e80304de970f3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f88c913f8aa1c2bb8e8636ccd9defcb7755a8a40"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f88c913f8aa1c2bb8e8636ccd9defcb7755a8a40",
"title": "f88c913f8aa1c2bb8e8636ccd9defcb7755a8a40",
"url": "https://llvm.googlesource.com/llvm-project/+/f88c913f8aa1c2bb8e8636ccd9defcb7755a8a40"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ab7201a8a39a94bf446f247c6be2602976fbbb5b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ab7201a8a39a94bf446f247c6be2602976fbbb5b",
"title": "ab7201a8a39a94bf446f247c6be2602976fbbb5b",
"url": "https://llvm.googlesource.com/llvm-project/+/ab7201a8a39a94bf446f247c6be2602976fbbb5b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4acba0697e7d8068927753f3bdabad478df91dc4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4acba0697e7d8068927753f3bdabad478df91dc4",
"title": "4acba0697e7d8068927753f3bdabad478df91dc4",
"url": "https://llvm.googlesource.com/llvm-project/+/4acba0697e7d8068927753f3bdabad478df91dc4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4b3b74dffa0aa76169cb67c3cb7ccf152c2c03aa"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4b3b74dffa0aa76169cb67c3cb7ccf152c2c03aa",
"title": "4b3b74dffa0aa76169cb67c3cb7ccf152c2c03aa",
"url": "https://llvm.googlesource.com/llvm-project/+/4b3b74dffa0aa76169cb67c3cb7ccf152c2c03aa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fb4ecada815ceee37536a26b4ff5ce231226b23e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fb4ecada815ceee37536a26b4ff5ce231226b23e",
"title": "fb4ecada815ceee37536a26b4ff5ce231226b23e",
"url": "https://llvm.googlesource.com/llvm-project/+/fb4ecada815ceee37536a26b4ff5ce231226b23e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e660e6503ba14684bd460b7baaf3da7336d0f46e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e660e6503ba14684bd460b7baaf3da7336d0f46e",
"title": "e660e6503ba14684bd460b7baaf3da7336d0f46e",
"url": "https://llvm.googlesource.com/llvm-project/+/e660e6503ba14684bd460b7baaf3da7336d0f46e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e2368afbd0d9b7e8fb900f54c8d71787e44d5774"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e2368afbd0d9b7e8fb900f54c8d71787e44d5774",
"title": "e2368afbd0d9b7e8fb900f54c8d71787e44d5774",
"url": "https://llvm.googlesource.com/llvm-project/+/e2368afbd0d9b7e8fb900f54c8d71787e44d5774"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fa9bcb4d9f47beaea0898d00f77971549603e25e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fa9bcb4d9f47beaea0898d00f77971549603e25e",
"title": "fa9bcb4d9f47beaea0898d00f77971549603e25e",
"url": "https://llvm.googlesource.com/llvm-project/+/fa9bcb4d9f47beaea0898d00f77971549603e25e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ae023f3499dda3975e6379bc4c0a8d097ac18f60"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ae023f3499dda3975e6379bc4c0a8d097ac18f60",
"title": "ae023f3499dda3975e6379bc4c0a8d097ac18f60",
"url": "https://llvm.googlesource.com/llvm-project/+/ae023f3499dda3975e6379bc4c0a8d097ac18f60"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ba7cc955662cfebb614c6a37a7341ba6072a0b70"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ba7cc955662cfebb614c6a37a7341ba6072a0b70",
"title": "ba7cc955662cfebb614c6a37a7341ba6072a0b70",
"url": "https://llvm.googlesource.com/llvm-project/+/ba7cc955662cfebb614c6a37a7341ba6072a0b70"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "81c2024311ab1f0a30c73df8d0957b86c5dac282"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@81c2024311ab1f0a30c73df8d0957b86c5dac282",
"title": "81c2024311ab1f0a30c73df8d0957b86c5dac282",
"url": "https://llvm.googlesource.com/llvm-project/+/81c2024311ab1f0a30c73df8d0957b86c5dac282"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0733f384142b02558b80b3e9a4633dc4d202a14b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0733f384142b02558b80b3e9a4633dc4d202a14b",
"title": "0733f384142b02558b80b3e9a4633dc4d202a14b",
"url": "https://llvm.googlesource.com/llvm-project/+/0733f384142b02558b80b3e9a4633dc4d202a14b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "81055ff070e128bff78c8fa2d8ffe4c92ae692a6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@81055ff070e128bff78c8fa2d8ffe4c92ae692a6",
"title": "81055ff070e128bff78c8fa2d8ffe4c92ae692a6",
"url": "https://llvm.googlesource.com/llvm-project/+/81055ff070e128bff78c8fa2d8ffe4c92ae692a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "74046855981bad2847c8f03114efd731da4d216c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@74046855981bad2847c8f03114efd731da4d216c",
"title": "74046855981bad2847c8f03114efd731da4d216c",
"url": "https://llvm.googlesource.com/llvm-project/+/74046855981bad2847c8f03114efd731da4d216c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8f8dcedb007c21412956208e524ff245c0ba5f58"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8f8dcedb007c21412956208e524ff245c0ba5f58",
"title": "8f8dcedb007c21412956208e524ff245c0ba5f58",
"url": "https://llvm.googlesource.com/llvm-project/+/8f8dcedb007c21412956208e524ff245c0ba5f58"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1f342f94b258bbf31efa2a6dc458229832fb5c6f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1f342f94b258bbf31efa2a6dc458229832fb5c6f",
"title": "1f342f94b258bbf31efa2a6dc458229832fb5c6f",
"url": "https://llvm.googlesource.com/llvm-project/+/1f342f94b258bbf31efa2a6dc458229832fb5c6f"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1f342f94b258bbf31efa2a6dc458229832fb5c6f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8896157977007592192"
},
{
"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"
}
}
[18:07:27.433] Scheduled build:
{
"id": "8730727914040543937",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-20T18:07:27.056886304Z",
"updateTime": "2024-11-20T18:07:27.056886304Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1f342f94b258bbf31efa2a6dc458229832fb5c6f",
"ref": "refs/heads/main"
}
}
}
[18:07:27.433] Task URL: https://cr-buildbucket.appspot.com/build/8730727914040543937
[18:07:27.433] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:2:0) after 7m28s
[18:07:29.596] Received PubSub notification, asking Buildbucket for the build status
[18:07:29.619] Build status: SCHEDULED
[18:07:49.545] Received PubSub notification, asking Buildbucket for the build status
[18:07:49.574] Build status: STARTED
[18:14:55.531] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:2:0)
[18:14:55.593] Build status: STARTED
[18:14:55.593] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:5:0) after 5m49s
[18:20:44.652] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:5:0)
[18:20:44.670] Build status: STARTED
[18:20:44.670] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:6:0) after 1m52s
[18:22:36.782] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:6:0)
[18:22:36.857] Build status: STARTED
[18:22:36.857] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:7:0) after 8m15s
[18:30:51.952] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:7:0)
[18:30:52.189] Build status: STARTED
[18:30:52.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:8:0) after 4m21s
[18:35:13.302] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:8:0)
[18:35:13.323] Build status: STARTED
[18:35:13.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:9:0) after 4m34s
[18:39:47.340] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:9:0)
[18:39:47.358] Build status: STARTED
[18:39:47.358] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:10:0) after 3m36s
[18:43:23.472] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:10:0)
[18:43:23.492] Build status: STARTED
[18:43:23.492] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:11:0) after 9m5s
[18:52:28.559] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:11:0)
[18:52:28.605] Build status: STARTED
[18:52:28.605] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:12:0) after 7m55s
[19:00:23.609] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:12:0)
[19:00:23.632] Build status: STARTED
[19:00:23.632] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:13:0) after 2m53s
[19:03:16.660] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:13:0)
[19:03:16.678] Build status: STARTED
[19:03:16.679] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:14:0) after 9m18s
[19:12:34.737] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:14:0)
[19:12:34.760] Build status: STARTED
[19:12:34.760] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:15:0) after 2m9s
[19:14:43.866] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:15:0)
[19:14:43.885] Build status: STARTED
[19:14:43.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8896157977007592192:16:0) after 5m42s
[19:15:34.641] Received PubSub notification, asking Buildbucket for the build status
[19:15:34.657] Build:
{
"id": "8730727914040543937",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-20T18:07:27.056886304Z",
"startTime": "2024-11-20T18:07:45.587679896Z",
"endTime": "2024-11-20T19:15:34.378074716Z",
"updateTime": "2024-11-20T19:15:34.378074716Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1f342f94b258bbf31efa2a6dc458229832fb5c6f",
"ref": "refs/heads/main"
}
}
}
[19:15:34.657] Invocation finished in 1h8m9.81335245s with status SUCCEEDED