[00:37:22.108] New invocation is queued and will start shortly
[00:37:23.277] Starting the invocation (attempt 1)
[00:37:23.309] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2f55de4e317ee93cdca839558acf8be2b5ac2b46"
[00:37:23.309] Popped gitiles commit info from properties and tags
[00:37:23.309] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:37:23.309] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:37:23.310] Buildbucket request:
{
"requestId": "8896677025011489680",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8896677025011489680",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "44adc245d8e7e16b730fb247f3b8b47428e2864b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@44adc245d8e7e16b730fb247f3b8b47428e2864b",
"title": "44adc245d8e7e16b730fb247f3b8b47428e2864b",
"url": "https://llvm.googlesource.com/llvm-project/+/44adc245d8e7e16b730fb247f3b8b47428e2864b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0f0e2fe97b6c771b7a70964bf321ad91788e6a22"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0f0e2fe97b6c771b7a70964bf321ad91788e6a22",
"title": "0f0e2fe97b6c771b7a70964bf321ad91788e6a22",
"url": "https://llvm.googlesource.com/llvm-project/+/0f0e2fe97b6c771b7a70964bf321ad91788e6a22"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "abff8fe2a940212b1c43af2d86a68fc92849f019"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@abff8fe2a940212b1c43af2d86a68fc92849f019",
"title": "abff8fe2a940212b1c43af2d86a68fc92849f019",
"url": "https://llvm.googlesource.com/llvm-project/+/abff8fe2a940212b1c43af2d86a68fc92849f019"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aa81c28cd54ec6be370a3a04c8546e9b65a1e6a0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aa81c28cd54ec6be370a3a04c8546e9b65a1e6a0",
"title": "aa81c28cd54ec6be370a3a04c8546e9b65a1e6a0",
"url": "https://llvm.googlesource.com/llvm-project/+/aa81c28cd54ec6be370a3a04c8546e9b65a1e6a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b3134fa2338388adf8cfb2d77339d0b042eab9f6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b3134fa2338388adf8cfb2d77339d0b042eab9f6",
"title": "b3134fa2338388adf8cfb2d77339d0b042eab9f6",
"url": "https://llvm.googlesource.com/llvm-project/+/b3134fa2338388adf8cfb2d77339d0b042eab9f6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9c7701fa78037af03be10ed168fd3c75a2ed1aef"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9c7701fa78037af03be10ed168fd3c75a2ed1aef",
"title": "9c7701fa78037af03be10ed168fd3c75a2ed1aef",
"url": "https://llvm.googlesource.com/llvm-project/+/9c7701fa78037af03be10ed168fd3c75a2ed1aef"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d761b7485dbf0d951db34abcca270c405be1e93a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d761b7485dbf0d951db34abcca270c405be1e93a",
"title": "d761b7485dbf0d951db34abcca270c405be1e93a",
"url": "https://llvm.googlesource.com/llvm-project/+/d761b7485dbf0d951db34abcca270c405be1e93a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "59da1afd2ad74af2a8b8475412353c5d54a7d7f5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@59da1afd2ad74af2a8b8475412353c5d54a7d7f5",
"title": "59da1afd2ad74af2a8b8475412353c5d54a7d7f5",
"url": "https://llvm.googlesource.com/llvm-project/+/59da1afd2ad74af2a8b8475412353c5d54a7d7f5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3121f7522a0dc1463362cb6c11243d4352d4c857"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3121f7522a0dc1463362cb6c11243d4352d4c857",
"title": "3121f7522a0dc1463362cb6c11243d4352d4c857",
"url": "https://llvm.googlesource.com/llvm-project/+/3121f7522a0dc1463362cb6c11243d4352d4c857"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1857d297354fd307d2b30ff69036cc343d2fd692"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1857d297354fd307d2b30ff69036cc343d2fd692",
"title": "1857d297354fd307d2b30ff69036cc343d2fd692",
"url": "https://llvm.googlesource.com/llvm-project/+/1857d297354fd307d2b30ff69036cc343d2fd692"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eec21ccee0950d52926a79685573db1996e3ba5b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eec21ccee0950d52926a79685573db1996e3ba5b",
"title": "eec21ccee0950d52926a79685573db1996e3ba5b",
"url": "https://llvm.googlesource.com/llvm-project/+/eec21ccee0950d52926a79685573db1996e3ba5b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2f55de4e317ee93cdca839558acf8be2b5ac2b46"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2f55de4e317ee93cdca839558acf8be2b5ac2b46",
"title": "2f55de4e317ee93cdca839558acf8be2b5ac2b46",
"url": "https://llvm.googlesource.com/llvm-project/+/2f55de4e317ee93cdca839558acf8be2b5ac2b46"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2f55de4e317ee93cdca839558acf8be2b5ac2b46",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8896677025011489680"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:37:23.730] Scheduled build:
{
"id": "8731246963027765169",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-15T00:37:23.368078198Z",
"updateTime": "2024-11-15T00:37:23.368078198Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2f55de4e317ee93cdca839558acf8be2b5ac2b46",
"ref": "refs/heads/main"
}
}
}
[00:37:23.731] Task URL: https://cr-buildbucket.appspot.com/build/8731246963027765169
[00:37:23.731] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:2:0) after 1m15s
[00:37:31.067] Received PubSub notification, asking Buildbucket for the build status
[00:37:31.164] Build status: SCHEDULED
[00:38:38.749] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:2:0)
[00:38:38.776] Build status: SCHEDULED
[00:38:38.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:4:0) after 2m34s
[00:41:12.789] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:4:0)
[00:41:12.818] Build status: SCHEDULED
[00:41:12.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:5:0) after 5m28s
[00:46:40.943] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:5:0)
[00:46:40.967] Build status: SCHEDULED
[00:46:40.967] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:6:0) after 2m50s
[00:49:31.028] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:6:0)
[00:49:31.051] Build status: SCHEDULED
[00:49:31.051] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:7:0) after 2m19s
[00:51:50.068] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:7:0)
[00:51:50.085] Build status: SCHEDULED
[00:51:50.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:8:0) after 8m46s
[01:00:36.116] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:8:0)
[01:00:36.137] Build status: SCHEDULED
[01:00:36.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:9:0) after 5m16s
[01:01:08.642] Received PubSub notification, asking Buildbucket for the build status
[01:01:08.667] Build status: STARTED
[01:05:52.219] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:9:0)
[01:05:52.313] Build status: STARTED
[01:05:52.313] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:11:0) after 2m26s
[01:08:18.332] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:11:0)
[01:08:18.407] Build status: STARTED
[01:08:18.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:12:0) after 2m59s
[01:11:17.447] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:12:0)
[01:11:17.461] Build status: STARTED
[01:11:17.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:13:0) after 3m59s
[01:15:16.563] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:13:0)
[01:15:16.590] Build status: STARTED
[01:15:16.590] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:14:0) after 3m25s
[01:18:41.582] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:14:0)
[01:18:41.609] Build status: STARTED
[01:18:41.609] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:15:0) after 2m22s
[01:21:03.629] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:15:0)
[01:21:03.644] Build status: STARTED
[01:21:03.644] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:16:0) after 8m45s
[01:29:48.661] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:16:0)
[01:29:48.687] Build status: STARTED
[01:29:48.687] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:17:0) after 1m47s
[01:31:35.708] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:17:0)
[01:31:35.799] Build status: STARTED
[01:31:35.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:18:0) after 9m27s
[01:41:02.772] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:18:0)
[01:41:02.850] Build status: STARTED
[01:41:02.850] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:19:0) after 9m16s
[01:50:19.014] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:19:0)
[01:50:19.033] Build status: STARTED
[01:50:19.033] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:20:0) after 2m39s
[01:52:58.033] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:20:0)
[01:52:58.055] Build status: STARTED
[01:52:58.055] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:21:0) after 2m29s
[01:55:27.084] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:21:0)
[01:55:27.105] Build status: STARTED
[01:55:27.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:22:0) after 2m2s
[01:57:29.134] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:22:0)
[01:57:29.159] Build status: STARTED
[01:57:29.159] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:23:0) after 9m30s
[02:06:59.195] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:23:0)
[02:06:59.218] Build status: STARTED
[02:06:59.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:24:0) after 1m24s
[02:08:23.285] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:24:0)
[02:08:23.310] Build status: STARTED
[02:08:23.310] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:25:0) after 2m27s
[02:10:50.364] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:25:0)
[02:10:50.452] Build status: STARTED
[02:10:50.452] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8896677025011489680:26:0) after 8m8s
[02:16:47.871] Received PubSub notification, asking Buildbucket for the build status
[02:16:47.903] Build:
{
"id": "8731246963027765169",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-15T00:37:23.368078198Z",
"startTime": "2024-11-15T01:01:08.450109932Z",
"endTime": "2024-11-15T02:16:47.228956090Z",
"updateTime": "2024-11-15T02:16:47.228956090Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2f55de4e317ee93cdca839558acf8be2b5ac2b46",
"ref": "refs/heads/main"
}
}
}
[02:16:47.904] Invocation finished in 1h39m25.811526705s with status SUCCEEDED