[04:19:28.338] New invocation is queued and will start shortly
[04:19:29.473] Starting the invocation (attempt 1)
[04:19:29.498] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/7fa9657633b990b6ee9262627e9aeafd478806c4"
[04:19:29.498] Popped gitiles commit info from properties and tags
[04:19:29.498] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:19:29.498] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:19:29.499] Buildbucket request:
{
"requestId": "8851726956103886624",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-lto"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8851726956103886624",
"job": "fuchsia/global.ci-core.arm64-lto-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3a026481da9f2bec46f9c4af1f423d3726acc028"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3a026481da9f2bec46f9c4af1f423d3726acc028",
"title": "3a026481da9f2bec46f9c4af1f423d3726acc028",
"url": "https://fuchsia.googlesource.com/integration/+/3a026481da9f2bec46f9c4af1f423d3726acc028"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6e51eb5c7a69a84e073212c86d07927602a72ccb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6e51eb5c7a69a84e073212c86d07927602a72ccb",
"title": "6e51eb5c7a69a84e073212c86d07927602a72ccb",
"url": "https://fuchsia.googlesource.com/integration/+/6e51eb5c7a69a84e073212c86d07927602a72ccb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "375e4a8840ba952a35a69882bdfdda8df96f5428"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@375e4a8840ba952a35a69882bdfdda8df96f5428",
"title": "375e4a8840ba952a35a69882bdfdda8df96f5428",
"url": "https://fuchsia.googlesource.com/integration/+/375e4a8840ba952a35a69882bdfdda8df96f5428"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2d28a544eaed99b07b01da011234dddcd9af1fe2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2d28a544eaed99b07b01da011234dddcd9af1fe2",
"title": "2d28a544eaed99b07b01da011234dddcd9af1fe2",
"url": "https://fuchsia.googlesource.com/integration/+/2d28a544eaed99b07b01da011234dddcd9af1fe2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "537ca6403ddf550b112382e94a75b828ae5bfd2a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@537ca6403ddf550b112382e94a75b828ae5bfd2a",
"title": "537ca6403ddf550b112382e94a75b828ae5bfd2a",
"url": "https://fuchsia.googlesource.com/integration/+/537ca6403ddf550b112382e94a75b828ae5bfd2a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "14b7029eabe8f9d6c418e2b4742454422d15d29c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@14b7029eabe8f9d6c418e2b4742454422d15d29c",
"title": "14b7029eabe8f9d6c418e2b4742454422d15d29c",
"url": "https://fuchsia.googlesource.com/integration/+/14b7029eabe8f9d6c418e2b4742454422d15d29c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "78281cc7d9d4721abe9479d499818ceb67531f9a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@78281cc7d9d4721abe9479d499818ceb67531f9a",
"title": "78281cc7d9d4721abe9479d499818ceb67531f9a",
"url": "https://fuchsia.googlesource.com/integration/+/78281cc7d9d4721abe9479d499818ceb67531f9a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a28583957b438d83c2ce2331046453522e4beb6c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a28583957b438d83c2ce2331046453522e4beb6c",
"title": "a28583957b438d83c2ce2331046453522e4beb6c",
"url": "https://fuchsia.googlesource.com/integration/+/a28583957b438d83c2ce2331046453522e4beb6c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b2f388989cd468b216febcfb6197d8de422891a6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b2f388989cd468b216febcfb6197d8de422891a6",
"title": "b2f388989cd468b216febcfb6197d8de422891a6",
"url": "https://fuchsia.googlesource.com/integration/+/b2f388989cd468b216febcfb6197d8de422891a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8f64a01b4963ebd640ad8ce3ad7c803a40816238"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8f64a01b4963ebd640ad8ce3ad7c803a40816238",
"title": "8f64a01b4963ebd640ad8ce3ad7c803a40816238",
"url": "https://fuchsia.googlesource.com/integration/+/8f64a01b4963ebd640ad8ce3ad7c803a40816238"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3002d328ad186463ad256f530222c35529b8cf99"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3002d328ad186463ad256f530222c35529b8cf99",
"title": "3002d328ad186463ad256f530222c35529b8cf99",
"url": "https://fuchsia.googlesource.com/integration/+/3002d328ad186463ad256f530222c35529b8cf99"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5165a0b6ab50ca77106aef14202b20a9635ecc6c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5165a0b6ab50ca77106aef14202b20a9635ecc6c",
"title": "5165a0b6ab50ca77106aef14202b20a9635ecc6c",
"url": "https://fuchsia.googlesource.com/integration/+/5165a0b6ab50ca77106aef14202b20a9635ecc6c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5c99e7ef8f80c8cd8a9a5d30c418aa4080b1e0f8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5c99e7ef8f80c8cd8a9a5d30c418aa4080b1e0f8",
"title": "5c99e7ef8f80c8cd8a9a5d30c418aa4080b1e0f8",
"url": "https://fuchsia.googlesource.com/integration/+/5c99e7ef8f80c8cd8a9a5d30c418aa4080b1e0f8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7fa9657633b990b6ee9262627e9aeafd478806c4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7fa9657633b990b6ee9262627e9aeafd478806c4",
"title": "7fa9657633b990b6ee9262627e9aeafd478806c4",
"url": "https://fuchsia.googlesource.com/integration/+/7fa9657633b990b6ee9262627e9aeafd478806c4"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "7fa9657633b990b6ee9262627e9aeafd478806c4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8851726956103886624"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.arm64-lto-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:19:30.471] Scheduled build:
{
"id": "8686296894158834897",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-lto"
},
"createdBy": "project:fuchsia",
"createTime": "2026-03-26T04:19:29.569798992Z",
"updateTime": "2026-03-26T04:19:29.569798992Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "7fa9657633b990b6ee9262627e9aeafd478806c4",
"ref": "refs/heads/main"
}
}
}
[04:19:30.471] Task URL: https://cr-buildbucket.appspot.com/build/8686296894158834897
[04:19:30.471] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:2:0) after 9m37s
[04:19:31.243] Received PubSub notification, asking Buildbucket for the build status
[04:19:31.339] Build status: SCHEDULED
[04:19:37.034] Received PubSub notification, asking Buildbucket for the build status
[04:19:37.057] Build status: STARTED
[04:29:07.578] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:2:0)
[04:29:07.607] Build status: STARTED
[04:29:07.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:5:0) after 7m11s
[04:36:18.613] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:5:0)
[04:36:18.699] Build status: STARTED
[04:36:18.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:6:0) after 9m56s
[04:46:14.737] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:6:0)
[04:46:14.758] Build status: STARTED
[04:46:14.758] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:7:0) after 1m30s
[04:47:44.871] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:7:0)
[04:47:44.885] Build status: STARTED
[04:47:44.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:8:0) after 4m50s
[04:52:34.909] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:8:0)
[04:52:34.933] Build status: STARTED
[04:52:34.933] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:9:0) after 6m14s
[04:58:48.997] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:9:0)
[04:58:49.011] Build status: STARTED
[04:58:49.011] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:10:0) after 6m13s
[05:05:02.034] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:10:0)
[05:05:02.066] Build status: STARTED
[05:05:02.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:11:0) after 8m40s
[05:13:42.088] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:11:0)
[05:13:42.158] Build status: STARTED
[05:13:42.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:12:0) after 4m12s
[05:17:54.212] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:12:0)
[05:17:54.234] Build status: STARTED
[05:17:54.234] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:13:0) after 5m1s
[05:22:55.253] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:13:0)
[05:22:55.268] Build status: STARTED
[05:22:55.268] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:14:0) after 3m51s
[05:26:46.311] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:14:0)
[05:26:46.333] Build status: STARTED
[05:26:46.333] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8851726956103886624:15:0) after 8m24s
[05:31:25.818] Received PubSub notification, asking Buildbucket for the build status
[05:31:25.909] Build:
{
"id": "8686296894158834897",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-lto"
},
"createdBy": "project:fuchsia",
"createTime": "2026-03-26T04:19:29.569798992Z",
"startTime": "2026-03-26T04:19:36.442814431Z",
"endTime": "2026-03-26T05:31:25.471133019Z",
"updateTime": "2026-03-26T05:31:25.471133019Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "7fa9657633b990b6ee9262627e9aeafd478806c4",
"ref": "refs/heads/main"
}
}
}
[05:31:25.909] Invocation finished in 1h11m57.579495269s with status SUCCEEDED