[12:19:08.878] New invocation is queued and will start shortly
[12:19:10.056] Starting the invocation (attempt 1)
[12:19:10.086] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/fbd643fb22607b933a4e129ae86a7334b62c9b55"
[12:19:10.086] Popped gitiles commit info from properties and tags
[12:19:10.086] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:19:10.087] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:19:10.087] Buildbucket request:
{
"requestId": "8912577938950075472",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8912577938950075472",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "964079d6501af7073e4420a221511b3067130ac4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@964079d6501af7073e4420a221511b3067130ac4",
"title": "964079d6501af7073e4420a221511b3067130ac4",
"url": "https://llvm.googlesource.com/llvm-project/+/964079d6501af7073e4420a221511b3067130ac4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b6468766f73e7a294fce71da60b9ec90f3900281"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b6468766f73e7a294fce71da60b9ec90f3900281",
"title": "b6468766f73e7a294fce71da60b9ec90f3900281",
"url": "https://llvm.googlesource.com/llvm-project/+/b6468766f73e7a294fce71da60b9ec90f3900281"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1d0e8b24001d854a848a3810b90244a6bc94cf03"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1d0e8b24001d854a848a3810b90244a6bc94cf03",
"title": "1d0e8b24001d854a848a3810b90244a6bc94cf03",
"url": "https://llvm.googlesource.com/llvm-project/+/1d0e8b24001d854a848a3810b90244a6bc94cf03"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "55e5842385ef18eaf7b5b6548413f4ee6f555dfc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@55e5842385ef18eaf7b5b6548413f4ee6f555dfc",
"title": "55e5842385ef18eaf7b5b6548413f4ee6f555dfc",
"url": "https://llvm.googlesource.com/llvm-project/+/55e5842385ef18eaf7b5b6548413f4ee6f555dfc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "85b9826c34bbefb0bdd42697edfda7d5192c5d1e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@85b9826c34bbefb0bdd42697edfda7d5192c5d1e",
"title": "85b9826c34bbefb0bdd42697edfda7d5192c5d1e",
"url": "https://llvm.googlesource.com/llvm-project/+/85b9826c34bbefb0bdd42697edfda7d5192c5d1e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "27f53b266cbfcbc956687be45cb0fdc80667b98e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@27f53b266cbfcbc956687be45cb0fdc80667b98e",
"title": "27f53b266cbfcbc956687be45cb0fdc80667b98e",
"url": "https://llvm.googlesource.com/llvm-project/+/27f53b266cbfcbc956687be45cb0fdc80667b98e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4e0f8a4919b1920ed715ca19314e6b3e06a70763"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4e0f8a4919b1920ed715ca19314e6b3e06a70763",
"title": "4e0f8a4919b1920ed715ca19314e6b3e06a70763",
"url": "https://llvm.googlesource.com/llvm-project/+/4e0f8a4919b1920ed715ca19314e6b3e06a70763"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5b5af52bad647321d19476cea39293802fa3cfd3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5b5af52bad647321d19476cea39293802fa3cfd3",
"title": "5b5af52bad647321d19476cea39293802fa3cfd3",
"url": "https://llvm.googlesource.com/llvm-project/+/5b5af52bad647321d19476cea39293802fa3cfd3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "84729c9df30b29d5f4e903ad71235a6aa0c764d6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@84729c9df30b29d5f4e903ad71235a6aa0c764d6",
"title": "84729c9df30b29d5f4e903ad71235a6aa0c764d6",
"url": "https://llvm.googlesource.com/llvm-project/+/84729c9df30b29d5f4e903ad71235a6aa0c764d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fbd643fb22607b933a4e129ae86a7334b62c9b55"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fbd643fb22607b933a4e129ae86a7334b62c9b55",
"title": "fbd643fb22607b933a4e129ae86a7334b62c9b55",
"url": "https://llvm.googlesource.com/llvm-project/+/fbd643fb22607b933a4e129ae86a7334b62c9b55"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "fbd643fb22607b933a4e129ae86a7334b62c9b55",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8912577938950075472"
},
{
"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"
}
}
[12:19:10.547] Scheduled build:
{
"id": "8747147876954958465",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-23T12:19:10.148581881Z",
"updateTime": "2024-05-23T12:19:10.148581881Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "fbd643fb22607b933a4e129ae86a7334b62c9b55",
"ref": "refs/heads/main"
}
}
}
[12:19:10.547] Task URL: https://cr-buildbucket.appspot.com/build/8747147876954958465
[12:19:10.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:2:0) after 7m14s
[12:19:11.538] Received PubSub notification, asking Buildbucket for the build status
[12:19:11.580] Build status: SCHEDULED
[12:19:15.745] Received PubSub notification, asking Buildbucket for the build status
[12:19:15.789] Build status: STARTED
[12:26:24.967] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:2:0)
[12:26:24.984] Build status: STARTED
[12:26:24.984] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:5:0) after 4m46s
[12:31:11.096] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:5:0)
[12:31:11.173] Build status: STARTED
[12:31:11.173] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:6:0) after 8m0s
[12:39:11.287] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:6:0)
[12:39:11.314] Build status: STARTED
[12:39:11.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:7:0) after 1m2s
[12:40:13.328] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:7:0)
[12:40:13.374] Build status: STARTED
[12:40:13.374] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:8:0) after 4m32s
[12:44:45.394] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:8:0)
[12:44:45.418] Build status: STARTED
[12:44:45.418] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:9:0) after 4m16s
[12:49:01.493] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:9:0)
[12:49:01.557] Build status: STARTED
[12:49:01.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:10:0) after 3m8s
[12:52:09.550] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:10:0)
[12:52:09.587] Build status: STARTED
[12:52:09.587] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:11:0) after 9m46s
[13:01:55.649] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:11:0)
[13:01:55.682] Build status: STARTED
[13:01:55.682] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:12:0) after 1m32s
[13:03:27.719] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:12:0)
[13:03:27.774] Build status: STARTED
[13:03:27.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:13:0) after 2m1s
[13:05:28.891] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:13:0)
[13:05:28.955] Build status: STARTED
[13:05:28.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:14:0) after 7m39s
[13:13:08.025] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:14:0)
[13:13:08.048] Build status: STARTED
[13:13:08.048] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:15:0) after 4m13s
[13:17:21.132] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:15:0)
[13:17:21.163] Build status: STARTED
[13:17:21.163] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:16:0) after 2m38s
[13:19:59.135] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:16:0)
[13:19:59.158] Build status: STARTED
[13:19:59.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:17:0) after 3m48s
[13:23:47.137] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:17:0)
[13:23:47.197] Build status: STARTED
[13:23:47.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:18:0) after 2m4s
[13:25:51.214] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:18:0)
[13:25:51.241] Build status: STARTED
[13:25:51.241] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:19:0) after 6m37s
[13:32:28.305] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:19:0)
[13:32:28.334] Build status: STARTED
[13:32:28.334] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:20:0) after 5m33s
[13:38:01.378] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:20:0)
[13:38:01.402] Build status: STARTED
[13:38:01.402] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912577938950075472:21:0) after 1m47s
[13:38:49.534] Received PubSub notification, asking Buildbucket for the build status
[13:38:49.555] Build:
{
"id": "8747147876954958465",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-23T12:19:10.148581881Z",
"startTime": "2024-05-23T12:19:15.504771951Z",
"endTime": "2024-05-23T13:38:49.268967529Z",
"updateTime": "2024-05-23T13:38:49.268967529Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "fbd643fb22607b933a4e129ae86a7334b62c9b55",
"ref": "refs/heads/main"
}
}
}
[13:38:49.555] Invocation finished in 1h19m40.693598377s with status SUCCEEDED