[22:25:06.165] New invocation is queued and will start shortly
[22:25:07.401] Starting the invocation (attempt 1)
[22:25:07.429] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/ecc6ac01080f475b700073bc1f7d71cf47e3ce60"
[22:25:07.429] Popped gitiles commit info from properties and tags
[22:25:07.429] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:25:07.430] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:25:07.430] Buildbucket request:
{
"requestId": "8842870748396780704",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-thinlto"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8842870748396780704",
"job": "fuchsia/global.ci-core.x64-thinlto-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4a45a51ba1a9eab63ec45985792d33dd23140f18"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4a45a51ba1a9eab63ec45985792d33dd23140f18",
"title": "4a45a51ba1a9eab63ec45985792d33dd23140f18",
"url": "https://fuchsia.googlesource.com/integration/+/4a45a51ba1a9eab63ec45985792d33dd23140f18"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4354c0d2fb9fec02a6c06c1699429247efd989ea"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4354c0d2fb9fec02a6c06c1699429247efd989ea",
"title": "4354c0d2fb9fec02a6c06c1699429247efd989ea",
"url": "https://fuchsia.googlesource.com/integration/+/4354c0d2fb9fec02a6c06c1699429247efd989ea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "09f426f2612fbfa45a730ebbb4b4e95286b5b7ec"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@09f426f2612fbfa45a730ebbb4b4e95286b5b7ec",
"title": "09f426f2612fbfa45a730ebbb4b4e95286b5b7ec",
"url": "https://fuchsia.googlesource.com/integration/+/09f426f2612fbfa45a730ebbb4b4e95286b5b7ec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c69c92ef845bc2b1c7b969e47d70d920f627ffe4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c69c92ef845bc2b1c7b969e47d70d920f627ffe4",
"title": "c69c92ef845bc2b1c7b969e47d70d920f627ffe4",
"url": "https://fuchsia.googlesource.com/integration/+/c69c92ef845bc2b1c7b969e47d70d920f627ffe4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8c1f2b242b8c01e49aaf2dc9cb8955a8664e4233"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8c1f2b242b8c01e49aaf2dc9cb8955a8664e4233",
"title": "8c1f2b242b8c01e49aaf2dc9cb8955a8664e4233",
"url": "https://fuchsia.googlesource.com/integration/+/8c1f2b242b8c01e49aaf2dc9cb8955a8664e4233"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "980eaf9b922456f3138f994a61a93dfafa96c493"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@980eaf9b922456f3138f994a61a93dfafa96c493",
"title": "980eaf9b922456f3138f994a61a93dfafa96c493",
"url": "https://fuchsia.googlesource.com/integration/+/980eaf9b922456f3138f994a61a93dfafa96c493"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e0ca52f086c49fd3cff5ce4c51edf81a3b7402af"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e0ca52f086c49fd3cff5ce4c51edf81a3b7402af",
"title": "e0ca52f086c49fd3cff5ce4c51edf81a3b7402af",
"url": "https://fuchsia.googlesource.com/integration/+/e0ca52f086c49fd3cff5ce4c51edf81a3b7402af"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ecc6ac01080f475b700073bc1f7d71cf47e3ce60"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ecc6ac01080f475b700073bc1f7d71cf47e3ce60",
"title": "ecc6ac01080f475b700073bc1f7d71cf47e3ce60",
"url": "https://fuchsia.googlesource.com/integration/+/ecc6ac01080f475b700073bc1f7d71cf47e3ce60"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ecc6ac01080f475b700073bc1f7d71cf47e3ce60",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8842870748396780704"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.x64-thinlto-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:25:07.820] Scheduled build:
{
"id": "8677440686347529313",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-thinlto"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-01T22:25:07.499856032Z",
"updateTime": "2026-07-01T22:25:07.499856032Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ecc6ac01080f475b700073bc1f7d71cf47e3ce60",
"ref": "refs/heads/main"
}
}
}
[22:25:07.820] Task URL: https://cr-buildbucket.appspot.com/build/8677440686347529313
[22:25:07.820] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:2:0) after 4m30s
[22:25:08.745] Received PubSub notification, asking Buildbucket for the build status
[22:25:08.776] Build status: SCHEDULED
[22:29:10.206] Received PubSub notification, asking Buildbucket for the build status
[22:29:10.225] Build status: STARTED
[22:29:37.833] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:2:0)
[22:29:37.864] Build status: STARTED
[22:29:37.864] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:5:0) after 7m34s
[22:37:11.875] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:5:0)
[22:37:11.895] Build status: STARTED
[22:37:11.895] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:6:0) after 7m26s
[22:44:37.909] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:6:0)
[22:44:37.976] Build status: STARTED
[22:44:37.976] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:7:0) after 4m28s
[22:49:05.988] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:7:0)
[22:49:06.005] Build status: STARTED
[22:49:06.005] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:8:0) after 5m36s
[22:54:42.172] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:8:0)
[22:54:42.191] Build status: STARTED
[22:54:42.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:9:0) after 8m26s
[23:03:08.174] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:9:0)
[23:03:08.197] Build status: STARTED
[23:03:08.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:10:0) after 2m40s
[23:05:48.209] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:10:0)
[23:05:48.227] Build status: STARTED
[23:05:48.227] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:11:0) after 9m53s
[23:15:41.309] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:11:0)
[23:15:41.326] Build status: STARTED
[23:15:41.326] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:12:0) after 2m21s
[23:18:02.424] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:12:0)
[23:18:02.441] Build status: STARTED
[23:18:02.441] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:13:0) after 4m52s
[23:22:54.493] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:13:0)
[23:22:54.509] Build status: STARTED
[23:22:54.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:14:0) after 6m26s
[23:29:20.609] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:14:0)
[23:29:20.627] Build status: STARTED
[23:29:20.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-thinlto-e5a0ec7f:8842870748396780704:15:0) after 1m57s
[23:30:22.894] Received PubSub notification, asking Buildbucket for the build status
[23:30:22.968] Build:
{
"id": "8677440686347529313",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-thinlto"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-01T22:25:07.499856032Z",
"startTime": "2026-07-01T22:29:10.037387976Z",
"endTime": "2026-07-01T23:30:22.165897363Z",
"updateTime": "2026-07-01T23:30:22.165897363Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ecc6ac01080f475b700073bc1f7d71cf47e3ce60",
"ref": "refs/heads/main"
}
}
}
[23:30:22.968] Invocation finished in 1h5m16.806941502s with status SUCCEEDED