[02:49:49.521] New invocation is queued and will start shortly
[02:49:49.521] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[02:49:50.904] Starting the invocation (attempt 1)
[02:49:50.928] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/ebcb862bbb9031c4969c06ec73d44780ea37d0ff"
[02:49:50.929] Reconstructed gitiles commit from tags
[02:49:50.929] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:49:50.929] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:49:50.929] Buildbucket request:
{
"requestId": "8910801818294578000",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "7df2377a1234b236c9f4bedff756c49b60806d0f",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "aee0bee3ec25386b1932503ba220a74d678c64421354506f65c73b1511618329/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8910801818294578000",
"job": "fuchsia/rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "7df2377a1234b236c9f4bedff756c49b60806d0f",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "c250b9afb8524cd6d116a4b041adc548f9cdd41fbb8ee910b58a687eb2f65d68/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "ebcb862bbb9031c4969c06ec73d44780ea37d0ff"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/ebcb862bbb9031c4969c06ec73d44780ea37d0ff",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux",
"user_agent:recipe"
]
},
"id": "4b1f929f-2a7a-4756-be71-14684eec3571",
"title": "rust-x64-linux/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "7df2377a1234b236c9f4bedff756c49b60806d0f",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "aee0bee3ec25386b1932503ba220a74d678c64421354506f65c73b1511618329/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "ebcb862bbb9031c4969c06ec73d44780ea37d0ff"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/ebcb862bbb9031c4969c06ec73d44780ea37d0ff",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "b9e6df49-b389-4935-8f56-9f230715de65",
"title": "rust-x64-linux-bootstrap/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "ebcb862bbb9031c4969c06ec73d44780ea37d0ff"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "ebcb862bbb9031c4969c06ec73d44780ea37d0ff",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8910801818294578000"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust_toolchain.core.x64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "rust-x64-linux-bootstrap"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:49:51.442] Scheduled build:
{
"id": "8745371756063297025",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-12T02:49:51.025887636Z",
"updateTime": "2024-06-12T02:49:51.025887636Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "ebcb862bbb9031c4969c06ec73d44780ea37d0ff",
"ref": "refs/heads/main"
}
}
}
[02:49:51.442] Task URL: https://cr-buildbucket.appspot.com/build/8745371756063297025
[02:49:51.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:2:0) after 7m5s
[02:49:52.430] Received PubSub notification, asking Buildbucket for the build status
[02:49:52.446] Build status: SCHEDULED
[02:49:56.953] Received PubSub notification, asking Buildbucket for the build status
[02:49:56.972] Build status: STARTED
[02:56:56.531] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:2:0)
[02:56:56.570] Build status: STARTED
[02:56:56.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:5:0) after 7m21s
[03:04:17.680] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:5:0)
[03:04:17.736] Build status: STARTED
[03:04:17.736] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:6:0) after 8m47s
[03:13:04.786] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:6:0)
[03:13:04.840] Build status: STARTED
[03:13:04.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:7:0) after 3m9s
[03:16:13.945] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:7:0)
[03:16:13.966] Build status: STARTED
[03:16:13.966] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:8:0) after 7m46s
[03:23:59.991] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:8:0)
[03:24:00.012] Build status: STARTED
[03:24:00.012] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:9:0) after 6m52s
[03:30:51.992] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:9:0)
[03:30:52.073] Build status: STARTED
[03:30:52.073] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:10:0) after 1m36s
[03:32:28.091] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:10:0)
[03:32:28.109] Build status: STARTED
[03:32:28.109] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:11:0) after 6m34s
[03:39:02.112] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:11:0)
[03:39:02.134] Build status: STARTED
[03:39:02.134] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:12:0) after 6m8s
[03:45:10.163] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:12:0)
[03:45:10.190] Build status: STARTED
[03:45:10.190] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:13:0) after 1m4s
[03:46:14.256] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:13:0)
[03:46:14.385] Build status: STARTED
[03:46:14.385] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:14:0) after 7m43s
[03:53:57.470] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:14:0)
[03:53:57.487] Build status: STARTED
[03:53:57.487] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:15:0) after 8m11s
[04:02:08.546] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:15:0)
[04:02:08.563] Build status: STARTED
[04:02:08.564] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:16:0) after 6m10s
[04:08:18.621] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:16:0)
[04:08:18.644] Build status: STARTED
[04:08:18.644] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:17:0) after 7m55s
[04:16:13.754] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:17:0)
[04:16:13.793] Build status: STARTED
[04:16:13.793] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:18:0) after 8m43s
[04:24:57.366] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:18:0)
[04:24:57.384] Build status: STARTED
[04:24:57.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:19:0) after 4m16s
[04:29:13.416] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:19:0)
[04:29:13.435] Build status: STARTED
[04:29:13.435] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:20:0) after 1m59s
[04:31:12.450] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:20:0)
[04:31:12.471] Build status: STARTED
[04:31:12.471] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:21:0) after 2m33s
[04:33:45.524] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:21:0)
[04:33:45.541] Build status: STARTED
[04:33:45.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:22:0) after 5m18s
[04:39:03.564] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:22:0)
[04:39:03.582] Build status: STARTED
[04:39:03.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:23:0) after 5m10s
[04:44:13.647] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:23:0)
[04:44:13.667] Build status: STARTED
[04:44:13.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:24:0) after 1m12s
[04:45:25.707] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:24:0)
[04:45:25.727] Build status: STARTED
[04:45:25.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8910801818294578000:25:0) after 3m17s
[04:46:32.993] Received PubSub notification, asking Buildbucket for the build status
[04:46:33.008] Build:
{
"id": "8745371756063297025",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-12T02:49:51.025887636Z",
"startTime": "2024-06-12T02:49:56.735100626Z",
"endTime": "2024-06-12T04:46:31.872492278Z",
"updateTime": "2024-06-12T04:46:31.872492278Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "ebcb862bbb9031c4969c06ec73d44780ea37d0ff",
"ref": "refs/heads/main"
}
}
}
[04:46:33.008] Invocation finished in 1h56m43.493855604s with status SUCCEEDED