[00:53:36.057] New invocation is queued and will start shortly
[00:53:37.122] Starting the invocation (attempt 1)
[00:53:37.150] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/439aefbeb494da4256a74b470725870f8178ef32"
[00:53:37.150] Popped gitiles commit info from properties and tags
[00:53:37.150] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:53:37.150] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:53:37.150] Buildbucket request:
{
"requestId": "8833801709059612720",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-balanced"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8833801709059612720",
"job": "fuchsia/global.ci-core.x64-balanced-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "470deac7d73be7e60cb4912362be5eb15a9df270"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@470deac7d73be7e60cb4912362be5eb15a9df270",
"title": "470deac7d73be7e60cb4912362be5eb15a9df270",
"url": "https://fuchsia.googlesource.com/integration/+/470deac7d73be7e60cb4912362be5eb15a9df270"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "34d8249126a7997657fbf8fdfb43ffd110cdd699"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@34d8249126a7997657fbf8fdfb43ffd110cdd699",
"title": "34d8249126a7997657fbf8fdfb43ffd110cdd699",
"url": "https://fuchsia.googlesource.com/integration/+/34d8249126a7997657fbf8fdfb43ffd110cdd699"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b502463bdc1de542321a3fd9ce1bb7fa37ae1202"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b502463bdc1de542321a3fd9ce1bb7fa37ae1202",
"title": "b502463bdc1de542321a3fd9ce1bb7fa37ae1202",
"url": "https://fuchsia.googlesource.com/integration/+/b502463bdc1de542321a3fd9ce1bb7fa37ae1202"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "47eca6b532324d2d63d063aaa7641e9eb31e6f3e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@47eca6b532324d2d63d063aaa7641e9eb31e6f3e",
"title": "47eca6b532324d2d63d063aaa7641e9eb31e6f3e",
"url": "https://fuchsia.googlesource.com/integration/+/47eca6b532324d2d63d063aaa7641e9eb31e6f3e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4428a9d9034e61629f4e9f67f94f8211428e0205"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4428a9d9034e61629f4e9f67f94f8211428e0205",
"title": "4428a9d9034e61629f4e9f67f94f8211428e0205",
"url": "https://fuchsia.googlesource.com/integration/+/4428a9d9034e61629f4e9f67f94f8211428e0205"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f6d337d0a1c32f47482ca2eb4bab800db971c7ed"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f6d337d0a1c32f47482ca2eb4bab800db971c7ed",
"title": "f6d337d0a1c32f47482ca2eb4bab800db971c7ed",
"url": "https://fuchsia.googlesource.com/integration/+/f6d337d0a1c32f47482ca2eb4bab800db971c7ed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9a1de1db55c67b86b0437aacc688b6d6d3ebe429"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9a1de1db55c67b86b0437aacc688b6d6d3ebe429",
"title": "9a1de1db55c67b86b0437aacc688b6d6d3ebe429",
"url": "https://fuchsia.googlesource.com/integration/+/9a1de1db55c67b86b0437aacc688b6d6d3ebe429"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2b03a18484552434e2fdbff4781d8ff0de3a8442"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2b03a18484552434e2fdbff4781d8ff0de3a8442",
"title": "2b03a18484552434e2fdbff4781d8ff0de3a8442",
"url": "https://fuchsia.googlesource.com/integration/+/2b03a18484552434e2fdbff4781d8ff0de3a8442"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "594883ec7fe332d3e9b492eef0b233ec71e2b6cc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@594883ec7fe332d3e9b492eef0b233ec71e2b6cc",
"title": "594883ec7fe332d3e9b492eef0b233ec71e2b6cc",
"url": "https://fuchsia.googlesource.com/integration/+/594883ec7fe332d3e9b492eef0b233ec71e2b6cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ca394d5fa1a3c021fc73ee9871f64263e522249f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ca394d5fa1a3c021fc73ee9871f64263e522249f",
"title": "ca394d5fa1a3c021fc73ee9871f64263e522249f",
"url": "https://fuchsia.googlesource.com/integration/+/ca394d5fa1a3c021fc73ee9871f64263e522249f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4ce7422be466c5f50c1778ef0fb7a05bee0ed9ca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4ce7422be466c5f50c1778ef0fb7a05bee0ed9ca",
"title": "4ce7422be466c5f50c1778ef0fb7a05bee0ed9ca",
"url": "https://fuchsia.googlesource.com/integration/+/4ce7422be466c5f50c1778ef0fb7a05bee0ed9ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "439aefbeb494da4256a74b470725870f8178ef32"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@439aefbeb494da4256a74b470725870f8178ef32",
"title": "439aefbeb494da4256a74b470725870f8178ef32",
"url": "https://fuchsia.googlesource.com/integration/+/439aefbeb494da4256a74b470725870f8178ef32"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "439aefbeb494da4256a74b470725870f8178ef32",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8833801709059612720"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.x64-balanced-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:53:37.546] Scheduled build:
{
"id": "8668371647192046545",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-balanced"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-10T00:53:37.216783777Z",
"updateTime": "2026-10-10T00:53:37.216783777Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "439aefbeb494da4256a74b470725870f8178ef32",
"ref": "refs/heads/main"
}
}
}
[00:53:37.546] Task URL: https://cr-buildbucket.appspot.com/build/8668371647192046545
[00:53:37.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:2:0) after 2m9s
[00:53:38.508] Received PubSub notification, asking Buildbucket for the build status
[00:53:38.531] Build status: SCHEDULED
[00:53:42.107] Received PubSub notification, asking Buildbucket for the build status
[00:53:42.164] Build status: STARTED
[00:55:46.561] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:2:0)
[00:55:46.592] Build status: STARTED
[00:55:46.592] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:5:0) after 8m57s
[01:04:43.617] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:5:0)
[01:04:43.634] Build status: STARTED
[01:04:43.634] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:6:0) after 3m12s
[01:07:55.698] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:6:0)
[01:07:55.731] Build status: STARTED
[01:07:55.731] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:7:0) after 3m28s
[01:11:23.753] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:7:0)
[01:11:23.779] Build status: STARTED
[01:11:23.780] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:8:0) after 6m14s
[01:17:37.796] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:8:0)
[01:17:37.814] Build status: STARTED
[01:17:37.814] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:9:0) after 9m42s
[01:27:19.996] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:9:0)
[01:27:20.017] Build status: STARTED
[01:27:20.017] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:10:0) after 6m10s
[01:33:30.090] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:10:0)
[01:33:30.113] Build status: STARTED
[01:33:30.113] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:11:0) after 4m20s
[01:37:50.202] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:11:0)
[01:37:50.220] Build status: STARTED
[01:37:50.220] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:12:0) after 6m33s
[01:44:23.286] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:12:0)
[01:44:23.314] Build status: STARTED
[01:44:23.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:13:0) after 4m13s
[01:48:36.393] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:13:0)
[01:48:36.508] Build status: STARTED
[01:48:36.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:14:0) after 6m32s
[01:55:08.575] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:14:0)
[01:55:08.618] Build status: STARTED
[01:55:08.618] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:15:0) after 7m4s
[02:02:12.691] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:15:0)
[02:02:12.775] Build status: STARTED
[02:02:12.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:16:0) after 2m46s
[02:04:58.860] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:16:0)
[02:04:58.884] Build status: STARTED
[02:04:58.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:17:0) after 5m53s
[02:10:52.000] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:17:0)
[02:10:52.134] Build status: STARTED
[02:10:52.134] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:18:0) after 5m8s
[02:16:00.328] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:18:0)
[02:16:00.365] Build status: STARTED
[02:16:00.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:19:0) after 1m7s
[02:17:07.422] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:19:0)
[02:17:07.441] Build status: STARTED
[02:17:07.441] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833801709059612720:20:0) after 1m23s
[02:18:17.186] Received PubSub notification, asking Buildbucket for the build status
[02:18:17.204] Build:
{
"id": "8668371647192046545",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-balanced"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-10T00:53:37.216783777Z",
"startTime": "2026-10-10T00:53:41.303486955Z",
"endTime": "2026-10-10T02:18:16.232989375Z",
"updateTime": "2026-10-10T02:18:16.232989375Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "439aefbeb494da4256a74b470725870f8178ef32",
"ref": "refs/heads/main"
}
}
}
[02:18:17.204] Invocation finished in 1h24m41.151052634s with status SUCCEEDED