[01:52:09.086] New invocation is queued and will start shortly
[01:52:10.190] Starting the invocation (attempt 1)
[01:52:10.219] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/65fd7ee9302448600cf61a325a7167aec00a32e7"
[01:52:10.219] Popped gitiles commit info from properties and tags
[01:52:10.219] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:52:10.219] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:52:10.220] Buildbucket request:
{
"requestId": "8844216676515374912",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "sdk-core-linux-rstest"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8844216676515374912",
"job": "fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bc107b531c53f22976149f0a59ad13df09d0d7b5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bc107b531c53f22976149f0a59ad13df09d0d7b5",
"title": "bc107b531c53f22976149f0a59ad13df09d0d7b5",
"url": "https://fuchsia.googlesource.com/integration/+/bc107b531c53f22976149f0a59ad13df09d0d7b5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "84295ccc19d42333b6d659428bcdc0da3776e21f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@84295ccc19d42333b6d659428bcdc0da3776e21f",
"title": "84295ccc19d42333b6d659428bcdc0da3776e21f",
"url": "https://fuchsia.googlesource.com/integration/+/84295ccc19d42333b6d659428bcdc0da3776e21f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6a9602235f679f3a447f47e82d47f00ad619361c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6a9602235f679f3a447f47e82d47f00ad619361c",
"title": "6a9602235f679f3a447f47e82d47f00ad619361c",
"url": "https://fuchsia.googlesource.com/integration/+/6a9602235f679f3a447f47e82d47f00ad619361c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "388d5b594c925ca6e8d0cedb8ffee9d113f4ba78"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@388d5b594c925ca6e8d0cedb8ffee9d113f4ba78",
"title": "388d5b594c925ca6e8d0cedb8ffee9d113f4ba78",
"url": "https://fuchsia.googlesource.com/integration/+/388d5b594c925ca6e8d0cedb8ffee9d113f4ba78"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fd8e4e0dea52ce37a69dec4b02b064fe1c7432b4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fd8e4e0dea52ce37a69dec4b02b064fe1c7432b4",
"title": "fd8e4e0dea52ce37a69dec4b02b064fe1c7432b4",
"url": "https://fuchsia.googlesource.com/integration/+/fd8e4e0dea52ce37a69dec4b02b064fe1c7432b4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8efb5dff473db4894f3377a072a5b9ea1d494e27"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8efb5dff473db4894f3377a072a5b9ea1d494e27",
"title": "8efb5dff473db4894f3377a072a5b9ea1d494e27",
"url": "https://fuchsia.googlesource.com/integration/+/8efb5dff473db4894f3377a072a5b9ea1d494e27"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dfd7a64cee3367298c84a2a61287df86fba38abb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dfd7a64cee3367298c84a2a61287df86fba38abb",
"title": "dfd7a64cee3367298c84a2a61287df86fba38abb",
"url": "https://fuchsia.googlesource.com/integration/+/dfd7a64cee3367298c84a2a61287df86fba38abb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "65fd7ee9302448600cf61a325a7167aec00a32e7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@65fd7ee9302448600cf61a325a7167aec00a32e7",
"title": "65fd7ee9302448600cf61a325a7167aec00a32e7",
"url": "https://fuchsia.googlesource.com/integration/+/65fd7ee9302448600cf61a325a7167aec00a32e7"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "65fd7ee9302448600cf61a325a7167aec00a32e7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8844216676515374912"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:52:10.720] Scheduled build:
{
"id": "8678786614587468625",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "sdk-core-linux-rstest"
},
"createdBy": "project:fuchsia",
"createTime": "2026-06-17T01:52:10.305990725Z",
"updateTime": "2026-06-17T01:52:10.305990725Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "65fd7ee9302448600cf61a325a7167aec00a32e7",
"ref": "refs/heads/main"
}
}
}
[01:52:10.720] Task URL: https://cr-buildbucket.appspot.com/build/8678786614587468625
[01:52:10.720] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8844216676515374912:2:0) after 4m36s
[01:52:11.719] Received PubSub notification, asking Buildbucket for the build status
[01:52:11.756] Build status: SCHEDULED
[01:52:13.526] Received PubSub notification, asking Buildbucket for the build status
[01:52:13.547] Build status: STARTED
[01:56:46.734] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8844216676515374912:2:0)
[01:56:46.758] Build status: STARTED
[01:56:46.758] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8844216676515374912:5:0) after 1m56s
[01:58:42.798] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8844216676515374912:5:0)
[01:58:42.816] Build status: STARTED
[01:58:42.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8844216676515374912:6:0) after 7m35s
[02:06:18.026] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8844216676515374912:6:0)
[02:06:18.043] Build status: STARTED
[02:06:18.043] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8844216676515374912:7:0) after 3m57s
[02:10:15.098] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8844216676515374912:7:0)
[02:10:15.117] Build status: STARTED
[02:10:15.117] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8844216676515374912:8:0) after 6m19s
[02:16:34.173] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8844216676515374912:8:0)
[02:16:34.190] Build status: STARTED
[02:16:34.190] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8844216676515374912:9:0) after 6m33s
[02:22:26.556] Received PubSub notification, asking Buildbucket for the build status
[02:22:26.572] Build:
{
"id": "8678786614587468625",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "sdk-core-linux-rstest"
},
"createdBy": "project:fuchsia",
"createTime": "2026-06-17T01:52:10.305990725Z",
"startTime": "2026-06-17T01:52:13.340203436Z",
"endTime": "2026-06-17T02:22:26.274644031Z",
"updateTime": "2026-06-17T02:22:26.274644031Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "65fd7ee9302448600cf61a325a7167aec00a32e7",
"ref": "refs/heads/main"
}
}
}
[02:22:26.572] Invocation finished in 30m17.489251998s with status SUCCEEDED