[01:41:37.152] New invocation is queued and will start shortly
[01:41:38.289] Starting the invocation (attempt 1)
[01:41:38.325] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/9e6348d82036058c99a021a8b46aaf1c323a5e47"
[01:41:38.325] Popped gitiles commit info from properties and tags
[01:41:38.325] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:41:38.325] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:41:38.326] Buildbucket request:
{
"requestId": "8888972240560028336",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-lto-no_rbe-build_only"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8888972240560028336",
"job": "fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0de6f3446b5c2edd6e1fbd3f7e32d65744b99582"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0de6f3446b5c2edd6e1fbd3f7e32d65744b99582",
"title": "0de6f3446b5c2edd6e1fbd3f7e32d65744b99582",
"url": "https://fuchsia.googlesource.com/integration/+/0de6f3446b5c2edd6e1fbd3f7e32d65744b99582"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c6c5234f642cc5065ea5b51ed6cd0c097291ec5e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c6c5234f642cc5065ea5b51ed6cd0c097291ec5e",
"title": "c6c5234f642cc5065ea5b51ed6cd0c097291ec5e",
"url": "https://fuchsia.googlesource.com/integration/+/c6c5234f642cc5065ea5b51ed6cd0c097291ec5e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "50081b22bb8acfe0e949579b5fda7df5a6a23559"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@50081b22bb8acfe0e949579b5fda7df5a6a23559",
"title": "50081b22bb8acfe0e949579b5fda7df5a6a23559",
"url": "https://fuchsia.googlesource.com/integration/+/50081b22bb8acfe0e949579b5fda7df5a6a23559"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8456baa9bc9cd5076a1eead2d701d55834bb6d21"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8456baa9bc9cd5076a1eead2d701d55834bb6d21",
"title": "8456baa9bc9cd5076a1eead2d701d55834bb6d21",
"url": "https://fuchsia.googlesource.com/integration/+/8456baa9bc9cd5076a1eead2d701d55834bb6d21"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a52fb354c3fb768359a4eee745aaf49ff41faf67"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a52fb354c3fb768359a4eee745aaf49ff41faf67",
"title": "a52fb354c3fb768359a4eee745aaf49ff41faf67",
"url": "https://fuchsia.googlesource.com/integration/+/a52fb354c3fb768359a4eee745aaf49ff41faf67"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "07762284faa229962e058fb018edc23bbd6c79e6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@07762284faa229962e058fb018edc23bbd6c79e6",
"title": "07762284faa229962e058fb018edc23bbd6c79e6",
"url": "https://fuchsia.googlesource.com/integration/+/07762284faa229962e058fb018edc23bbd6c79e6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "06b4409841840cf0d9182c41a985b1962a98c2c1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@06b4409841840cf0d9182c41a985b1962a98c2c1",
"title": "06b4409841840cf0d9182c41a985b1962a98c2c1",
"url": "https://fuchsia.googlesource.com/integration/+/06b4409841840cf0d9182c41a985b1962a98c2c1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0bff6f14beef57863aaf026527a097013bc5f564"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0bff6f14beef57863aaf026527a097013bc5f564",
"title": "0bff6f14beef57863aaf026527a097013bc5f564",
"url": "https://fuchsia.googlesource.com/integration/+/0bff6f14beef57863aaf026527a097013bc5f564"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e51361eb7c578fd30a1256c7afbc4ad3b71224a0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e51361eb7c578fd30a1256c7afbc4ad3b71224a0",
"title": "e51361eb7c578fd30a1256c7afbc4ad3b71224a0",
"url": "https://fuchsia.googlesource.com/integration/+/e51361eb7c578fd30a1256c7afbc4ad3b71224a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dd638be0f2e91c2799e0aeb08a7a623e6023044b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dd638be0f2e91c2799e0aeb08a7a623e6023044b",
"title": "dd638be0f2e91c2799e0aeb08a7a623e6023044b",
"url": "https://fuchsia.googlesource.com/integration/+/dd638be0f2e91c2799e0aeb08a7a623e6023044b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "735fa3f49175a0dca3f75f9346304c7c0706ddb2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@735fa3f49175a0dca3f75f9346304c7c0706ddb2",
"title": "735fa3f49175a0dca3f75f9346304c7c0706ddb2",
"url": "https://fuchsia.googlesource.com/integration/+/735fa3f49175a0dca3f75f9346304c7c0706ddb2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9e6348d82036058c99a021a8b46aaf1c323a5e47"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9e6348d82036058c99a021a8b46aaf1c323a5e47",
"title": "9e6348d82036058c99a021a8b46aaf1c323a5e47",
"url": "https://fuchsia.googlesource.com/integration/+/9e6348d82036058c99a021a8b46aaf1c323a5e47"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9e6348d82036058c99a021a8b46aaf1c323a5e47",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8888972240560028336"
},
{
"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"
}
}
[01:41:38.685] Scheduled build:
{
"id": "8723542178604665569",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-lto-no_rbe-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-08T01:41:38.386417026Z",
"updateTime": "2025-02-08T01:41:38.386417026Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9e6348d82036058c99a021a8b46aaf1c323a5e47",
"ref": "refs/heads/main"
}
}
}
[01:41:38.685] Task URL: https://cr-buildbucket.appspot.com/build/8723542178604665569
[01:41:38.685] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:2:0) after 5m38s
[01:41:39.674] Received PubSub notification, asking Buildbucket for the build status
[01:41:39.692] Build status: SCHEDULED
[01:41:45.386] Received PubSub notification, asking Buildbucket for the build status
[01:41:45.411] Build status: STARTED
[01:47:16.768] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:2:0)
[01:47:16.790] Build status: STARTED
[01:47:16.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:5:0) after 7m1s
[01:54:17.818] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:5:0)
[01:54:17.842] Build status: STARTED
[01:54:17.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:6:0) after 5m13s
[01:59:30.871] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:6:0)
[01:59:30.969] Build status: STARTED
[01:59:30.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:7:0) after 4m31s
[02:04:01.995] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:7:0)
[02:04:02.025] Build status: STARTED
[02:04:02.025] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:8:0) after 5m40s
[02:09:42.000] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:8:0)
[02:09:42.032] Build status: STARTED
[02:09:42.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:9:0) after 6m43s
[02:16:25.159] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:9:0)
[02:16:25.178] Build status: STARTED
[02:16:25.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:10:0) after 3m33s
[02:19:58.201] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:10:0)
[02:19:58.225] Build status: STARTED
[02:19:58.225] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:11:0) after 3m24s
[02:23:22.414] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:11:0)
[02:23:22.470] Build status: STARTED
[02:23:22.470] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:12:0) after 1m35s
[02:24:57.509] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:12:0)
[02:24:57.534] Build status: STARTED
[02:24:57.534] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:13:0) after 3m48s
[02:28:45.568] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:13:0)
[02:28:45.595] Build status: STARTED
[02:28:45.595] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:14:0) after 2m24s
[02:31:09.601] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:14:0)
[02:31:09.664] Build status: STARTED
[02:31:09.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:15:0) after 9m52s
[02:41:01.684] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:15:0)
[02:41:01.715] Build status: STARTED
[02:41:01.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:16:0) after 2m31s
[02:43:32.740] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:16:0)
[02:43:32.767] Build status: STARTED
[02:43:32.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:17:0) after 8m4s
[02:51:36.797] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:17:0)
[02:51:36.823] Build status: STARTED
[02:51:36.823] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:18:0) after 8m5s
[02:59:41.816] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:18:0)
[02:59:41.832] Build status: STARTED
[02:59:41.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:19:0) after 8m19s
[03:08:00.981] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:19:0)
[03:08:01.034] Build status: STARTED
[03:08:01.034] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:20:0) after 6m31s
[03:14:32.129] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:20:0)
[03:14:32.145] Build status: STARTED
[03:14:32.145] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:21:0) after 7m14s
[03:21:46.202] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:21:0)
[03:21:46.217] Build status: STARTED
[03:21:46.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:22:0) after 8m24s
[03:30:10.279] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:22:0)
[03:30:10.294] Build status: STARTED
[03:30:10.294] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8888972240560028336:23:0) after 8m58s
[03:34:15.844] Received PubSub notification, asking Buildbucket for the build status
[03:34:15.888] Build:
{
"id": "8723542178604665569",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-lto-no_rbe-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-08T01:41:38.386417026Z",
"startTime": "2025-02-08T01:41:45.164261100Z",
"endTime": "2025-02-08T03:34:14.947760309Z",
"updateTime": "2025-02-08T03:34:14.947760309Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9e6348d82036058c99a021a8b46aaf1c323a5e47",
"ref": "refs/heads/main"
}
}
}
[03:34:15.889] Invocation finished in 1h52m38.751082072s with status SUCCEEDED