[23:25:42.952] New invocation is queued and will start shortly
[23:25:44.440] Starting the invocation (attempt 1)
[23:25:44.469] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/cd5d0d2b97ea84019898c7c1567546516c385e14"
[23:25:44.469] Popped gitiles commit info from properties and tags
[23:25:44.469] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:25:44.470] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:25:44.470] Buildbucket request:
{
"requestId": "8856275285988493104",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-profile-kernel-core.x64-release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8856275285988493104",
"job": "fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "58463a8491cfda4412331399ea01da5f6335c652"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@58463a8491cfda4412331399ea01da5f6335c652",
"title": "58463a8491cfda4412331399ea01da5f6335c652",
"url": "https://fuchsia.googlesource.com/integration/+/58463a8491cfda4412331399ea01da5f6335c652"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5f85de77ea24d901ca383ec12a3b484baf080af4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5f85de77ea24d901ca383ec12a3b484baf080af4",
"title": "5f85de77ea24d901ca383ec12a3b484baf080af4",
"url": "https://fuchsia.googlesource.com/integration/+/5f85de77ea24d901ca383ec12a3b484baf080af4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "43e292ec543d64383a2336dff006a0d2bffda6f6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@43e292ec543d64383a2336dff006a0d2bffda6f6",
"title": "43e292ec543d64383a2336dff006a0d2bffda6f6",
"url": "https://fuchsia.googlesource.com/integration/+/43e292ec543d64383a2336dff006a0d2bffda6f6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6d0539c7a3e44c118d4844b157ed97790fc698a5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6d0539c7a3e44c118d4844b157ed97790fc698a5",
"title": "6d0539c7a3e44c118d4844b157ed97790fc698a5",
"url": "https://fuchsia.googlesource.com/integration/+/6d0539c7a3e44c118d4844b157ed97790fc698a5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "da561d76952d3890f01831d9e70edff4b295b079"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@da561d76952d3890f01831d9e70edff4b295b079",
"title": "da561d76952d3890f01831d9e70edff4b295b079",
"url": "https://fuchsia.googlesource.com/integration/+/da561d76952d3890f01831d9e70edff4b295b079"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d2f135fa216b52db4d491d18e3c79985e1256a4f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d2f135fa216b52db4d491d18e3c79985e1256a4f",
"title": "d2f135fa216b52db4d491d18e3c79985e1256a4f",
"url": "https://fuchsia.googlesource.com/integration/+/d2f135fa216b52db4d491d18e3c79985e1256a4f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b7ef8d85a6f78c5ccbda718e215760e4950435d9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b7ef8d85a6f78c5ccbda718e215760e4950435d9",
"title": "b7ef8d85a6f78c5ccbda718e215760e4950435d9",
"url": "https://fuchsia.googlesource.com/integration/+/b7ef8d85a6f78c5ccbda718e215760e4950435d9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f88974d2718a75d3c6a73ea6da93f464b1e610e8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f88974d2718a75d3c6a73ea6da93f464b1e610e8",
"title": "f88974d2718a75d3c6a73ea6da93f464b1e610e8",
"url": "https://fuchsia.googlesource.com/integration/+/f88974d2718a75d3c6a73ea6da93f464b1e610e8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c47f1bdcbb06cb2d1239e07b41773ac2a789a747"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c47f1bdcbb06cb2d1239e07b41773ac2a789a747",
"title": "c47f1bdcbb06cb2d1239e07b41773ac2a789a747",
"url": "https://fuchsia.googlesource.com/integration/+/c47f1bdcbb06cb2d1239e07b41773ac2a789a747"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c547ba123de19e03a1bb25ff52033be80384cac3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c547ba123de19e03a1bb25ff52033be80384cac3",
"title": "c547ba123de19e03a1bb25ff52033be80384cac3",
"url": "https://fuchsia.googlesource.com/integration/+/c547ba123de19e03a1bb25ff52033be80384cac3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d815f249687c55a659d60f6978d376c32208eb6a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d815f249687c55a659d60f6978d376c32208eb6a",
"title": "d815f249687c55a659d60f6978d376c32208eb6a",
"url": "https://fuchsia.googlesource.com/integration/+/d815f249687c55a659d60f6978d376c32208eb6a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0d3b535ae1ce2be3b5ebebee54a6526739223032"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0d3b535ae1ce2be3b5ebebee54a6526739223032",
"title": "0d3b535ae1ce2be3b5ebebee54a6526739223032",
"url": "https://fuchsia.googlesource.com/integration/+/0d3b535ae1ce2be3b5ebebee54a6526739223032"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cd5d0d2b97ea84019898c7c1567546516c385e14"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cd5d0d2b97ea84019898c7c1567546516c385e14",
"title": "cd5d0d2b97ea84019898c7c1567546516c385e14",
"url": "https://fuchsia.googlesource.com/integration/+/cd5d0d2b97ea84019898c7c1567546516c385e14"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "cd5d0d2b97ea84019898c7c1567546516c385e14",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8856275285988493104"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:25:45.518] Scheduled build:
{
"id": "8690845223468768689",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-profile-kernel-core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2026-02-03T23:25:44.723020799Z",
"updateTime": "2026-02-03T23:25:44.723020799Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "cd5d0d2b97ea84019898c7c1567546516c385e14",
"ref": "refs/heads/main"
}
}
}
[23:25:45.518] Task URL: https://cr-buildbucket.appspot.com/build/8690845223468768689
[23:25:45.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:2:0) after 8m22s
[23:25:46.274] Received PubSub notification, asking Buildbucket for the build status
[23:25:46.338] Build status: SCHEDULED
[23:25:48.581] Received PubSub notification, asking Buildbucket for the build status
[23:25:48.630] Build status: STARTED
[23:34:07.547] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:2:0)
[23:34:07.599] Build status: STARTED
[23:34:07.599] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:5:0) after 7m13s
[23:41:20.791] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:5:0)
[23:41:20.820] Build status: STARTED
[23:41:20.820] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:6:0) after 8m14s
[23:49:34.835] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:6:0)
[23:49:34.849] Build status: STARTED
[23:49:34.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:7:0) after 3m20s
[23:52:54.919] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:7:0)
[23:52:54.943] Build status: STARTED
[23:52:54.943] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:8:0) after 3m2s
[23:55:57.056] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:8:0)
[23:55:57.082] Build status: STARTED
[23:55:57.082] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:9:0) after 5m16s
[00:01:13.180] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:9:0)
[00:01:13.350] Build status: STARTED
[00:01:13.350] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:10:0) after 3m23s
[00:04:36.953] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:10:0)
[00:04:36.971] Build status: STARTED
[00:04:36.971] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:11:0) after 6m4s
[00:10:40.985] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:11:0)
[00:10:41.001] Build status: STARTED
[00:10:41.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:12:0) after 1m4s
[00:11:45.195] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:12:0)
[00:11:45.211] Build status: STARTED
[00:11:45.211] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:13:0) after 5m3s
[00:16:48.226] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:13:0)
[00:16:48.240] Build status: STARTED
[00:16:48.241] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:14:0) after 3m52s
[00:20:40.495] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:14:0)
[00:20:40.542] Build status: STARTED
[00:20:40.542] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:15:0) after 7m0s
[00:27:40.608] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:15:0)
[00:27:40.625] Build status: STARTED
[00:27:40.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:16:0) after 6m53s
[00:34:33.638] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:16:0)
[00:34:33.660] Build status: STARTED
[00:34:33.660] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:17:0) after 5m17s
[00:39:50.740] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:17:0)
[00:39:50.753] Build status: STARTED
[00:39:50.753] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:18:0) after 6m41s
[00:46:31.819] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:18:0)
[00:46:31.836] Build status: STARTED
[00:46:31.836] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:19:0) after 5m33s
[00:52:04.878] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:19:0)
[00:52:04.892] Build status: STARTED
[00:52:04.892] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8856275285988493104:20:0) after 6m42s
[00:57:48.149] Received PubSub notification, asking Buildbucket for the build status
[00:57:48.173] Build:
{
"id": "8690845223468768689",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-profile-kernel-core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2026-02-03T23:25:44.723020799Z",
"startTime": "2026-02-03T23:25:48.357903839Z",
"endTime": "2026-02-04T00:57:47.756187432Z",
"updateTime": "2026-02-04T00:57:47.756187432Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "cd5d0d2b97ea84019898c7c1567546516c385e14",
"ref": "refs/heads/main"
}
}
}
[00:57:48.173] Invocation finished in 1h32m5.235748654s with status SUCCEEDED