[02:06:55.279] New invocation is queued and will start shortly
[02:06:55.279] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[02:06:56.375] Starting the invocation (attempt 1)
[02:06:56.403] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/bfe5e8cef698ccc4fca655b4cdbabf78fed43816"
[02:06:56.403] Reconstructed gitiles commit from tags
[02:06:56.403] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:06:56.403] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:06:56.404] Buildbucket request:
{
"requestId": "8900657657350979328",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-release"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ee605b4958cc5268a7785c9e22576c966c9efee7",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "24358704605ba7447109c0b7d59faa46d3dae564bd04c0b00eb2f64e0a226647/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8900657657350979328",
"job": "fuchsia/rust_toolchain.core.x64-release",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ee605b4958cc5268a7785c9e22576c966c9efee7",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "20d587c74011b40d98555fa68d224f745e6bfcc56cb965e08bf673bab5938d35/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "bfe5e8cef698ccc4fca655b4cdbabf78fed43816"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/bfe5e8cef698ccc4fca655b4cdbabf78fed43816",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "b20b914a-bf5d-4125-90d0-9285d390c8da",
"title": "rust-x64-linux-bootstrap/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ee605b4958cc5268a7785c9e22576c966c9efee7",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "24358704605ba7447109c0b7d59faa46d3dae564bd04c0b00eb2f64e0a226647/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "bfe5e8cef698ccc4fca655b4cdbabf78fed43816"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/bfe5e8cef698ccc4fca655b4cdbabf78fed43816",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux",
"user_agent:recipe"
]
},
"id": "38b8b6b3-362d-4176-a000-3cbc5c53d8af",
"title": "rust-x64-linux/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "bfe5e8cef698ccc4fca655b4cdbabf78fed43816"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "bfe5e8cef698ccc4fca655b4cdbabf78fed43816",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8900657657350979328"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust_toolchain.core.x64-release"
},
{
"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"
}
}
[02:06:56.955] Scheduled build:
{
"id": "8735227595453025057",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-02T02:06:56.461288460Z",
"updateTime": "2024-10-02T02:06:56.461288460Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "bfe5e8cef698ccc4fca655b4cdbabf78fed43816",
"ref": "refs/heads/main"
}
}
}
[02:06:56.955] Task URL: https://cr-buildbucket.appspot.com/build/8735227595453025057
[02:06:56.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:2:0) after 2m44s
[02:07:07.649] Received PubSub notification, asking Buildbucket for the build status
[02:07:07.673] Build status: SCHEDULED
[02:07:29.140] Received PubSub notification, asking Buildbucket for the build status
[02:07:29.159] Build status: STARTED
[02:09:41.012] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:2:0)
[02:09:41.039] Build status: STARTED
[02:09:41.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:5:0) after 3m43s
[02:13:24.060] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:5:0)
[02:13:24.078] Build status: STARTED
[02:13:24.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:6:0) after 7m51s
[02:21:15.124] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:6:0)
[02:21:15.151] Build status: STARTED
[02:21:15.151] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:7:0) after 2m12s
[02:23:27.461] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:7:0)
[02:23:27.484] Build status: STARTED
[02:23:27.484] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:8:0) after 5m9s
[02:28:36.542] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:8:0)
[02:28:36.560] Build status: STARTED
[02:28:36.561] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:9:0) after 1m29s
[02:30:05.542] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:9:0)
[02:30:05.571] Build status: STARTED
[02:30:05.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:10:0) after 4m53s
[02:34:58.586] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:10:0)
[02:34:58.615] Build status: STARTED
[02:34:58.615] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:11:0) after 8m9s
[02:43:07.830] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:11:0)
[02:43:07.852] Build status: STARTED
[02:43:07.852] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:12:0) after 4m53s
[02:48:00.969] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:12:0)
[02:48:01.112] Build status: STARTED
[02:48:01.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:13:0) after 6m7s
[02:54:08.129] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:13:0)
[02:54:08.146] Build status: STARTED
[02:54:08.146] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:14:0) after 2m17s
[02:56:25.219] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:14:0)
[02:56:25.239] Build status: STARTED
[02:56:25.239] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:15:0) after 4m1s
[03:00:26.261] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:15:0)
[03:00:26.281] Build status: STARTED
[03:00:26.281] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:16:0) after 8m22s
[03:08:48.298] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:16:0)
[03:08:48.321] Build status: STARTED
[03:08:48.321] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:17:0) after 4m34s
[03:13:22.683] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:17:0)
[03:13:22.721] Build status: STARTED
[03:13:22.721] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:18:0) after 9m7s
[03:22:29.737] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:18:0)
[03:22:29.758] Build status: STARTED
[03:22:29.758] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:19:0) after 6m59s
[03:29:28.836] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:19:0)
[03:29:28.853] Build status: STARTED
[03:29:28.853] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:20:0) after 6m45s
[03:36:13.873] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:20:0)
[03:36:13.896] Build status: STARTED
[03:36:13.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:21:0) after 5m58s
[03:42:12.607] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:21:0)
[03:42:12.633] Build status: STARTED
[03:42:12.633] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:22:0) after 6m43s
[03:48:55.840] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:22:0)
[03:48:55.892] Build status: STARTED
[03:48:55.892] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:23:0) after 1m16s
[03:50:12.074] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:23:0)
[03:50:12.093] Build status: STARTED
[03:50:12.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:24:0) after 7m31s
[03:57:43.180] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:24:0)
[03:57:43.197] Build status: STARTED
[03:57:43.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:25:0) after 4m59s
[04:02:42.323] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:25:0)
[04:02:42.344] Build status: STARTED
[04:02:42.344] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-release:8900657657350979328:26:0) after 3m29s
[04:04:20.955] Received PubSub notification, asking Buildbucket for the build status
[04:04:20.979] Build:
{
"id": "8735227595453025057",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-02T02:06:56.461288460Z",
"startTime": "2024-10-02T02:07:08.751304652Z",
"endTime": "2024-10-02T04:04:20.300288208Z",
"updateTime": "2024-10-02T04:04:20.300288208Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "bfe5e8cef698ccc4fca655b4cdbabf78fed43816",
"ref": "refs/heads/main"
}
}
}
[04:04:20.979] Invocation finished in 1h57m25.712051322s with status SUCCEEDED