[22:12:48.796] New invocation is queued and will start shortly
[22:12:49.966] Starting the invocation (attempt 1)
[22:12:49.996] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/270eb58631a277ece8c13398a089b9bff986cd50"
[22:12:49.996] Popped gitiles commit info from properties and tags
[22:12:49.996] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:12:49.996] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:12:49.996] Buildbucket request:
{
"requestId": "8936548784847814432",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8936548784847814432",
"job": "fuchsia/rust_test-x64-linux-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "cbe8a059034f87141761ebd2300c047e775fdf7b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@cbe8a059034f87141761ebd2300c047e775fdf7b",
"title": "cbe8a059034f87141761ebd2300c047e775fdf7b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/cbe8a059034f87141761ebd2300c047e775fdf7b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "efc759238d3fbf8ab6c30aa49706ab9097184f13"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@efc759238d3fbf8ab6c30aa49706ab9097184f13",
"title": "efc759238d3fbf8ab6c30aa49706ab9097184f13",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/efc759238d3fbf8ab6c30aa49706ab9097184f13"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "9adc6a49aa0aafa532c69cb842714cb74e865d57"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@9adc6a49aa0aafa532c69cb842714cb74e865d57",
"title": "9adc6a49aa0aafa532c69cb842714cb74e865d57",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/9adc6a49aa0aafa532c69cb842714cb74e865d57"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "62835c953190e7c6cadac1557156a47753a2a913"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@62835c953190e7c6cadac1557156a47753a2a913",
"title": "62835c953190e7c6cadac1557156a47753a2a913",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/62835c953190e7c6cadac1557156a47753a2a913"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "ba9af10846f31648891e89d7fdb06a77c63781c5"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@ba9af10846f31648891e89d7fdb06a77c63781c5",
"title": "ba9af10846f31648891e89d7fdb06a77c63781c5",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/ba9af10846f31648891e89d7fdb06a77c63781c5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "355ba433eed96e4bea83b361264521ce42f7bf1d"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@355ba433eed96e4bea83b361264521ce42f7bf1d",
"title": "355ba433eed96e4bea83b361264521ce42f7bf1d",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/355ba433eed96e4bea83b361264521ce42f7bf1d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "6e6031e094acb77bdf60d813fa8f748c12d8a3c9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@6e6031e094acb77bdf60d813fa8f748c12d8a3c9",
"title": "6e6031e094acb77bdf60d813fa8f748c12d8a3c9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/6e6031e094acb77bdf60d813fa8f748c12d8a3c9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "db6ae0721b59b698c3951ef62b11ba43fca8e9c1"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@db6ae0721b59b698c3951ef62b11ba43fca8e9c1",
"title": "db6ae0721b59b698c3951ef62b11ba43fca8e9c1",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/db6ae0721b59b698c3951ef62b11ba43fca8e9c1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "888dc2e3b0307199d7492498fb44ad036d9337c4"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@888dc2e3b0307199d7492498fb44ad036d9337c4",
"title": "888dc2e3b0307199d7492498fb44ad036d9337c4",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/888dc2e3b0307199d7492498fb44ad036d9337c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "cf24a9fdf69118ab324c595122b997ed698d629f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@cf24a9fdf69118ab324c595122b997ed698d629f",
"title": "cf24a9fdf69118ab324c595122b997ed698d629f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/cf24a9fdf69118ab324c595122b997ed698d629f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "db450d29814e8db1b736975dca931453502d6cd5"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@db450d29814e8db1b736975dca931453502d6cd5",
"title": "db450d29814e8db1b736975dca931453502d6cd5",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/db450d29814e8db1b736975dca931453502d6cd5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "ead5f80deb7e565cd583080e802887a71fd1fa8f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@ead5f80deb7e565cd583080e802887a71fd1fa8f",
"title": "ead5f80deb7e565cd583080e802887a71fd1fa8f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/ead5f80deb7e565cd583080e802887a71fd1fa8f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "270eb58631a277ece8c13398a089b9bff986cd50"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@270eb58631a277ece8c13398a089b9bff986cd50",
"title": "270eb58631a277ece8c13398a089b9bff986cd50",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/270eb58631a277ece8c13398a089b9bff986cd50"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "270eb58631a277ece8c13398a089b9bff986cd50",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8936548784847814432"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust_test-x64-linux-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:12:50.469] Scheduled build:
{
"id": "8771118722869651441",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-01T22:12:50.057692601Z",
"updateTime": "2023-09-01T22:12:50.057692601Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "270eb58631a277ece8c13398a089b9bff986cd50",
"ref": "refs/heads/main"
}
}
}
[22:12:50.469] Task URL: https://cr-buildbucket.appspot.com/build/8771118722869651441
[22:12:50.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:2:0) after 5m24s
[22:12:51.363] Received PubSub notification, asking Buildbucket for the build status
[22:12:51.406] Build status: SCHEDULED
[22:13:00.821] Received PubSub notification, asking Buildbucket for the build status
[22:13:00.845] Build status: STARTED
[22:18:14.572] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:2:0)
[22:18:14.596] Build status: STARTED
[22:18:14.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:5:0) after 7m53s
[22:26:07.751] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:5:0)
[22:26:07.780] Build status: STARTED
[22:26:07.780] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:6:0) after 1m20s
[22:27:27.845] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:6:0)
[22:27:27.865] Build status: STARTED
[22:27:27.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:7:0) after 2m41s
[22:30:08.878] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:7:0)
[22:30:08.897] Build status: STARTED
[22:30:08.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:8:0) after 6m22s
[22:36:30.920] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:8:0)
[22:36:30.941] Build status: STARTED
[22:36:30.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:9:0) after 3m22s
[22:39:53.008] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:9:0)
[22:39:53.042] Build status: STARTED
[22:39:53.042] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:10:0) after 3m25s
[22:43:18.070] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:10:0)
[22:43:18.096] Build status: STARTED
[22:43:18.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:11:0) after 5m1s
[22:48:19.203] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:11:0)
[22:48:19.387] Build status: STARTED
[22:48:19.387] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:12:0) after 3m33s
[22:51:52.537] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:12:0)
[22:51:52.562] Build status: STARTED
[22:51:52.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:13:0) after 7m24s
[22:59:16.792] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:13:0)
[22:59:16.851] Build status: STARTED
[22:59:16.851] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8936548784847814432:14:0) after 2m47s
[22:59:51.839] Received PubSub notification, asking Buildbucket for the build status
[22:59:51.860] Build:
{
"id": "8771118722869651441",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-01T22:12:50.057692601Z",
"startTime": "2023-09-01T22:12:59.748543Z",
"endTime": "2023-09-01T22:59:51.586894273Z",
"updateTime": "2023-09-01T22:59:51.586894273Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "270eb58631a277ece8c13398a089b9bff986cd50",
"ref": "refs/heads/main"
}
}
}
[22:59:51.860] Invocation finished in 47m3.073160151s with status FAILED