[20:54:14.661] New invocation is queued and will start shortly
[20:54:15.982] Starting the invocation (attempt 1)
[20:54:16.009] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/b73528ca4918b1cb3fa911188a2feaf1dc0e1224"
[20:54:16.009] Popped gitiles commit info from properties and tags
[20:54:16.009] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:54:16.011] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:54:16.011] Buildbucket request:
{
"requestId": "8922692392121117328",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-ffx_subtools"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8922692392121117328",
"job": "fuchsia/core.x64-release-ffx_subtools-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a3bda16abb91196a7f6ea989042ddefbba9a9b78"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a3bda16abb91196a7f6ea989042ddefbba9a9b78",
"title": "a3bda16abb91196a7f6ea989042ddefbba9a9b78",
"url": "https://fuchsia.googlesource.com/integration/+/a3bda16abb91196a7f6ea989042ddefbba9a9b78"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0e02e10f00a502ff1e6a5822780d9141b262efde"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0e02e10f00a502ff1e6a5822780d9141b262efde",
"title": "0e02e10f00a502ff1e6a5822780d9141b262efde",
"url": "https://fuchsia.googlesource.com/integration/+/0e02e10f00a502ff1e6a5822780d9141b262efde"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "16cb8719b7ac0567b2973f849009a1c49026647a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@16cb8719b7ac0567b2973f849009a1c49026647a",
"title": "16cb8719b7ac0567b2973f849009a1c49026647a",
"url": "https://fuchsia.googlesource.com/integration/+/16cb8719b7ac0567b2973f849009a1c49026647a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "57af8915ffbf8dd06a3d6552683171b4a4d5119b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@57af8915ffbf8dd06a3d6552683171b4a4d5119b",
"title": "57af8915ffbf8dd06a3d6552683171b4a4d5119b",
"url": "https://fuchsia.googlesource.com/integration/+/57af8915ffbf8dd06a3d6552683171b4a4d5119b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "36685ca46e65acbfeded3e182670ec3785972009"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@36685ca46e65acbfeded3e182670ec3785972009",
"title": "36685ca46e65acbfeded3e182670ec3785972009",
"url": "https://fuchsia.googlesource.com/integration/+/36685ca46e65acbfeded3e182670ec3785972009"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "370aa9c446f3d4a28e63e9290eb74fa901ed596e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@370aa9c446f3d4a28e63e9290eb74fa901ed596e",
"title": "370aa9c446f3d4a28e63e9290eb74fa901ed596e",
"url": "https://fuchsia.googlesource.com/integration/+/370aa9c446f3d4a28e63e9290eb74fa901ed596e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a060ea238c8ce0b374f8ab3a44d4dcb480355a2a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a060ea238c8ce0b374f8ab3a44d4dcb480355a2a",
"title": "a060ea238c8ce0b374f8ab3a44d4dcb480355a2a",
"url": "https://fuchsia.googlesource.com/integration/+/a060ea238c8ce0b374f8ab3a44d4dcb480355a2a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "afbbf3bd3034756f85b31963c29dfb4624fbf70e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@afbbf3bd3034756f85b31963c29dfb4624fbf70e",
"title": "afbbf3bd3034756f85b31963c29dfb4624fbf70e",
"url": "https://fuchsia.googlesource.com/integration/+/afbbf3bd3034756f85b31963c29dfb4624fbf70e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1b2e4a04bef3bfdd01f94d39c8aae6d5c29915e5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1b2e4a04bef3bfdd01f94d39c8aae6d5c29915e5",
"title": "1b2e4a04bef3bfdd01f94d39c8aae6d5c29915e5",
"url": "https://fuchsia.googlesource.com/integration/+/1b2e4a04bef3bfdd01f94d39c8aae6d5c29915e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "032be87e6aa6788b7e764373427471165d54c214"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@032be87e6aa6788b7e764373427471165d54c214",
"title": "032be87e6aa6788b7e764373427471165d54c214",
"url": "https://fuchsia.googlesource.com/integration/+/032be87e6aa6788b7e764373427471165d54c214"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9192098b6ab6bc592bf12e1624f09688ebf43645"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9192098b6ab6bc592bf12e1624f09688ebf43645",
"title": "9192098b6ab6bc592bf12e1624f09688ebf43645",
"url": "https://fuchsia.googlesource.com/integration/+/9192098b6ab6bc592bf12e1624f09688ebf43645"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "454ef79a9906df26bbca415e7ce4543968f5e33c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@454ef79a9906df26bbca415e7ce4543968f5e33c",
"title": "454ef79a9906df26bbca415e7ce4543968f5e33c",
"url": "https://fuchsia.googlesource.com/integration/+/454ef79a9906df26bbca415e7ce4543968f5e33c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7043138362e4bda904927bbdae242a5a6a88c536"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7043138362e4bda904927bbdae242a5a6a88c536",
"title": "7043138362e4bda904927bbdae242a5a6a88c536",
"url": "https://fuchsia.googlesource.com/integration/+/7043138362e4bda904927bbdae242a5a6a88c536"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "642cff118391f0b6b69d926b748155849c0899ec"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@642cff118391f0b6b69d926b748155849c0899ec",
"title": "642cff118391f0b6b69d926b748155849c0899ec",
"url": "https://fuchsia.googlesource.com/integration/+/642cff118391f0b6b69d926b748155849c0899ec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0dd9dd047206216070a272d2c673791ed39a7bc0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0dd9dd047206216070a272d2c673791ed39a7bc0",
"title": "0dd9dd047206216070a272d2c673791ed39a7bc0",
"url": "https://fuchsia.googlesource.com/integration/+/0dd9dd047206216070a272d2c673791ed39a7bc0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3e0e6d4bc58baea8c5b0ec51954a502fa6de212c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3e0e6d4bc58baea8c5b0ec51954a502fa6de212c",
"title": "3e0e6d4bc58baea8c5b0ec51954a502fa6de212c",
"url": "https://fuchsia.googlesource.com/integration/+/3e0e6d4bc58baea8c5b0ec51954a502fa6de212c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "033f9d7e359ad34d7a39eeede155ab9615dc08ff"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@033f9d7e359ad34d7a39eeede155ab9615dc08ff",
"title": "033f9d7e359ad34d7a39eeede155ab9615dc08ff",
"url": "https://fuchsia.googlesource.com/integration/+/033f9d7e359ad34d7a39eeede155ab9615dc08ff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "038b4b6066a1ff4ba3258e544d33fbe21ad19585"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@038b4b6066a1ff4ba3258e544d33fbe21ad19585",
"title": "038b4b6066a1ff4ba3258e544d33fbe21ad19585",
"url": "https://fuchsia.googlesource.com/integration/+/038b4b6066a1ff4ba3258e544d33fbe21ad19585"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5191d662b8066a923619667c292f5903ce9bb34a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5191d662b8066a923619667c292f5903ce9bb34a",
"title": "5191d662b8066a923619667c292f5903ce9bb34a",
"url": "https://fuchsia.googlesource.com/integration/+/5191d662b8066a923619667c292f5903ce9bb34a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a5ea04920fd2d95b307ff65dd3d0d8a900a9969d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a5ea04920fd2d95b307ff65dd3d0d8a900a9969d",
"title": "a5ea04920fd2d95b307ff65dd3d0d8a900a9969d",
"url": "https://fuchsia.googlesource.com/integration/+/a5ea04920fd2d95b307ff65dd3d0d8a900a9969d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cc9eb9a456b6409831464e09ad7c00ef9e20373f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cc9eb9a456b6409831464e09ad7c00ef9e20373f",
"title": "cc9eb9a456b6409831464e09ad7c00ef9e20373f",
"url": "https://fuchsia.googlesource.com/integration/+/cc9eb9a456b6409831464e09ad7c00ef9e20373f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "27d13833f261f944ea858445cfb31e9c604a9f20"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@27d13833f261f944ea858445cfb31e9c604a9f20",
"title": "27d13833f261f944ea858445cfb31e9c604a9f20",
"url": "https://fuchsia.googlesource.com/integration/+/27d13833f261f944ea858445cfb31e9c604a9f20"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b73528ca4918b1cb3fa911188a2feaf1dc0e1224"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b73528ca4918b1cb3fa911188a2feaf1dc0e1224",
"title": "b73528ca4918b1cb3fa911188a2feaf1dc0e1224",
"url": "https://fuchsia.googlesource.com/integration/+/b73528ca4918b1cb3fa911188a2feaf1dc0e1224"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b73528ca4918b1cb3fa911188a2feaf1dc0e1224",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8922692392121117328"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-release-ffx_subtools-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:54:16.946] Scheduled build:
{
"id": "8757262329972848737",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-ffx_subtools"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-01T20:54:16.080479309Z",
"updateTime": "2024-02-01T20:54:16.080479309Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b73528ca4918b1cb3fa911188a2feaf1dc0e1224",
"ref": "refs/heads/main"
}
}
}
[20:54:16.946] Task URL: https://cr-buildbucket.appspot.com/build/8757262329972848737
[20:54:16.946] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:2:0) after 7m56s
[20:54:17.544] Received PubSub notification, asking Buildbucket for the build status
[20:54:17.575] Build status: SCHEDULED
[20:56:17.640] Received PubSub notification, asking Buildbucket for the build status
[20:56:17.676] Build status: STARTED
[21:02:12.962] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:2:0)
[21:02:12.995] Build status: STARTED
[21:02:12.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:5:0) after 8m11s
[21:10:24.080] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:5:0)
[21:10:24.108] Build status: STARTED
[21:10:24.108] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:6:0) after 5m52s
[21:16:16.197] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:6:0)
[21:16:16.223] Build status: STARTED
[21:16:16.223] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:7:0) after 5m40s
[21:21:56.266] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:7:0)
[21:21:56.295] Build status: STARTED
[21:21:56.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:8:0) after 2m46s
[21:24:42.325] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:8:0)
[21:24:42.362] Build status: STARTED
[21:24:42.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:9:0) after 1m9s
[21:25:51.333] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:9:0)
[21:25:51.414] Build status: STARTED
[21:25:51.414] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:10:0) after 7m50s
[21:33:41.533] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:10:0)
[21:33:41.570] Build status: STARTED
[21:33:41.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:11:0) after 9m43s
[21:43:24.599] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:11:0)
[21:43:24.622] Build status: STARTED
[21:43:24.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:12:0) after 3m47s
[21:47:11.716] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:12:0)
[21:47:11.732] Build status: STARTED
[21:47:11.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:13:0) after 3m19s
[21:50:30.750] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:13:0)
[21:50:30.775] Build status: STARTED
[21:50:30.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:14:0) after 2m11s
[21:52:41.855] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:14:0)
[21:52:41.873] Build status: STARTED
[21:52:41.873] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:15:0) after 8m1s
[22:00:42.954] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:15:0)
[22:00:43.032] Build status: STARTED
[22:00:43.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:16:0) after 1m49s
[22:02:32.085] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:16:0)
[22:02:32.131] Build status: STARTED
[22:02:32.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-ffx_subtools-e5a0ec7f:8922692392121117328:17:0) after 3m15s
[22:03:27.485] Received PubSub notification, asking Buildbucket for the build status
[22:03:27.508] Build:
{
"id": "8757262329972848737",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-ffx_subtools"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-01T20:54:16.080479309Z",
"startTime": "2024-02-01T20:56:16.932624Z",
"endTime": "2024-02-01T22:03:25.793605Z",
"updateTime": "2024-02-01T22:03:25.793605Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b73528ca4918b1cb3fa911188a2feaf1dc0e1224",
"ref": "refs/heads/main"
}
}
}
[22:03:27.508] Invocation finished in 1h9m12.860380519s with status SUCCEEDED