[18:48:11.183] New invocation is queued and will start shortly
[18:48:12.947] Starting the invocation (attempt 1)
[18:48:12.977] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/8f2c39fc07d2253c483d3eca774ca64cfd942de1"
[18:48:12.977] Popped gitiles commit info from properties and tags
[18:48:12.977] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:48:12.977] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:48:12.978] Buildbucket request:
{
"requestId": "8833190520192152560",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-balanced"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8833190520192152560",
"job": "fuchsia/global.ci-core.x64-balanced-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "372b147166a1cd0686f7a372e0d2ff2f742f7a0f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@372b147166a1cd0686f7a372e0d2ff2f742f7a0f",
"title": "372b147166a1cd0686f7a372e0d2ff2f742f7a0f",
"url": "https://fuchsia.googlesource.com/integration/+/372b147166a1cd0686f7a372e0d2ff2f742f7a0f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1373ef1a2518ab270010e3c781b9052c646d3c8c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1373ef1a2518ab270010e3c781b9052c646d3c8c",
"title": "1373ef1a2518ab270010e3c781b9052c646d3c8c",
"url": "https://fuchsia.googlesource.com/integration/+/1373ef1a2518ab270010e3c781b9052c646d3c8c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c02544494e15dfa02d1441f25c5764d722dcc88e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c02544494e15dfa02d1441f25c5764d722dcc88e",
"title": "c02544494e15dfa02d1441f25c5764d722dcc88e",
"url": "https://fuchsia.googlesource.com/integration/+/c02544494e15dfa02d1441f25c5764d722dcc88e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fdc71c10748bfc2a173d60dca878d3a678a8485a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fdc71c10748bfc2a173d60dca878d3a678a8485a",
"title": "fdc71c10748bfc2a173d60dca878d3a678a8485a",
"url": "https://fuchsia.googlesource.com/integration/+/fdc71c10748bfc2a173d60dca878d3a678a8485a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c69279eeea489b89e76d340b9ef295b1a2c75872"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c69279eeea489b89e76d340b9ef295b1a2c75872",
"title": "c69279eeea489b89e76d340b9ef295b1a2c75872",
"url": "https://fuchsia.googlesource.com/integration/+/c69279eeea489b89e76d340b9ef295b1a2c75872"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "db153641d3adec43be30c35e91cbda8b06f93b61"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@db153641d3adec43be30c35e91cbda8b06f93b61",
"title": "db153641d3adec43be30c35e91cbda8b06f93b61",
"url": "https://fuchsia.googlesource.com/integration/+/db153641d3adec43be30c35e91cbda8b06f93b61"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aaae5ff9d1beec937031f62e7e93d55c5cefddb6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aaae5ff9d1beec937031f62e7e93d55c5cefddb6",
"title": "aaae5ff9d1beec937031f62e7e93d55c5cefddb6",
"url": "https://fuchsia.googlesource.com/integration/+/aaae5ff9d1beec937031f62e7e93d55c5cefddb6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1bae39066e7f77e9e068fa52e64691b01457e3d9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1bae39066e7f77e9e068fa52e64691b01457e3d9",
"title": "1bae39066e7f77e9e068fa52e64691b01457e3d9",
"url": "https://fuchsia.googlesource.com/integration/+/1bae39066e7f77e9e068fa52e64691b01457e3d9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "07416a26f54cc9be793aa7a13101bb509b0e3f23"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@07416a26f54cc9be793aa7a13101bb509b0e3f23",
"title": "07416a26f54cc9be793aa7a13101bb509b0e3f23",
"url": "https://fuchsia.googlesource.com/integration/+/07416a26f54cc9be793aa7a13101bb509b0e3f23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c719abd08ae9fc48775e94c6427fbe8a47c95f91"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c719abd08ae9fc48775e94c6427fbe8a47c95f91",
"title": "c719abd08ae9fc48775e94c6427fbe8a47c95f91",
"url": "https://fuchsia.googlesource.com/integration/+/c719abd08ae9fc48775e94c6427fbe8a47c95f91"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "836a114b1eeae7f6e7d2847ed2606fb9ed26c279"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@836a114b1eeae7f6e7d2847ed2606fb9ed26c279",
"title": "836a114b1eeae7f6e7d2847ed2606fb9ed26c279",
"url": "https://fuchsia.googlesource.com/integration/+/836a114b1eeae7f6e7d2847ed2606fb9ed26c279"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0921a12edb1629582fc6494e0c3c415b133bd072"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0921a12edb1629582fc6494e0c3c415b133bd072",
"title": "0921a12edb1629582fc6494e0c3c415b133bd072",
"url": "https://fuchsia.googlesource.com/integration/+/0921a12edb1629582fc6494e0c3c415b133bd072"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cefa392ffd73e398c53f0391eac69dd55162edad"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cefa392ffd73e398c53f0391eac69dd55162edad",
"title": "cefa392ffd73e398c53f0391eac69dd55162edad",
"url": "https://fuchsia.googlesource.com/integration/+/cefa392ffd73e398c53f0391eac69dd55162edad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "38c973ae0c6f37afa82e454f2d5766f455a63916"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@38c973ae0c6f37afa82e454f2d5766f455a63916",
"title": "38c973ae0c6f37afa82e454f2d5766f455a63916",
"url": "https://fuchsia.googlesource.com/integration/+/38c973ae0c6f37afa82e454f2d5766f455a63916"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "613512bce8bdb121e3a6bb6d427c9fa652999f26"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@613512bce8bdb121e3a6bb6d427c9fa652999f26",
"title": "613512bce8bdb121e3a6bb6d427c9fa652999f26",
"url": "https://fuchsia.googlesource.com/integration/+/613512bce8bdb121e3a6bb6d427c9fa652999f26"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d7ba5ec1b620f2654bd97cd3de583c6cd4b822e5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d7ba5ec1b620f2654bd97cd3de583c6cd4b822e5",
"title": "d7ba5ec1b620f2654bd97cd3de583c6cd4b822e5",
"url": "https://fuchsia.googlesource.com/integration/+/d7ba5ec1b620f2654bd97cd3de583c6cd4b822e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "149ef7ea466ecd462843f2c3d6b1304a0fbba89f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@149ef7ea466ecd462843f2c3d6b1304a0fbba89f",
"title": "149ef7ea466ecd462843f2c3d6b1304a0fbba89f",
"url": "https://fuchsia.googlesource.com/integration/+/149ef7ea466ecd462843f2c3d6b1304a0fbba89f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6b7ffff280be029b91100f4dc50e9903a4803424"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6b7ffff280be029b91100f4dc50e9903a4803424",
"title": "6b7ffff280be029b91100f4dc50e9903a4803424",
"url": "https://fuchsia.googlesource.com/integration/+/6b7ffff280be029b91100f4dc50e9903a4803424"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5c1600795391597f4c54bc590cdff0a0bc40e642"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5c1600795391597f4c54bc590cdff0a0bc40e642",
"title": "5c1600795391597f4c54bc590cdff0a0bc40e642",
"url": "https://fuchsia.googlesource.com/integration/+/5c1600795391597f4c54bc590cdff0a0bc40e642"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5b1a4a797d306b8c906cb29f8139c7dfaaac5bb3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5b1a4a797d306b8c906cb29f8139c7dfaaac5bb3",
"title": "5b1a4a797d306b8c906cb29f8139c7dfaaac5bb3",
"url": "https://fuchsia.googlesource.com/integration/+/5b1a4a797d306b8c906cb29f8139c7dfaaac5bb3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d7d8e7f911aed6b1f1a5642e2efcae5ad066c864"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d7d8e7f911aed6b1f1a5642e2efcae5ad066c864",
"title": "d7d8e7f911aed6b1f1a5642e2efcae5ad066c864",
"url": "https://fuchsia.googlesource.com/integration/+/d7d8e7f911aed6b1f1a5642e2efcae5ad066c864"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8f2c39fc07d2253c483d3eca774ca64cfd942de1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8f2c39fc07d2253c483d3eca774ca64cfd942de1",
"title": "8f2c39fc07d2253c483d3eca774ca64cfd942de1",
"url": "https://fuchsia.googlesource.com/integration/+/8f2c39fc07d2253c483d3eca774ca64cfd942de1"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8f2c39fc07d2253c483d3eca774ca64cfd942de1",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8833190520192152560"
},
{
"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"
}
}
[18:48:13.474] Scheduled build:
{
"id": "8667760457546693953",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-balanced"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-16T18:48:13.084858190Z",
"updateTime": "2026-10-16T18:48:13.084858190Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8f2c39fc07d2253c483d3eca774ca64cfd942de1",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:48:13.474] Task URL: https://cr-buildbucket.appspot.com/build/8667760457546693953
[18:48:13.474] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:2:0) after 4m40s
[18:48:14.590] Received PubSub notification, asking Buildbucket for the build status
[18:48:14.616] Build status: SCHEDULED
[18:48:17.798] Received PubSub notification, asking Buildbucket for the build status
[18:48:17.816] Build status: STARTED
[18:52:53.503] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:2:0)
[18:52:53.581] Build status: STARTED
[18:52:53.581] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:5:0) after 3m4s
[18:55:57.664] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:5:0)
[18:55:57.690] Build status: STARTED
[18:55:57.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:6:0) after 5m28s
[19:01:25.715] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:6:0)
[19:01:25.739] Build status: STARTED
[19:01:25.739] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:7:0) after 4m27s
[19:05:52.742] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:7:0)
[19:05:52.825] Build status: STARTED
[19:05:52.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:8:0) after 4m31s
[19:10:23.839] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:8:0)
[19:10:23.870] Build status: STARTED
[19:10:23.870] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:9:0) after 4m25s
[19:14:48.884] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:9:0)
[19:14:48.904] Build status: STARTED
[19:14:48.904] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:10:0) after 4m55s
[19:19:44.138] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:10:0)
[19:19:44.157] Build status: STARTED
[19:19:44.157] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:11:0) after 7m30s
[19:27:14.276] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:11:0)
[19:27:14.297] Build status: STARTED
[19:27:14.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:12:0) after 3m43s
[19:30:57.392] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:12:0)
[19:30:57.439] Build status: STARTED
[19:30:57.439] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:13:0) after 2m29s
[19:33:26.523] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:13:0)
[19:33:26.548] Build status: STARTED
[19:33:26.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:14:0) after 6m37s
[19:40:03.598] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:14:0)
[19:40:03.681] Build status: STARTED
[19:40:03.681] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:15:0) after 6m41s
[19:46:44.730] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:15:0)
[19:46:44.789] Build status: STARTED
[19:46:44.789] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:16:0) after 3m7s
[19:49:51.871] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:16:0)
[19:49:51.999] Build status: STARTED
[19:49:51.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:17:0) after 6m59s
[19:56:51.028] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:17:0)
[19:56:51.047] Build status: STARTED
[19:56:51.047] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:18:0) after 7m50s
[20:04:41.136] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:18:0)
[20:04:41.164] Build status: STARTED
[20:04:41.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:19:0) after 7m42s
[20:12:23.407] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:19:0)
[20:12:23.426] Build status: STARTED
[20:12:23.426] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:20:0) after 2m32s
[20:14:55.428] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:20:0)
[20:14:55.465] Build status: STARTED
[20:14:55.466] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-balanced-e5a0ec7f:8833190520192152560:21:0) after 3m39s
[20:17:10.891] Received PubSub notification, asking Buildbucket for the build status
[20:17:10.915] Build:
{
"id": "8667760457546693953",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-balanced"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-16T18:48:13.084858190Z",
"startTime": "2026-10-16T18:48:17.606922163Z",
"endTime": "2026-10-16T20:17:10.289243100Z",
"updateTime": "2026-10-16T20:17:10.289243100Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8f2c39fc07d2253c483d3eca774ca64cfd942de1",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:17:10.915] Invocation finished in 1h28m59.737340125s with status SUCCEEDED