[10:12:21.768] New invocation is queued and will start shortly
[10:12:21.768] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[10:12:23.087] Starting the invocation (attempt 1)
[10:12:23.114] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b840d2968391dd610b792a65133a1edc1bcc397c"
[10:12:23.114] Reconstructed gitiles commit from tags
[10:12:23.114] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:12:23.115] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:12:23.115] Buildbucket request:
{
"requestId": "8922642178849159856",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "dccf845c9d26571e9d404bf6800a5d1dc654dd7d7ffab77454eb5d7217443151/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f1429dfbf6d2e35cd76b90fff48a26f0405861e0",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8922642178849159856",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "28441857ad2c58928ee753c54f2d4a86bdfcc27002752b2f31ed7e7aae9f0eeb/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f1429dfbf6d2e35cd76b90fff48a26f0405861e0",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "58ceefe09cd992c3692bb3af7c2807ac8949ba67"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/58ceefe09cd992c3692bb3af7c2807ac8949ba67",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "77ad6299-eff2-439c-9ef9-cac381c0cdb9",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "c69374ca1b422a04833196a4fb54ea543c985801f7b9c59f9989c2eb172de889/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f1429dfbf6d2e35cd76b90fff48a26f0405861e0",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "75c4339ef31922bf8c883a7a5dfe638ec6818ab2"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/75c4339ef31922bf8c883a7a5dfe638ec6818ab2",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "ab7f6da4-ded4-4827-be61-ae72bd9237ea",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "dccf845c9d26571e9d404bf6800a5d1dc654dd7d7ffab77454eb5d7217443151/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f1429dfbf6d2e35cd76b90fff48a26f0405861e0",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "b840d2968391dd610b792a65133a1edc1bcc397c"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b840d2968391dd610b792a65133a1edc1bcc397c",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "1bf7b526-4233-4f6d-985f-c3e65461cbbf",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "b840d2968391dd610b792a65133a1edc1bcc397c"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b840d2968391dd610b792a65133a1edc1bcc397c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8922642178849159856"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.x64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "clang-linux-x64"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[10:12:23.614] Scheduled build:
{
"id": "8757212116710576289",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-02T10:12:23.179471881Z",
"updateTime": "2024-02-02T10:12:23.179471881Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b840d2968391dd610b792a65133a1edc1bcc397c",
"ref": "refs/heads/main"
}
}
}
[10:12:23.614] Task URL: https://cr-buildbucket.appspot.com/build/8757212116710576289
[10:12:23.614] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:2:0) after 5m14s
[10:12:24.482] Received PubSub notification, asking Buildbucket for the build status
[10:12:24.510] Build status: SCHEDULED
[10:12:24.660] Received PubSub notification, asking Buildbucket for the build status
[10:12:24.678] Build status: STARTED
[10:17:37.706] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:2:0)
[10:17:37.734] Build status: STARTED
[10:17:37.734] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:5:0) after 1m33s
[10:19:10.747] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:5:0)
[10:19:10.766] Build status: STARTED
[10:19:10.766] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:6:0) after 9m26s
[10:28:36.818] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:6:0)
[10:28:36.837] Build status: STARTED
[10:28:36.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:7:0) after 6m30s
[10:35:07.159] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:7:0)
[10:35:07.183] Build status: STARTED
[10:35:07.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:8:0) after 4m54s
[10:40:01.203] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:8:0)
[10:40:01.221] Build status: STARTED
[10:40:01.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:9:0) after 1m12s
[10:41:13.239] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:9:0)
[10:41:13.320] Build status: STARTED
[10:41:13.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:10:0) after 5m51s
[10:47:04.337] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:10:0)
[10:47:04.358] Build status: STARTED
[10:47:04.358] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:11:0) after 9m28s
[10:56:32.375] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:11:0)
[10:56:32.393] Build status: STARTED
[10:56:32.393] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:12:0) after 9m0s
[11:05:32.606] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:12:0)
[11:05:32.629] Build status: STARTED
[11:05:32.629] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:13:0) after 9m43s
[11:15:15.747] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:13:0)
[11:15:15.770] Build status: STARTED
[11:15:15.770] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:14:0) after 5m49s
[11:21:05.443] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:14:0)
[11:21:05.459] Build status: STARTED
[11:21:05.459] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:15:0) after 1m53s
[11:22:58.564] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:15:0)
[11:22:58.654] Build status: STARTED
[11:22:58.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:16:0) after 6m10s
[11:29:08.687] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:16:0)
[11:29:08.715] Build status: STARTED
[11:29:08.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:17:0) after 8m45s
[11:37:54.024] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:17:0)
[11:37:54.047] Build status: STARTED
[11:37:54.047] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:18:0) after 8m28s
[11:46:22.086] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:18:0)
[11:46:22.138] Build status: STARTED
[11:46:22.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:19:0) after 3m25s
[11:49:47.206] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:19:0)
[11:49:47.248] Build status: STARTED
[11:49:47.248] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:20:0) after 5m24s
[11:55:11.423] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:20:0)
[11:55:11.452] Build status: STARTED
[11:55:11.452] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:21:0) after 8m13s
[12:03:24.487] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:21:0)
[12:03:24.510] Build status: STARTED
[12:03:24.510] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:22:0) after 2m5s
[12:05:29.602] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:22:0)
[12:05:29.630] Build status: STARTED
[12:05:29.630] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:23:0) after 1m22s
[12:06:51.655] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:23:0)
[12:06:51.676] Build status: STARTED
[12:06:51.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922642178849159856:24:0) after 9m49s
[12:09:26.704] Received PubSub notification, asking Buildbucket for the build status
[12:09:26.734] Build:
{
"id": "8757212116710576289",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-02T10:12:23.179471881Z",
"startTime": "2024-02-02T10:12:24.161178Z",
"endTime": "2024-02-02T12:09:24.571504Z",
"updateTime": "2024-02-02T12:09:24.571504Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b840d2968391dd610b792a65133a1edc1bcc397c",
"ref": "refs/heads/main"
}
}
}
[12:09:26.734] Invocation finished in 1h57m4.978162544s with status SUCCEEDED