[03:31:16.704] New invocation is queued and will start shortly
[03:31:16.704] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[03:31:17.753] Starting the invocation (attempt 1)
[03:31:17.781] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/1a740c381675940fce3ca4b125677928be736f0b"
[03:31:17.781] Reconstructed gitiles commit from tags
[03:31:17.781] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:31:17.781] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:31:17.782] Buildbucket request:
{
"requestId": "8929552782338160096",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "9240f399750ed119ad078a43cba4789ff0dd1295",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "787902c017102182172b14e203c94bee5947ab17611bb17997880a6faf4417dc/394"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8929552782338160096",
"job": "fuchsia/rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "9240f399750ed119ad078a43cba4789ff0dd1295",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "ec670a8b7cf7925ad2a31056d9a5e7d7f08cb67737f29a4e247dbac507376472/394"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "1a740c381675940fce3ca4b125677928be736f0b"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/1a740c381675940fce3ca4b125677928be736f0b",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "1ded17ba-9557-4603-bf0b-acb271c09cb2",
"title": "rust-x64-linux-bootstrap/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "9240f399750ed119ad078a43cba4789ff0dd1295",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "787902c017102182172b14e203c94bee5947ab17611bb17997880a6faf4417dc/394"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "1a740c381675940fce3ca4b125677928be736f0b"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/1a740c381675940fce3ca4b125677928be736f0b",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux",
"user_agent:recipe"
]
},
"id": "be446c2a-90d3-4494-a6f8-6a3e82a5eed7",
"title": "rust-x64-linux/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "1a740c381675940fce3ca4b125677928be736f0b"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "1a740c381675940fce3ca4b125677928be736f0b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8929552782338160096"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust_toolchain.core.x64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "rust-x64-linux"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:31:18.258] Scheduled build:
{
"id": "8764122720483380049",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-18T03:31:17.850852031Z",
"updateTime": "2023-11-18T03:31:17.850852031Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "1a740c381675940fce3ca4b125677928be736f0b",
"ref": "refs/heads/main"
}
}
}
[03:31:18.258] Task URL: https://cr-buildbucket.appspot.com/build/8764122720483380049
[03:31:18.258] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:2:0) after 6m26s
[03:31:19.180] Received PubSub notification, asking Buildbucket for the build status
[03:31:19.378] Build status: SCHEDULED
[03:31:20.249] Received PubSub notification, asking Buildbucket for the build status
[03:31:20.276] Build status: STARTED
[03:37:44.319] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:2:0)
[03:37:44.343] Build status: STARTED
[03:37:44.343] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:5:0) after 3m46s
[03:41:30.843] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:5:0)
[03:41:30.865] Build status: STARTED
[03:41:30.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:6:0) after 7m13s
[03:48:44.287] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:6:0)
[03:48:44.311] Build status: STARTED
[03:48:44.311] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:7:0) after 8m48s
[03:57:32.391] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:7:0)
[03:57:32.424] Build status: STARTED
[03:57:32.424] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:8:0) after 8m6s
[04:05:38.471] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:8:0)
[04:05:38.492] Build status: STARTED
[04:05:38.492] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:9:0) after 4m48s
[04:10:26.748] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:9:0)
[04:10:26.771] Build status: STARTED
[04:10:26.771] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:10:0) after 9m45s
[04:20:11.836] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:10:0)
[04:20:11.863] Build status: STARTED
[04:20:11.863] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:11:0) after 8m3s
[04:28:14.958] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:11:0)
[04:28:14.991] Build status: STARTED
[04:28:14.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:12:0) after 5m17s
[04:33:32.133] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:12:0)
[04:33:32.160] Build status: STARTED
[04:33:32.160] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:13:0) after 8m56s
[04:42:28.302] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:13:0)
[04:42:28.321] Build status: STARTED
[04:42:28.321] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:14:0) after 1m57s
[04:44:25.337] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:14:0)
[04:44:25.362] Build status: STARTED
[04:44:25.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:15:0) after 5m13s
[04:49:38.434] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:15:0)
[04:49:38.488] Build status: STARTED
[04:49:38.488] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:16:0) after 7m59s
[04:57:37.703] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:16:0)
[04:57:37.768] Build status: STARTED
[04:57:37.768] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:17:0) after 3m26s
[05:01:03.832] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:17:0)
[05:01:03.859] Build status: STARTED
[05:01:03.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:18:0) after 1m56s
[05:03:00.075] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:18:0)
[05:03:00.095] Build status: STARTED
[05:03:00.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8929552782338160096:19:0) after 4m37s
[05:03:23.234] Received PubSub notification, asking Buildbucket for the build status
[05:03:23.253] Build:
{
"id": "8764122720483380049",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-18T03:31:17.850852031Z",
"startTime": "2023-11-18T03:31:19.091050Z",
"endTime": "2023-11-18T05:03:22.470380Z",
"updateTime": "2023-11-18T05:03:22.470380Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "1a740c381675940fce3ca4b125677928be736f0b",
"ref": "refs/heads/main"
}
}
}
[05:03:23.253] Invocation finished in 1h32m6.555795066s with status SUCCEEDED