[07:37:17.469] New invocation is queued and will start shortly
[07:37:17.469] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[07:37:21.808] Starting the invocation (attempt 1)
[07:37:21.831] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/d62f05b842d94d3bcad4d41d4b81df3949bad7c6"
[07:37:21.831] Reconstructed gitiles commit from tags
[07:37:21.832] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:37:21.832] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:37:21.832] Buildbucket request:
{
"requestId": "8925098053197861984",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "159c0b356e95b26d38c6e4f19c2c4719adb7919c",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "7bac875d920280cec1508223768c9649a2172aa9458c79a2f84c6909ae9cf858/394"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8925098053197861984",
"job": "fuchsia/rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "159c0b356e95b26d38c6e4f19c2c4719adb7919c",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "43bdc34bfc6a7e74083edf2fd24608334ae2cef12b4eac242600acd9a57ceeec/394"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "d62f05b842d94d3bcad4d41d4b81df3949bad7c6"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/d62f05b842d94d3bcad4d41d4b81df3949bad7c6",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "2582005e-c2c3-44be-8fa5-5e5413b41fcd",
"title": "rust-x64-linux-bootstrap/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "159c0b356e95b26d38c6e4f19c2c4719adb7919c",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "7bac875d920280cec1508223768c9649a2172aa9458c79a2f84c6909ae9cf858/394"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "d62f05b842d94d3bcad4d41d4b81df3949bad7c6"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/d62f05b842d94d3bcad4d41d4b81df3949bad7c6",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux",
"user_agent:recipe"
]
},
"id": "6deb2114-5a16-4221-9922-5d92b251cba1",
"title": "rust-x64-linux/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "d62f05b842d94d3bcad4d41d4b81df3949bad7c6"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "d62f05b842d94d3bcad4d41d4b81df3949bad7c6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8925098053197861984"
},
{
"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"
}
}
[07:37:22.392] Scheduled build:
{
"id": "8759667987917008721",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-06T07:37:21.885185458Z",
"updateTime": "2024-01-06T07:37:21.885185458Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "d62f05b842d94d3bcad4d41d4b81df3949bad7c6",
"ref": "refs/heads/main"
}
}
}
[07:37:22.392] Task URL: https://cr-buildbucket.appspot.com/build/8759667987917008721
[07:37:22.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:2:0) after 9m48s
[07:37:23.371] Received PubSub notification, asking Buildbucket for the build status
[07:37:23.389] Build status: SCHEDULED
[07:37:27.528] Received PubSub notification, asking Buildbucket for the build status
[07:37:27.638] Build status: STARTED
[07:47:11.403] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:2:0)
[07:47:11.424] Build status: STARTED
[07:47:11.424] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:5:0) after 7m33s
[07:54:44.514] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:5:0)
[07:54:44.570] Build status: STARTED
[07:54:44.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:6:0) after 1m17s
[07:56:01.791] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:6:0)
[07:56:01.822] Build status: STARTED
[07:56:01.822] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:7:0) after 4m49s
[08:00:50.850] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:7:0)
[08:00:50.869] Build status: STARTED
[08:00:50.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:8:0) after 3m34s
[08:04:24.915] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:8:0)
[08:04:24.951] Build status: STARTED
[08:04:24.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:9:0) after 4m55s
[08:09:19.973] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:9:0)
[08:09:19.998] Build status: STARTED
[08:09:19.998] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:10:0) after 6m53s
[08:16:13.013] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:10:0)
[08:16:13.044] Build status: STARTED
[08:16:13.044] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:11:0) after 4m59s
[08:21:12.188] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:11:0)
[08:21:12.327] Build status: STARTED
[08:21:12.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:12:0) after 6m28s
[08:27:40.443] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:12:0)
[08:27:40.458] Build status: STARTED
[08:27:40.458] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:13:0) after 9m10s
[08:36:50.470] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:13:0)
[08:36:50.512] Build status: STARTED
[08:36:50.512] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:14:0) after 9m54s
[08:46:44.526] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:14:0)
[08:46:44.547] Build status: STARTED
[08:46:44.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:15:0) after 5m35s
[08:52:19.605] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:15:0)
[08:52:19.623] Build status: STARTED
[08:52:19.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:16:0) after 9m2s
[09:01:21.669] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:16:0)
[09:01:21.753] Build status: STARTED
[09:01:21.753] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:17:0) after 1m58s
[09:03:20.180] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:17:0)
[09:03:20.288] Build status: STARTED
[09:03:20.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:18:0) after 4m24s
[09:07:44.344] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:18:0)
[09:07:44.403] Build status: STARTED
[09:07:44.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8925098053197861984:19:0) after 5m43s
[09:10:53.614] Received PubSub notification, asking Buildbucket for the build status
[09:10:53.630] Build:
{
"id": "8759667987917008721",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-06T07:37:21.885185458Z",
"startTime": "2024-01-06T07:37:26.830089Z",
"endTime": "2024-01-06T09:10:51.513112Z",
"updateTime": "2024-01-06T09:10:51.513112Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "d62f05b842d94d3bcad4d41d4b81df3949bad7c6",
"ref": "refs/heads/main"
}
}
}
[09:10:53.630] Invocation finished in 1h33m36.165305699s with status SUCCEEDED