[20:27:05.211] New invocation is queued and will start shortly
[20:27:06.264] Starting the invocation (attempt 1)
[20:27:06.298] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/5b3e80be841c87abbf4ec8bbd56a0d9328b7bec5"
[20:27:06.298] Popped gitiles commit info from properties and tags
[20:27:06.298] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:27:06.299] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:27:06.299] Buildbucket request:
{
"requestId": "8906839631602541952",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-lto-no_rbe-build_only"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8906839631602541952",
"job": "fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "742d144386aa62ef7fa88289bb94aa02c4b3aba1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@742d144386aa62ef7fa88289bb94aa02c4b3aba1",
"title": "742d144386aa62ef7fa88289bb94aa02c4b3aba1",
"url": "https://fuchsia.googlesource.com/integration/+/742d144386aa62ef7fa88289bb94aa02c4b3aba1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a3dd2d98656aa4485e5658bfe603dd8951b214e5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a3dd2d98656aa4485e5658bfe603dd8951b214e5",
"title": "a3dd2d98656aa4485e5658bfe603dd8951b214e5",
"url": "https://fuchsia.googlesource.com/integration/+/a3dd2d98656aa4485e5658bfe603dd8951b214e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1061efb505fff7db5629f1e97456520152709835"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1061efb505fff7db5629f1e97456520152709835",
"title": "1061efb505fff7db5629f1e97456520152709835",
"url": "https://fuchsia.googlesource.com/integration/+/1061efb505fff7db5629f1e97456520152709835"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bfacd7e17ae98409ac01969448e4d9720d934a76"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bfacd7e17ae98409ac01969448e4d9720d934a76",
"title": "bfacd7e17ae98409ac01969448e4d9720d934a76",
"url": "https://fuchsia.googlesource.com/integration/+/bfacd7e17ae98409ac01969448e4d9720d934a76"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0cf79f003b34d778600a55a38a537bce8f2d22fc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0cf79f003b34d778600a55a38a537bce8f2d22fc",
"title": "0cf79f003b34d778600a55a38a537bce8f2d22fc",
"url": "https://fuchsia.googlesource.com/integration/+/0cf79f003b34d778600a55a38a537bce8f2d22fc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8f5fe1e101bd8e5e20b4a58c3e32e5898065d700"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8f5fe1e101bd8e5e20b4a58c3e32e5898065d700",
"title": "8f5fe1e101bd8e5e20b4a58c3e32e5898065d700",
"url": "https://fuchsia.googlesource.com/integration/+/8f5fe1e101bd8e5e20b4a58c3e32e5898065d700"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "59e5b67f31e7f79526b0d553fa2aea43898bd346"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@59e5b67f31e7f79526b0d553fa2aea43898bd346",
"title": "59e5b67f31e7f79526b0d553fa2aea43898bd346",
"url": "https://fuchsia.googlesource.com/integration/+/59e5b67f31e7f79526b0d553fa2aea43898bd346"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dbe6b64a06d4b2438e6975b12decd0f55f80f6e5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dbe6b64a06d4b2438e6975b12decd0f55f80f6e5",
"title": "dbe6b64a06d4b2438e6975b12decd0f55f80f6e5",
"url": "https://fuchsia.googlesource.com/integration/+/dbe6b64a06d4b2438e6975b12decd0f55f80f6e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ef128fcd7b23b20b1d8ab825db85b5410b163e60"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ef128fcd7b23b20b1d8ab825db85b5410b163e60",
"title": "ef128fcd7b23b20b1d8ab825db85b5410b163e60",
"url": "https://fuchsia.googlesource.com/integration/+/ef128fcd7b23b20b1d8ab825db85b5410b163e60"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5b3e80be841c87abbf4ec8bbd56a0d9328b7bec5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5b3e80be841c87abbf4ec8bbd56a0d9328b7bec5",
"title": "5b3e80be841c87abbf4ec8bbd56a0d9328b7bec5",
"url": "https://fuchsia.googlesource.com/integration/+/5b3e80be841c87abbf4ec8bbd56a0d9328b7bec5"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5b3e80be841c87abbf4ec8bbd56a0d9328b7bec5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8906839631602541952"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:27:06.953] Scheduled build:
{
"id": "8741409569676477697",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-lto-no_rbe-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-25T20:27:06.419459642Z",
"updateTime": "2024-07-25T20:27:06.419459642Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5b3e80be841c87abbf4ec8bbd56a0d9328b7bec5",
"ref": "refs/heads/main"
}
}
}
[20:27:06.953] Task URL: https://cr-buildbucket.appspot.com/build/8741409569676477697
[20:27:06.953] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:2:0) after 8m30s
[20:27:07.884] Received PubSub notification, asking Buildbucket for the build status
[20:27:07.901] Build status: SCHEDULED
[20:27:12.155] Received PubSub notification, asking Buildbucket for the build status
[20:27:12.173] Build status: STARTED
[20:35:37.024] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:2:0)
[20:35:37.043] Build status: STARTED
[20:35:37.043] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:5:0) after 8m13s
[20:43:50.010] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:5:0)
[20:43:50.026] Build status: STARTED
[20:43:50.026] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:6:0) after 2m33s
[20:46:22.999] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:6:0)
[20:46:23.019] Build status: STARTED
[20:46:23.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:7:0) after 7m32s
[20:53:55.040] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:7:0)
[20:53:55.056] Build status: STARTED
[20:53:55.056] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:8:0) after 8m16s
[21:02:11.168] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:8:0)
[21:02:11.198] Build status: STARTED
[21:02:11.198] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:9:0) after 5m48s
[21:07:59.223] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:9:0)
[21:07:59.271] Build status: STARTED
[21:07:59.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:10:0) after 6m46s
[21:14:45.408] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:10:0)
[21:14:45.433] Build status: STARTED
[21:14:45.433] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:11:0) after 9m33s
[21:24:18.474] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:11:0)
[21:24:18.496] Build status: STARTED
[21:24:18.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:12:0) after 4m24s
[21:28:42.537] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:12:0)
[21:28:42.553] Build status: STARTED
[21:28:42.553] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:13:0) after 1m54s
[21:30:36.616] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:13:0)
[21:30:36.640] Build status: STARTED
[21:30:36.640] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:14:0) after 4m25s
[21:35:01.662] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:14:0)
[21:35:01.678] Build status: STARTED
[21:35:01.678] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:15:0) after 6m24s
[21:41:25.751] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:15:0)
[21:41:25.769] Build status: STARTED
[21:41:25.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:16:0) after 1m58s
[21:43:23.788] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:16:0)
[21:43:23.811] Build status: STARTED
[21:43:23.811] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:17:0) after 5m2s
[21:48:25.785] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:17:0)
[21:48:25.843] Build status: STARTED
[21:48:25.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:18:0) after 5m3s
[21:53:28.871] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:18:0)
[21:53:28.891] Build status: STARTED
[21:53:28.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:19:0) after 1m50s
[21:55:18.884] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:19:0)
[21:55:18.906] Build status: STARTED
[21:55:18.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:20:0) after 9m27s
[22:04:45.928] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:20:0)
[22:04:45.985] Build status: STARTED
[22:04:45.985] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:21:0) after 1m22s
[22:06:08.006] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:21:0)
[22:06:08.029] Build status: STARTED
[22:06:08.029] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:22:0) after 6m27s
[22:12:35.046] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:22:0)
[22:12:35.063] Build status: STARTED
[22:12:35.063] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:23:0) after 2m36s
[22:15:11.090] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:23:0)
[22:15:11.116] Build status: STARTED
[22:15:11.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:24:0) after 4m19s
[22:19:30.134] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:24:0)
[22:19:30.151] Build status: STARTED
[22:19:30.151] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:25:0) after 9m36s
[22:29:06.223] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:25:0)
[22:29:06.246] Build status: STARTED
[22:29:06.246] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906839631602541952:26:0) after 9m13s
[22:37:43.669] Received PubSub notification, asking Buildbucket for the build status
[22:37:43.687] Build:
{
"id": "8741409569676477697",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-lto-no_rbe-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-25T20:27:06.419459642Z",
"startTime": "2024-07-25T20:27:11.259730872Z",
"endTime": "2024-07-25T22:37:38.504880195Z",
"updateTime": "2024-07-25T22:37:38.504880195Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5b3e80be841c87abbf4ec8bbd56a0d9328b7bec5",
"ref": "refs/heads/main"
}
}
}
[22:37:43.687] Invocation finished in 2h10m38.488219181s with status SUCCEEDED