[12:04:20.238] New invocation is queued and will start shortly
[12:04:21.306] Starting the invocation (attempt 1)
[12:04:21.329] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/c1373d8c6a06a1d3397568081a98cd39acfe42c4"
[12:04:21.329] Popped gitiles commit info from properties and tags
[12:04:21.329] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:04:21.329] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:04:21.329] Buildbucket request:
{
"requestId": "8856680542484467888",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-rust_determinism-build_only"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8856680542484467888",
"job": "fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6664d8c9343266f3dc684581790a502a3ddafe62"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6664d8c9343266f3dc684581790a502a3ddafe62",
"title": "6664d8c9343266f3dc684581790a502a3ddafe62",
"url": "https://fuchsia.googlesource.com/integration/+/6664d8c9343266f3dc684581790a502a3ddafe62"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "de8505e28fc0594850a5d83f3c23b36c6ce4ddc4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@de8505e28fc0594850a5d83f3c23b36c6ce4ddc4",
"title": "de8505e28fc0594850a5d83f3c23b36c6ce4ddc4",
"url": "https://fuchsia.googlesource.com/integration/+/de8505e28fc0594850a5d83f3c23b36c6ce4ddc4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6a503ba57f947de752f1a2aeeb3d4dba51e81aea"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6a503ba57f947de752f1a2aeeb3d4dba51e81aea",
"title": "6a503ba57f947de752f1a2aeeb3d4dba51e81aea",
"url": "https://fuchsia.googlesource.com/integration/+/6a503ba57f947de752f1a2aeeb3d4dba51e81aea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1e9dffc6684b31676169b5d5b5f819c286f0b431"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1e9dffc6684b31676169b5d5b5f819c286f0b431",
"title": "1e9dffc6684b31676169b5d5b5f819c286f0b431",
"url": "https://fuchsia.googlesource.com/integration/+/1e9dffc6684b31676169b5d5b5f819c286f0b431"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c1373d8c6a06a1d3397568081a98cd39acfe42c4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c1373d8c6a06a1d3397568081a98cd39acfe42c4",
"title": "c1373d8c6a06a1d3397568081a98cd39acfe42c4",
"url": "https://fuchsia.googlesource.com/integration/+/c1373d8c6a06a1d3397568081a98cd39acfe42c4"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "c1373d8c6a06a1d3397568081a98cd39acfe42c4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8856680542484467888"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:04:22.641] Scheduled build:
{
"id": "8691250480324862913",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-rust_determinism-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-30T12:04:21.668979910Z",
"updateTime": "2026-01-30T12:04:21.668979910Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "c1373d8c6a06a1d3397568081a98cd39acfe42c4",
"ref": "refs/heads/main"
}
},
"canary": true
}
[12:04:22.641] Task URL: https://cr-buildbucket.appspot.com/build/8691250480324862913
[12:04:22.641] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:2:0) after 3m16s
[12:04:23.389] Received PubSub notification, asking Buildbucket for the build status
[12:04:23.406] Build status: SCHEDULED
[12:04:25.657] Received PubSub notification, asking Buildbucket for the build status
[12:04:25.672] Build status: STARTED
[12:07:38.656] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:2:0)
[12:07:38.672] Build status: STARTED
[12:07:38.672] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:5:0) after 1m21s
[12:08:59.731] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:5:0)
[12:08:59.822] Build status: STARTED
[12:08:59.822] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:6:0) after 6m40s
[12:15:39.875] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:6:0)
[12:15:39.892] Build status: STARTED
[12:15:39.892] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:7:0) after 2m42s
[12:18:21.917] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:7:0)
[12:18:21.949] Build status: STARTED
[12:18:21.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:8:0) after 1m43s
[12:20:04.965] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:8:0)
[12:20:05.003] Build status: STARTED
[12:20:05.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:9:0) after 3m0s
[12:23:05.016] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:9:0)
[12:23:05.033] Build status: STARTED
[12:23:05.033] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:10:0) after 9m17s
[12:32:22.096] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:10:0)
[12:32:22.120] Build status: STARTED
[12:32:22.120] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:11:0) after 7m12s
[12:39:34.122] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:11:0)
[12:39:34.168] Build status: STARTED
[12:39:34.168] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:12:0) after 3m23s
[12:42:57.238] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:12:0)
[12:42:57.258] Build status: STARTED
[12:42:57.259] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:13:0) after 6m21s
[12:49:18.280] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:13:0)
[12:49:18.299] Build status: STARTED
[12:49:18.299] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:14:0) after 7m13s
[12:56:31.356] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:14:0)
[12:56:31.393] Build status: STARTED
[12:56:31.393] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:15:0) after 7m42s
[13:04:13.415] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:15:0)
[13:04:13.437] Build status: STARTED
[13:04:13.437] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:16:0) after 8m56s
[13:13:09.480] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:16:0)
[13:13:09.498] Build status: STARTED
[13:13:09.498] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:17:0) after 2m20s
[13:15:29.539] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:17:0)
[13:15:29.558] Build status: STARTED
[13:15:29.558] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:18:0) after 3m43s
[13:19:12.646] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:18:0)
[13:19:12.665] Build status: STARTED
[13:19:12.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:19:0) after 8m4s
[13:27:16.719] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:19:0)
[13:27:16.746] Build status: STARTED
[13:27:16.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:20:0) after 7m39s
[13:34:55.964] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:20:0)
[13:34:55.985] Build status: STARTED
[13:34:55.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:21:0) after 8m16s
[13:43:12.102] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:21:0)
[13:43:12.128] Build status: STARTED
[13:43:12.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:22:0) after 6m8s
[13:49:20.292] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:22:0)
[13:49:20.308] Build status: STARTED
[13:49:20.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:23:0) after 5m41s
[13:55:01.370] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:23:0)
[13:55:01.469] Build status: STARTED
[13:55:01.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-rust_determinism-build_only-e5a0ec7f:8856680542484467888:24:0) after 5m49s
[13:58:30.666] Received PubSub notification, asking Buildbucket for the build status
[13:58:30.679] Build:
{
"id": "8691250480324862913",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-rust_determinism-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-30T12:04:21.668979910Z",
"startTime": "2026-01-30T12:04:25.420297940Z",
"endTime": "2026-01-30T13:58:30.356274647Z",
"updateTime": "2026-01-30T13:58:30.356274647Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "c1373d8c6a06a1d3397568081a98cd39acfe42c4",
"ref": "refs/heads/main"
}
},
"canary": true
}
[13:58:30.679] Invocation finished in 1h54m10.453995071s with status SUCCEEDED