[14:09:01.276] New invocation is queued and will start shortly
[14:09:03.370] Starting the invocation (attempt 1)
[14:09:03.418] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/f44b79ad9bc24e84eabbf104f8a99c948dbaf326"
[14:09:03.418] Popped gitiles commit info from properties and tags
[14:09:03.418] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:09:03.420] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:09:03.421] Buildbucket request:
{
"requestId": "8972908605941219296",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "cmake-linux-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8972908605941219296",
"job": "fuchsia/ci-cmake-linux-arm64-895bf645",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake",
"revision": "feeb9ae4ba8c162a84d9f7eb65ddde35eb9329a1"
},
"id": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/refs/heads/main@feeb9ae4ba8c162a84d9f7eb65ddde35eb9329a1",
"title": "feeb9ae4ba8c162a84d9f7eb65ddde35eb9329a1",
"url": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/feeb9ae4ba8c162a84d9f7eb65ddde35eb9329a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake",
"revision": "31ee3cd49d3fb27458cec92602e3240066d97c2c"
},
"id": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/refs/heads/main@31ee3cd49d3fb27458cec92602e3240066d97c2c",
"title": "31ee3cd49d3fb27458cec92602e3240066d97c2c",
"url": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/31ee3cd49d3fb27458cec92602e3240066d97c2c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake",
"revision": "7ba3a3290fb53d2874e8a355ae0a4d12c8191cfb"
},
"id": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/refs/heads/main@7ba3a3290fb53d2874e8a355ae0a4d12c8191cfb",
"title": "7ba3a3290fb53d2874e8a355ae0a4d12c8191cfb",
"url": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/7ba3a3290fb53d2874e8a355ae0a4d12c8191cfb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake",
"revision": "e73c8eaff20b33452db251ce1de1b1162b647178"
},
"id": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/refs/heads/main@e73c8eaff20b33452db251ce1de1b1162b647178",
"title": "e73c8eaff20b33452db251ce1de1b1162b647178",
"url": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/e73c8eaff20b33452db251ce1de1b1162b647178"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake",
"revision": "8b0ee799e4cefd4aa008e6f251504eb541773a70"
},
"id": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/refs/heads/main@8b0ee799e4cefd4aa008e6f251504eb541773a70",
"title": "8b0ee799e4cefd4aa008e6f251504eb541773a70",
"url": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/8b0ee799e4cefd4aa008e6f251504eb541773a70"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake",
"revision": "7a5b1b6010d9f3f2bf979a505eb4c698b994bf26"
},
"id": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/refs/heads/main@7a5b1b6010d9f3f2bf979a505eb4c698b994bf26",
"title": "7a5b1b6010d9f3f2bf979a505eb4c698b994bf26",
"url": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/7a5b1b6010d9f3f2bf979a505eb4c698b994bf26"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake",
"revision": "6a858138068f3b7ce9afc4628ebdd7fb63de6936"
},
"id": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/refs/heads/main@6a858138068f3b7ce9afc4628ebdd7fb63de6936",
"title": "6a858138068f3b7ce9afc4628ebdd7fb63de6936",
"url": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/6a858138068f3b7ce9afc4628ebdd7fb63de6936"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake",
"revision": "e1d49847069ff6319bb259bf4eb628111d2a1340"
},
"id": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/refs/heads/main@e1d49847069ff6319bb259bf4eb628111d2a1340",
"title": "e1d49847069ff6319bb259bf4eb628111d2a1340",
"url": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/e1d49847069ff6319bb259bf4eb628111d2a1340"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake",
"revision": "e781d92de56e0944b201ccb17ebb62117e05e1c2"
},
"id": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/refs/heads/main@e781d92de56e0944b201ccb17ebb62117e05e1c2",
"title": "e781d92de56e0944b201ccb17ebb62117e05e1c2",
"url": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/e781d92de56e0944b201ccb17ebb62117e05e1c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake",
"revision": "f44b79ad9bc24e84eabbf104f8a99c948dbaf326"
},
"id": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/refs/heads/main@f44b79ad9bc24e84eabbf104f8a99c948dbaf326",
"title": "f44b79ad9bc24e84eabbf104f8a99c948dbaf326",
"url": "https://fuchsia.googlesource.com/third_party/github.com/Kitware/CMake/+/f44b79ad9bc24e84eabbf104f8a99c948dbaf326"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/github.com/Kitware/CMake",
"id": "f44b79ad9bc24e84eabbf104f8a99c948dbaf326",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8972908605941219296"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/ci-cmake-linux-arm64-895bf645"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[14:09:04.187] Scheduled build:
{
"id": "8807478542773110977",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "cmake-linux-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2022-07-27T14:09:03.666298013Z",
"updateTime": "2022-07-27T14:09:03.666298013Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/github.com/Kitware/CMake",
"id": "f44b79ad9bc24e84eabbf104f8a99c948dbaf326",
"ref": "refs/heads/main"
}
}
}
[14:09:04.187] Task URL: https://cr-buildbucket.appspot.com/build/8807478542773110977
[14:09:04.187] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:2:0) after 2m53s
[14:11:57.204] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:2:0)
[14:11:57.371] Build status: SCHEDULED
[14:11:57.371] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:3:0) after 7m17s
[14:19:14.440] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:3:0)
[14:19:14.471] Build status: SCHEDULED
[14:19:14.471] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:4:0) after 9m17s
[14:28:31.732] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:4:0)
[14:28:31.771] Build status: SCHEDULED
[14:28:31.771] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:5:0) after 7m2s
[14:35:33.749] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:5:0)
[14:35:33.781] Build status: SCHEDULED
[14:35:33.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:6:0) after 1m26s
[14:36:59.802] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:6:0)
[14:36:59.834] Build status: SCHEDULED
[14:36:59.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:7:0) after 5m45s
[14:42:44.907] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:7:0)
[14:42:44.944] Build status: SCHEDULED
[14:42:44.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:8:0) after 8m42s
[14:51:26.963] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:8:0)
[14:51:26.999] Build status: SCHEDULED
[14:51:26.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:9:0) after 4m21s
[14:55:48.135] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:9:0)
[14:55:48.178] Build status: SCHEDULED
[14:55:48.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:10:0) after 1m45s
[14:57:33.224] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:10:0)
[14:57:33.261] Build status: SCHEDULED
[14:57:33.261] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:11:0) after 3m33s
[15:01:06.358] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:11:0)
[15:01:06.399] Build status: SCHEDULED
[15:01:06.399] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:12:0) after 7m56s
[15:09:02.558] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:12:0)
[15:09:02.752] Build status: SCHEDULED
[15:09:02.752] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:13:0) after 8m17s
[15:17:19.980] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:13:0)
[15:17:20.042] Build status: SCHEDULED
[15:17:20.042] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:14:0) after 4m14s
[15:21:34.467] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:14:0)
[15:21:34.502] Build status: SCHEDULED
[15:21:34.503] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:15:0) after 3m40s
[15:25:14.598] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:15:0)
[15:25:14.622] Build status: SCHEDULED
[15:25:14.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:16:0) after 4m43s
[15:29:57.734] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:16:0)
[15:29:57.770] Build status: SCHEDULED
[15:29:57.770] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:17:0) after 4m58s
[15:34:55.822] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:17:0)
[15:34:55.865] Build status: SCHEDULED
[15:34:55.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:18:0) after 9m52s
[15:44:47.884] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:18:0)
[15:44:47.937] Build status: SCHEDULED
[15:44:47.937] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:19:0) after 2m55s
[15:47:42.956] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:19:0)
[15:47:43.004] Build status: SCHEDULED
[15:47:43.004] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:20:0) after 7m2s
[15:54:45.318] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:20:0)
[15:54:45.353] Build status: SCHEDULED
[15:54:45.353] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:21:0) after 9m48s
[16:04:33.610] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:21:0)
[16:04:33.656] Build status: SCHEDULED
[16:04:33.656] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:22:0) after 7m29s
[16:04:42.309] Received PubSub notification, asking Buildbucket for the build status
[16:04:42.343] Build status: STARTED
[16:12:02.869] Handling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:22:0)
[16:12:02.903] Build status: STARTED
[16:12:02.903] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-cmake-linux-arm64-895bf645:8972908605941219296:24:0) after 6m44s
[16:14:38.666] Received PubSub notification, asking Buildbucket for the build status
[16:14:38.707] Build:
{
"id": "8807478542773110977",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "cmake-linux-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2022-07-27T14:09:03.666298013Z",
"startTime": "2022-07-27T16:04:40.898459Z",
"endTime": "2022-07-27T16:14:38.274950623Z",
"updateTime": "2022-07-27T16:14:38.274950623Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/github.com/Kitware/CMake",
"id": "f44b79ad9bc24e84eabbf104f8a99c948dbaf326",
"ref": "refs/heads/main"
}
}
}
[16:14:38.707] Invocation finished in 2h5m37.445805343s with status SUCCEEDED