[01:36:34.432] New invocation is queued and will start shortly
[01:36:35.726] Starting the invocation (attempt 1)
[01:36:35.751] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/4adfceb77db0e8b78a952b0f787e8870dea0e427"
[01:36:35.751] Popped gitiles commit info from properties and tags
[01:36:35.751] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:36:35.751] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:36:35.752] Buildbucket request:
{
"requestId": "8855542277376000272",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8855542277376000272",
"job": "fuchsia/global.ci-core.x64-debug-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1989114c107481becb0d0a811464e68211e8c889"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1989114c107481becb0d0a811464e68211e8c889",
"title": "1989114c107481becb0d0a811464e68211e8c889",
"url": "https://fuchsia.googlesource.com/integration/+/1989114c107481becb0d0a811464e68211e8c889"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d4aa9e0a8fbfac97f015aedba6290e345b4809e9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d4aa9e0a8fbfac97f015aedba6290e345b4809e9",
"title": "d4aa9e0a8fbfac97f015aedba6290e345b4809e9",
"url": "https://fuchsia.googlesource.com/integration/+/d4aa9e0a8fbfac97f015aedba6290e345b4809e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "13015501e0804c6d3768874bf73e502150821f58"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@13015501e0804c6d3768874bf73e502150821f58",
"title": "13015501e0804c6d3768874bf73e502150821f58",
"url": "https://fuchsia.googlesource.com/integration/+/13015501e0804c6d3768874bf73e502150821f58"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3b6e7cae3e9f25482958accfa552249baa118fba"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3b6e7cae3e9f25482958accfa552249baa118fba",
"title": "3b6e7cae3e9f25482958accfa552249baa118fba",
"url": "https://fuchsia.googlesource.com/integration/+/3b6e7cae3e9f25482958accfa552249baa118fba"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "114c866138c6e6e88b0f420b12d53a299ab7fc0a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@114c866138c6e6e88b0f420b12d53a299ab7fc0a",
"title": "114c866138c6e6e88b0f420b12d53a299ab7fc0a",
"url": "https://fuchsia.googlesource.com/integration/+/114c866138c6e6e88b0f420b12d53a299ab7fc0a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "909e92e246f0f3c4c7bf03347f82a14258524667"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@909e92e246f0f3c4c7bf03347f82a14258524667",
"title": "909e92e246f0f3c4c7bf03347f82a14258524667",
"url": "https://fuchsia.googlesource.com/integration/+/909e92e246f0f3c4c7bf03347f82a14258524667"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ff51d552e36744a89c8c4f4d79ecf847df7d7458"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ff51d552e36744a89c8c4f4d79ecf847df7d7458",
"title": "ff51d552e36744a89c8c4f4d79ecf847df7d7458",
"url": "https://fuchsia.googlesource.com/integration/+/ff51d552e36744a89c8c4f4d79ecf847df7d7458"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fa9ea8d5255463d0aa3e197cfaa100f3b95f5f1b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fa9ea8d5255463d0aa3e197cfaa100f3b95f5f1b",
"title": "fa9ea8d5255463d0aa3e197cfaa100f3b95f5f1b",
"url": "https://fuchsia.googlesource.com/integration/+/fa9ea8d5255463d0aa3e197cfaa100f3b95f5f1b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "63deaea937e744f6359bb0da67ddaf88a31304cb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@63deaea937e744f6359bb0da67ddaf88a31304cb",
"title": "63deaea937e744f6359bb0da67ddaf88a31304cb",
"url": "https://fuchsia.googlesource.com/integration/+/63deaea937e744f6359bb0da67ddaf88a31304cb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cf20f321a1fbd4a085c88e0883fdc46b228699e7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cf20f321a1fbd4a085c88e0883fdc46b228699e7",
"title": "cf20f321a1fbd4a085c88e0883fdc46b228699e7",
"url": "https://fuchsia.googlesource.com/integration/+/cf20f321a1fbd4a085c88e0883fdc46b228699e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4adfceb77db0e8b78a952b0f787e8870dea0e427"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4adfceb77db0e8b78a952b0f787e8870dea0e427",
"title": "4adfceb77db0e8b78a952b0f787e8870dea0e427",
"url": "https://fuchsia.googlesource.com/integration/+/4adfceb77db0e8b78a952b0f787e8870dea0e427"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4adfceb77db0e8b78a952b0f787e8870dea0e427",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8855542277376000272"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.x64-debug-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:36:36.378] Scheduled build:
{
"id": "8690112215290221297",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-02-12T01:36:35.797648537Z",
"updateTime": "2026-02-12T01:36:35.797648537Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4adfceb77db0e8b78a952b0f787e8870dea0e427",
"ref": "refs/heads/main"
}
}
}
[01:36:36.378] Task URL: https://cr-buildbucket.appspot.com/build/8690112215290221297
[01:36:36.378] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:2:0) after 6m42s
[01:36:37.108] Received PubSub notification, asking Buildbucket for the build status
[01:36:37.154] Build status: SCHEDULED
[01:39:51.985] Received PubSub notification, asking Buildbucket for the build status
[01:39:52.015] Build status: STARTED
[01:43:18.446] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:2:0)
[01:43:18.459] Build status: STARTED
[01:43:18.459] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:5:0) after 7m50s
[01:51:08.428] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:5:0)
[01:51:08.444] Build status: STARTED
[01:51:08.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:6:0) after 1m43s
[01:52:51.544] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:6:0)
[01:52:51.562] Build status: STARTED
[01:52:51.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:7:0) after 2m25s
[01:55:16.578] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:7:0)
[01:55:16.593] Build status: STARTED
[01:55:16.593] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:8:0) after 3m28s
[01:58:44.589] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:8:0)
[01:58:44.605] Build status: STARTED
[01:58:44.605] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:9:0) after 8m16s
[02:07:00.651] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:9:0)
[02:07:00.667] Build status: STARTED
[02:07:00.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:10:0) after 9m54s
[02:16:54.684] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:10:0)
[02:16:54.725] Build status: STARTED
[02:16:54.725] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:11:0) after 7m8s
[02:24:02.748] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:11:0)
[02:24:02.767] Build status: STARTED
[02:24:02.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:12:0) after 3m20s
[02:27:22.777] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:12:0)
[02:27:22.806] Build status: STARTED
[02:27:22.807] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:13:0) after 9m14s
[02:36:36.918] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:13:0)
[02:36:36.978] Build status: STARTED
[02:36:36.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:14:0) after 1m48s
[02:38:24.999] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:14:0)
[02:38:25.086] Build status: STARTED
[02:38:25.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:15:0) after 1m41s
[02:40:06.104] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:15:0)
[02:40:06.128] Build status: STARTED
[02:40:06.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:16:0) after 1m11s
[02:41:17.149] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:16:0)
[02:41:17.179] Build status: STARTED
[02:41:17.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:17:0) after 1m58s
[02:43:15.242] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:17:0)
[02:43:15.264] Build status: STARTED
[02:43:15.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8855542277376000272:18:0) after 9m41s
[02:45:17.560] Received PubSub notification, asking Buildbucket for the build status
[02:45:17.576] Build:
{
"id": "8690112215290221297",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-02-12T01:36:35.797648537Z",
"startTime": "2026-02-12T01:39:51.813282853Z",
"endTime": "2026-02-12T02:44:57.542163469Z",
"updateTime": "2026-02-12T02:44:57.542163469Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4adfceb77db0e8b78a952b0f787e8870dea0e427",
"ref": "refs/heads/main"
}
}
}
[02:45:17.576] Invocation finished in 1h8m43.152450916s with status SUCCEEDED