[14:49:39.402] New invocation is queued and will start shortly
[14:49:40.555] Starting the invocation (attempt 1)
[14:49:40.583] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a3a9ba80337ec1b276a7571049eda6ea03276ea3"
[14:49:40.583] Popped gitiles commit info from properties and tags
[14:49:40.583] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:49:40.583] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:49:40.584] Buildbucket request:
{
"requestId": "8899431909621461616",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8899431909621461616",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b75f9f7b3af0c9a46398645089c996412feea36c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b75f9f7b3af0c9a46398645089c996412feea36c",
"title": "b75f9f7b3af0c9a46398645089c996412feea36c",
"url": "https://llvm.googlesource.com/llvm-project/+/b75f9f7b3af0c9a46398645089c996412feea36c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "732353303e423237b7d23695a0e516728e491da4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@732353303e423237b7d23695a0e516728e491da4",
"title": "732353303e423237b7d23695a0e516728e491da4",
"url": "https://llvm.googlesource.com/llvm-project/+/732353303e423237b7d23695a0e516728e491da4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "043f066a647334195da41d7f5fd2a8400d7e4c91"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@043f066a647334195da41d7f5fd2a8400d7e4c91",
"title": "043f066a647334195da41d7f5fd2a8400d7e4c91",
"url": "https://llvm.googlesource.com/llvm-project/+/043f066a647334195da41d7f5fd2a8400d7e4c91"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4d788814061a1003f577e293f2cd74b30223e050"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4d788814061a1003f577e293f2cd74b30223e050",
"title": "4d788814061a1003f577e293f2cd74b30223e050",
"url": "https://llvm.googlesource.com/llvm-project/+/4d788814061a1003f577e293f2cd74b30223e050"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "94eb97550a7d1ab081b1484f1d3cdb12abe2d5a6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@94eb97550a7d1ab081b1484f1d3cdb12abe2d5a6",
"title": "94eb97550a7d1ab081b1484f1d3cdb12abe2d5a6",
"url": "https://llvm.googlesource.com/llvm-project/+/94eb97550a7d1ab081b1484f1d3cdb12abe2d5a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e100e4afc90afd4e6b8c7f692a553beacd214539"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e100e4afc90afd4e6b8c7f692a553beacd214539",
"title": "e100e4afc90afd4e6b8c7f692a553beacd214539",
"url": "https://llvm.googlesource.com/llvm-project/+/e100e4afc90afd4e6b8c7f692a553beacd214539"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3c777f04f065dda5f0c80eaaef2a7f623ccc20ed"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3c777f04f065dda5f0c80eaaef2a7f623ccc20ed",
"title": "3c777f04f065dda5f0c80eaaef2a7f623ccc20ed",
"url": "https://llvm.googlesource.com/llvm-project/+/3c777f04f065dda5f0c80eaaef2a7f623ccc20ed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2f09c722d65584d1bb1e6e38d4d1026dfa68f2d4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2f09c722d65584d1bb1e6e38d4d1026dfa68f2d4",
"title": "2f09c722d65584d1bb1e6e38d4d1026dfa68f2d4",
"url": "https://llvm.googlesource.com/llvm-project/+/2f09c722d65584d1bb1e6e38d4d1026dfa68f2d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a061d4d5cedf8f4651a01ea2e8cf98bd8863bf0f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a061d4d5cedf8f4651a01ea2e8cf98bd8863bf0f",
"title": "a061d4d5cedf8f4651a01ea2e8cf98bd8863bf0f",
"url": "https://llvm.googlesource.com/llvm-project/+/a061d4d5cedf8f4651a01ea2e8cf98bd8863bf0f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5dca89c2d5ce30dfb3852122d8dc62915a1e449b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5dca89c2d5ce30dfb3852122d8dc62915a1e449b",
"title": "5dca89c2d5ce30dfb3852122d8dc62915a1e449b",
"url": "https://llvm.googlesource.com/llvm-project/+/5dca89c2d5ce30dfb3852122d8dc62915a1e449b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c5c27d8025561ea9ba09950d0673170e70eca281"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c5c27d8025561ea9ba09950d0673170e70eca281",
"title": "c5c27d8025561ea9ba09950d0673170e70eca281",
"url": "https://llvm.googlesource.com/llvm-project/+/c5c27d8025561ea9ba09950d0673170e70eca281"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d9c2256c97948b648cb17a3757660070be5987a6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d9c2256c97948b648cb17a3757660070be5987a6",
"title": "d9c2256c97948b648cb17a3757660070be5987a6",
"url": "https://llvm.googlesource.com/llvm-project/+/d9c2256c97948b648cb17a3757660070be5987a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3c2e1d3a0014f3d659c29f1defce0674f6f755c0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3c2e1d3a0014f3d659c29f1defce0674f6f755c0",
"title": "3c2e1d3a0014f3d659c29f1defce0674f6f755c0",
"url": "https://llvm.googlesource.com/llvm-project/+/3c2e1d3a0014f3d659c29f1defce0674f6f755c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b43cfa7e45dfd252dcf8de6a753558e698a216d2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b43cfa7e45dfd252dcf8de6a753558e698a216d2",
"title": "b43cfa7e45dfd252dcf8de6a753558e698a216d2",
"url": "https://llvm.googlesource.com/llvm-project/+/b43cfa7e45dfd252dcf8de6a753558e698a216d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a7b7af7ad5c45fba87d9b423752601865cdfbee2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a7b7af7ad5c45fba87d9b423752601865cdfbee2",
"title": "a7b7af7ad5c45fba87d9b423752601865cdfbee2",
"url": "https://llvm.googlesource.com/llvm-project/+/a7b7af7ad5c45fba87d9b423752601865cdfbee2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b3c687b4e920893f224b28ab8223f1559cb3e209"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b3c687b4e920893f224b28ab8223f1559cb3e209",
"title": "b3c687b4e920893f224b28ab8223f1559cb3e209",
"url": "https://llvm.googlesource.com/llvm-project/+/b3c687b4e920893f224b28ab8223f1559cb3e209"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "46f953d1d953c6d4100bc949c932ecfab613b929"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@46f953d1d953c6d4100bc949c932ecfab613b929",
"title": "46f953d1d953c6d4100bc949c932ecfab613b929",
"url": "https://llvm.googlesource.com/llvm-project/+/46f953d1d953c6d4100bc949c932ecfab613b929"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "64421eced2464d6fe7a9b0e83dbd6fae656796c8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@64421eced2464d6fe7a9b0e83dbd6fae656796c8",
"title": "64421eced2464d6fe7a9b0e83dbd6fae656796c8",
"url": "https://llvm.googlesource.com/llvm-project/+/64421eced2464d6fe7a9b0e83dbd6fae656796c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a3a9ba80337ec1b276a7571049eda6ea03276ea3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a3a9ba80337ec1b276a7571049eda6ea03276ea3",
"title": "a3a9ba80337ec1b276a7571049eda6ea03276ea3",
"url": "https://llvm.googlesource.com/llvm-project/+/a3a9ba80337ec1b276a7571049eda6ea03276ea3"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a3a9ba80337ec1b276a7571049eda6ea03276ea3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8899431909621461616"
},
{
"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"
}
}
[14:49:41.093] Scheduled build:
{
"id": "8734001847654433585",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-15T14:49:40.655890449Z",
"updateTime": "2024-10-15T14:49:40.655890449Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a3a9ba80337ec1b276a7571049eda6ea03276ea3",
"ref": "refs/heads/main"
}
}
}
[14:49:41.093] Task URL: https://cr-buildbucket.appspot.com/build/8734001847654433585
[14:49:41.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:2:0) after 5m10s
[14:49:41.996] Received PubSub notification, asking Buildbucket for the build status
[14:49:42.035] Build status: SCHEDULED
[14:49:45.685] Received PubSub notification, asking Buildbucket for the build status
[14:49:45.756] Build status: STARTED
[14:54:51.216] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:2:0)
[14:54:51.243] Build status: STARTED
[14:54:51.244] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:5:0) after 3m51s
[14:58:42.533] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:5:0)
[14:58:42.558] Build status: STARTED
[14:58:42.558] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:6:0) after 5m4s
[15:03:46.640] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:6:0)
[15:03:46.666] Build status: STARTED
[15:03:46.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:7:0) after 5m38s
[15:09:25.082] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:7:0)
[15:09:25.101] Build status: STARTED
[15:09:25.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:8:0) after 3m30s
[15:12:55.170] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:8:0)
[15:12:55.290] Build status: STARTED
[15:12:55.290] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:9:0) after 2m12s
[15:15:07.410] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:9:0)
[15:15:07.436] Build status: STARTED
[15:15:07.436] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:10:0) after 1m34s
[15:16:41.456] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:10:0)
[15:16:41.473] Build status: STARTED
[15:16:41.473] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:11:0) after 4m24s
[15:21:05.490] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:11:0)
[15:21:05.514] Build status: STARTED
[15:21:05.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:12:0) after 1m38s
[15:22:43.564] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:12:0)
[15:22:43.582] Build status: STARTED
[15:22:43.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:13:0) after 9m4s
[15:31:47.968] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:13:0)
[15:31:47.989] Build status: STARTED
[15:31:47.989] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:14:0) after 4m40s
[15:36:28.053] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:14:0)
[15:36:28.082] Build status: STARTED
[15:36:28.083] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:15:0) after 4m57s
[15:41:25.107] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:15:0)
[15:41:25.131] Build status: STARTED
[15:41:25.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:16:0) after 1m45s
[15:43:10.214] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:16:0)
[15:43:10.231] Build status: STARTED
[15:43:10.231] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:17:0) after 4m31s
[15:47:41.260] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:17:0)
[15:47:41.280] Build status: STARTED
[15:47:41.280] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:18:0) after 8m48s
[15:56:29.298] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:18:0)
[15:56:29.317] Build status: STARTED
[15:56:29.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:19:0) after 5m24s
[16:01:53.339] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:19:0)
[16:01:53.358] Build status: STARTED
[16:01:53.359] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8899431909621461616:20:0) after 8m52s
[16:09:54.433] Received PubSub notification, asking Buildbucket for the build status
[16:09:54.471] Build:
{
"id": "8734001847654433585",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-15T14:49:40.655890449Z",
"startTime": "2024-10-15T14:49:45.338861770Z",
"endTime": "2024-10-15T16:09:53.925009149Z",
"updateTime": "2024-10-15T16:09:53.925009149Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a3a9ba80337ec1b276a7571049eda6ea03276ea3",
"ref": "refs/heads/main"
}
}
}
[16:09:54.471] Invocation finished in 1h20m15.07536593s with status SUCCEEDED