[20:57:03.099] New invocation is queued and will start shortly
[20:57:04.470] Starting the invocation (attempt 1)
[20:57:04.497] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/04a44fef1ffc6f2a0f5ea042beebd4a84dd5fed6"
[20:57:04.497] Popped gitiles commit info from properties and tags
[20:57:04.497] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:57:04.497] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:57:04.498] Buildbucket request:
{
"requestId": "8873769853636817488",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8873769853636817488",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8b7dc4cadb622e2b4a13155bffa5cec8c8fb6b8b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8b7dc4cadb622e2b4a13155bffa5cec8c8fb6b8b",
"title": "8b7dc4cadb622e2b4a13155bffa5cec8c8fb6b8b",
"url": "https://llvm.googlesource.com/llvm-project/+/8b7dc4cadb622e2b4a13155bffa5cec8c8fb6b8b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "20d93536fccad1d1901c2182e789c5371a072c47"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@20d93536fccad1d1901c2182e789c5371a072c47",
"title": "20d93536fccad1d1901c2182e789c5371a072c47",
"url": "https://llvm.googlesource.com/llvm-project/+/20d93536fccad1d1901c2182e789c5371a072c47"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e77230424fec932b49f54165775e188be70ee75f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e77230424fec932b49f54165775e188be70ee75f",
"title": "e77230424fec932b49f54165775e188be70ee75f",
"url": "https://llvm.googlesource.com/llvm-project/+/e77230424fec932b49f54165775e188be70ee75f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8e6a05d4712c3e134737d1584da90854a72bd84d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8e6a05d4712c3e134737d1584da90854a72bd84d",
"title": "8e6a05d4712c3e134737d1584da90854a72bd84d",
"url": "https://llvm.googlesource.com/llvm-project/+/8e6a05d4712c3e134737d1584da90854a72bd84d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3df67e8a40671d53ab8f3f16ed3d16a4e8efc402"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3df67e8a40671d53ab8f3f16ed3d16a4e8efc402",
"title": "3df67e8a40671d53ab8f3f16ed3d16a4e8efc402",
"url": "https://llvm.googlesource.com/llvm-project/+/3df67e8a40671d53ab8f3f16ed3d16a4e8efc402"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "63c2b8a5b35f552e00f5458307f04ce9a6f4cfff"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@63c2b8a5b35f552e00f5458307f04ce9a6f4cfff",
"title": "63c2b8a5b35f552e00f5458307f04ce9a6f4cfff",
"url": "https://llvm.googlesource.com/llvm-project/+/63c2b8a5b35f552e00f5458307f04ce9a6f4cfff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f834b0c3a782379bded3dd8d835b36246a1583d0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f834b0c3a782379bded3dd8d835b36246a1583d0",
"title": "f834b0c3a782379bded3dd8d835b36246a1583d0",
"url": "https://llvm.googlesource.com/llvm-project/+/f834b0c3a782379bded3dd8d835b36246a1583d0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3f3d779ff84fa505c15cd94c484103b966a93ff8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3f3d779ff84fa505c15cd94c484103b966a93ff8",
"title": "3f3d779ff84fa505c15cd94c484103b966a93ff8",
"url": "https://llvm.googlesource.com/llvm-project/+/3f3d779ff84fa505c15cd94c484103b966a93ff8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bc19aedba2dec11d9366cf886c2efbcd662177fe"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bc19aedba2dec11d9366cf886c2efbcd662177fe",
"title": "bc19aedba2dec11d9366cf886c2efbcd662177fe",
"url": "https://llvm.googlesource.com/llvm-project/+/bc19aedba2dec11d9366cf886c2efbcd662177fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fd65b2097be4acae1cc5b718dcccb10b9aaf324c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fd65b2097be4acae1cc5b718dcccb10b9aaf324c",
"title": "fd65b2097be4acae1cc5b718dcccb10b9aaf324c",
"url": "https://llvm.googlesource.com/llvm-project/+/fd65b2097be4acae1cc5b718dcccb10b9aaf324c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2f8c926d6ed54d05f3998025b54d5c60191a508e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2f8c926d6ed54d05f3998025b54d5c60191a508e",
"title": "2f8c926d6ed54d05f3998025b54d5c60191a508e",
"url": "https://llvm.googlesource.com/llvm-project/+/2f8c926d6ed54d05f3998025b54d5c60191a508e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e5202027c525d45d607487fb0cf6d846466135e0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e5202027c525d45d607487fb0cf6d846466135e0",
"title": "e5202027c525d45d607487fb0cf6d846466135e0",
"url": "https://llvm.googlesource.com/llvm-project/+/e5202027c525d45d607487fb0cf6d846466135e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "057b1c27294983e4939788172e55133160c3a1e2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@057b1c27294983e4939788172e55133160c3a1e2",
"title": "057b1c27294983e4939788172e55133160c3a1e2",
"url": "https://llvm.googlesource.com/llvm-project/+/057b1c27294983e4939788172e55133160c3a1e2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "445006d3a94e00bf6aa4ac650852aff52f0ca3b1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@445006d3a94e00bf6aa4ac650852aff52f0ca3b1",
"title": "445006d3a94e00bf6aa4ac650852aff52f0ca3b1",
"url": "https://llvm.googlesource.com/llvm-project/+/445006d3a94e00bf6aa4ac650852aff52f0ca3b1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4df8f726087c68d6e654a76839c544b18e4ca70e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4df8f726087c68d6e654a76839c544b18e4ca70e",
"title": "4df8f726087c68d6e654a76839c544b18e4ca70e",
"url": "https://llvm.googlesource.com/llvm-project/+/4df8f726087c68d6e654a76839c544b18e4ca70e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c090ed53fb73f59cf221f5610430af8047758117"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c090ed53fb73f59cf221f5610430af8047758117",
"title": "c090ed53fb73f59cf221f5610430af8047758117",
"url": "https://llvm.googlesource.com/llvm-project/+/c090ed53fb73f59cf221f5610430af8047758117"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "284a5c2c0b97edddf255ea210f939203ad3d09f2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@284a5c2c0b97edddf255ea210f939203ad3d09f2",
"title": "284a5c2c0b97edddf255ea210f939203ad3d09f2",
"url": "https://llvm.googlesource.com/llvm-project/+/284a5c2c0b97edddf255ea210f939203ad3d09f2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3e1392fb4b6afa4e1b212d04fb4881656d846736"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3e1392fb4b6afa4e1b212d04fb4881656d846736",
"title": "3e1392fb4b6afa4e1b212d04fb4881656d846736",
"url": "https://llvm.googlesource.com/llvm-project/+/3e1392fb4b6afa4e1b212d04fb4881656d846736"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5ebdfe386e3bb9f959719f76a9ad689f843c2164"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5ebdfe386e3bb9f959719f76a9ad689f843c2164",
"title": "5ebdfe386e3bb9f959719f76a9ad689f843c2164",
"url": "https://llvm.googlesource.com/llvm-project/+/5ebdfe386e3bb9f959719f76a9ad689f843c2164"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "56ae79a6ab70ded92846e053b13745ea51e48089"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@56ae79a6ab70ded92846e053b13745ea51e48089",
"title": "56ae79a6ab70ded92846e053b13745ea51e48089",
"url": "https://llvm.googlesource.com/llvm-project/+/56ae79a6ab70ded92846e053b13745ea51e48089"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "64704c6346697efd1a981ff543f407303707b2b4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@64704c6346697efd1a981ff543f407303707b2b4",
"title": "64704c6346697efd1a981ff543f407303707b2b4",
"url": "https://llvm.googlesource.com/llvm-project/+/64704c6346697efd1a981ff543f407303707b2b4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6118a254ff9acb4b54a6bdb952c088a792b679af"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6118a254ff9acb4b54a6bdb952c088a792b679af",
"title": "6118a254ff9acb4b54a6bdb952c088a792b679af",
"url": "https://llvm.googlesource.com/llvm-project/+/6118a254ff9acb4b54a6bdb952c088a792b679af"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "34a08cb89c5e50c22be05555529ce84eaa3e4d3c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@34a08cb89c5e50c22be05555529ce84eaa3e4d3c",
"title": "34a08cb89c5e50c22be05555529ce84eaa3e4d3c",
"url": "https://llvm.googlesource.com/llvm-project/+/34a08cb89c5e50c22be05555529ce84eaa3e4d3c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "04a44fef1ffc6f2a0f5ea042beebd4a84dd5fed6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@04a44fef1ffc6f2a0f5ea042beebd4a84dd5fed6",
"title": "04a44fef1ffc6f2a0f5ea042beebd4a84dd5fed6",
"url": "https://llvm.googlesource.com/llvm-project/+/04a44fef1ffc6f2a0f5ea042beebd4a84dd5fed6"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "04a44fef1ffc6f2a0f5ea042beebd4a84dd5fed6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8873769853636817488"
},
{
"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"
}
}
[20:57:04.948] Scheduled build:
{
"id": "8708339791403930593",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-25T20:57:04.607220892Z",
"updateTime": "2025-07-25T20:57:04.607220892Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "04a44fef1ffc6f2a0f5ea042beebd4a84dd5fed6",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:57:04.948] Task URL: https://cr-buildbucket.appspot.com/build/8708339791403930593
[20:57:04.948] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:2:0) after 6m39s
[20:57:05.132] Received PubSub notification, asking Buildbucket for the build status
[20:57:05.189] Build status: SCHEDULED
[20:57:08.356] Received PubSub notification, asking Buildbucket for the build status
[20:57:08.380] Build status: STARTED
[21:03:44.030] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:2:0)
[21:03:44.065] Build status: STARTED
[21:03:44.065] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:5:0) after 5m14s
[21:08:58.235] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:5:0)
[21:08:58.258] Build status: STARTED
[21:08:58.258] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:6:0) after 4m54s
[21:13:52.350] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:6:0)
[21:13:52.376] Build status: STARTED
[21:13:52.376] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:7:0) after 6m59s
[21:20:51.440] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:7:0)
[21:20:51.493] Build status: STARTED
[21:20:51.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:8:0) after 4m11s
[21:25:02.582] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:8:0)
[21:25:02.606] Build status: STARTED
[21:25:02.606] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:9:0) after 9m21s
[21:34:23.681] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:9:0)
[21:34:23.699] Build status: STARTED
[21:34:23.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:10:0) after 8m8s
[21:42:31.800] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:10:0)
[21:42:32.094] Build status: STARTED
[21:42:32.094] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:11:0) after 6m2s
[21:48:34.204] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:11:0)
[21:48:34.296] Build status: STARTED
[21:48:34.296] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:12:0) after 5m1s
[21:53:35.314] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:12:0)
[21:53:35.336] Build status: STARTED
[21:53:35.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:13:0) after 2m11s
[21:55:46.455] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:13:0)
[21:55:46.476] Build status: STARTED
[21:55:46.476] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:14:0) after 4m20s
[22:00:06.584] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:14:0)
[22:00:06.739] Build status: STARTED
[22:00:06.739] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:15:0) after 4m37s
[22:04:43.764] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:15:0)
[22:04:43.791] Build status: STARTED
[22:04:43.791] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:16:0) after 1m6s
[22:05:49.819] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:16:0)
[22:05:49.833] Build status: STARTED
[22:05:49.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:17:0) after 2m27s
[22:08:16.867] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:17:0)
[22:08:16.893] Build status: STARTED
[22:08:16.893] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:18:0) after 5m9s
[22:13:26.023] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:18:0)
[22:13:26.043] Build status: STARTED
[22:13:26.043] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:19:0) after 7m20s
[22:20:46.065] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:19:0)
[22:20:46.083] Build status: STARTED
[22:20:46.083] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:20:0) after 1m48s
[22:22:34.108] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:20:0)
[22:22:34.137] Build status: STARTED
[22:22:34.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8873769853636817488:21:0) after 4m20s
[22:25:12.976] Received PubSub notification, asking Buildbucket for the build status
[22:25:12.998] Build:
{
"id": "8708339791403930593",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-25T20:57:04.607220892Z",
"startTime": "2025-07-25T20:57:08.081159378Z",
"endTime": "2025-07-25T22:25:12.242006642Z",
"updateTime": "2025-07-25T22:25:12.242006642Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "04a44fef1ffc6f2a0f5ea042beebd4a84dd5fed6",
"ref": "refs/heads/main"
}
},
"canary": true
}
[22:25:12.998] Invocation finished in 1h28m9.903860142s with status SUCCEEDED