[02:48:13.421] New invocation is queued and will start shortly
[02:48:14.550] Starting the invocation (attempt 1)
[02:48:14.580] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/d2a7fea25649c7124568fc8902e81c1bc531625c"
[02:48:14.580] Popped gitiles commit info from properties and tags
[02:48:14.580] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:48:14.580] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:48:14.580] Buildbucket request:
{
"requestId": "8882173277685752800",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-coverage"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8882173277685752800",
"job": "fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6ee953cad5802a2de1ca73df6507a9aceb44b092"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6ee953cad5802a2de1ca73df6507a9aceb44b092",
"title": "6ee953cad5802a2de1ca73df6507a9aceb44b092",
"url": "https://fuchsia.googlesource.com/integration/+/6ee953cad5802a2de1ca73df6507a9aceb44b092"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d974887c6be39c316f5da2983ead215b8dd6a20f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d974887c6be39c316f5da2983ead215b8dd6a20f",
"title": "d974887c6be39c316f5da2983ead215b8dd6a20f",
"url": "https://fuchsia.googlesource.com/integration/+/d974887c6be39c316f5da2983ead215b8dd6a20f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fc1b8684b025379fa8ee72294469b814e369e34b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fc1b8684b025379fa8ee72294469b814e369e34b",
"title": "fc1b8684b025379fa8ee72294469b814e369e34b",
"url": "https://fuchsia.googlesource.com/integration/+/fc1b8684b025379fa8ee72294469b814e369e34b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b05640322dc0ceb753d339eff37c838402eee06e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b05640322dc0ceb753d339eff37c838402eee06e",
"title": "b05640322dc0ceb753d339eff37c838402eee06e",
"url": "https://fuchsia.googlesource.com/integration/+/b05640322dc0ceb753d339eff37c838402eee06e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3d3f767920b0995d9bf4521d809686dd87d4c725"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3d3f767920b0995d9bf4521d809686dd87d4c725",
"title": "3d3f767920b0995d9bf4521d809686dd87d4c725",
"url": "https://fuchsia.googlesource.com/integration/+/3d3f767920b0995d9bf4521d809686dd87d4c725"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "50190a4dc32756ff4b23270a3dfb485c60c2d31b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@50190a4dc32756ff4b23270a3dfb485c60c2d31b",
"title": "50190a4dc32756ff4b23270a3dfb485c60c2d31b",
"url": "https://fuchsia.googlesource.com/integration/+/50190a4dc32756ff4b23270a3dfb485c60c2d31b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fddd0dc4f1bf2772465748348b7f0fc2e6b5a392"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fddd0dc4f1bf2772465748348b7f0fc2e6b5a392",
"title": "fddd0dc4f1bf2772465748348b7f0fc2e6b5a392",
"url": "https://fuchsia.googlesource.com/integration/+/fddd0dc4f1bf2772465748348b7f0fc2e6b5a392"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9d83da92cf8f21b27a26c749d0bf645c15050ddc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9d83da92cf8f21b27a26c749d0bf645c15050ddc",
"title": "9d83da92cf8f21b27a26c749d0bf645c15050ddc",
"url": "https://fuchsia.googlesource.com/integration/+/9d83da92cf8f21b27a26c749d0bf645c15050ddc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ae03b0abfd600ed1da6fee6a79adff91f50c191a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ae03b0abfd600ed1da6fee6a79adff91f50c191a",
"title": "ae03b0abfd600ed1da6fee6a79adff91f50c191a",
"url": "https://fuchsia.googlesource.com/integration/+/ae03b0abfd600ed1da6fee6a79adff91f50c191a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c3e5dfd394b5e25fa248dfe652b0fad030b9b2cf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c3e5dfd394b5e25fa248dfe652b0fad030b9b2cf",
"title": "c3e5dfd394b5e25fa248dfe652b0fad030b9b2cf",
"url": "https://fuchsia.googlesource.com/integration/+/c3e5dfd394b5e25fa248dfe652b0fad030b9b2cf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b665a89a87178a5fcb8f69e9cb9c0e31cee31a44"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b665a89a87178a5fcb8f69e9cb9c0e31cee31a44",
"title": "b665a89a87178a5fcb8f69e9cb9c0e31cee31a44",
"url": "https://fuchsia.googlesource.com/integration/+/b665a89a87178a5fcb8f69e9cb9c0e31cee31a44"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "42b70ed3ad3a26e769b09fcd35a9b5eb6ce29601"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@42b70ed3ad3a26e769b09fcd35a9b5eb6ce29601",
"title": "42b70ed3ad3a26e769b09fcd35a9b5eb6ce29601",
"url": "https://fuchsia.googlesource.com/integration/+/42b70ed3ad3a26e769b09fcd35a9b5eb6ce29601"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "87176aee904be5a3b63522327564cfc1a78a7419"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@87176aee904be5a3b63522327564cfc1a78a7419",
"title": "87176aee904be5a3b63522327564cfc1a78a7419",
"url": "https://fuchsia.googlesource.com/integration/+/87176aee904be5a3b63522327564cfc1a78a7419"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d2a7fea25649c7124568fc8902e81c1bc531625c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d2a7fea25649c7124568fc8902e81c1bc531625c",
"title": "d2a7fea25649c7124568fc8902e81c1bc531625c",
"url": "https://fuchsia.googlesource.com/integration/+/d2a7fea25649c7124568fc8902e81c1bc531625c"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d2a7fea25649c7124568fc8902e81c1bc531625c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882173277685752800"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:48:14.994] Scheduled build:
{
"id": "8716743215750774913",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-coverage"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-24T02:48:14.638752348Z",
"updateTime": "2025-04-24T02:48:14.638752348Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d2a7fea25649c7124568fc8902e81c1bc531625c",
"ref": "refs/heads/main"
}
}
}
[02:48:14.994] Task URL: https://cr-buildbucket.appspot.com/build/8716743215750774913
[02:48:14.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:2:0) after 3m36s
[02:48:16.054] Received PubSub notification, asking Buildbucket for the build status
[02:48:16.079] Build status: SCHEDULED
[02:48:23.855] Received PubSub notification, asking Buildbucket for the build status
[02:48:23.880] Build status: STARTED
[02:51:51.083] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:2:0)
[02:51:51.109] Build status: STARTED
[02:51:51.109] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:5:0) after 9m13s
[03:01:04.135] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:5:0)
[03:01:04.150] Build status: STARTED
[03:01:04.150] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:6:0) after 2m6s
[03:03:10.171] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:6:0)
[03:03:10.226] Build status: STARTED
[03:03:10.226] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:7:0) after 5m25s
[03:08:35.304] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:7:0)
[03:08:35.359] Build status: STARTED
[03:08:35.359] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:8:0) after 5m57s
[03:14:33.016] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:8:0)
[03:14:33.045] Build status: STARTED
[03:14:33.045] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:9:0) after 6m34s
[03:21:07.287] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:9:0)
[03:21:07.307] Build status: STARTED
[03:21:07.307] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:10:0) after 3m5s
[03:24:12.330] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:10:0)
[03:24:12.350] Build status: STARTED
[03:24:12.350] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:11:0) after 8m44s
[03:32:56.369] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:11:0)
[03:32:56.389] Build status: STARTED
[03:32:56.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:12:0) after 3m27s
[03:36:23.700] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:12:0)
[03:36:23.730] Build status: STARTED
[03:36:23.730] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:13:0) after 9m36s
[03:45:59.875] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:13:0)
[03:46:01.093] Build status: STARTED
[03:46:01.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:14:0) after 2m18s
[03:48:19.113] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:14:0)
[03:48:19.127] Build status: STARTED
[03:48:19.127] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:15:0) after 8m19s
[03:56:38.200] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:15:0)
[03:56:38.218] Build status: STARTED
[03:56:38.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:16:0) after 5m33s
[04:02:11.286] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:16:0)
[04:02:11.308] Build status: STARTED
[04:02:11.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:17:0) after 4m0s
[04:06:11.338] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:17:0)
[04:06:11.359] Build status: STARTED
[04:06:11.359] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:18:0) after 1m23s
[04:07:34.383] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:18:0)
[04:07:34.408] Build status: STARTED
[04:07:34.408] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:19:0) after 3m49s
[04:11:23.474] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:19:0)
[04:11:23.494] Build status: STARTED
[04:11:23.494] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:20:0) after 3m59s
[04:15:23.111] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:20:0)
[04:15:23.125] Build status: STARTED
[04:15:23.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:21:0) after 5m24s
[04:20:47.156] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:21:0)
[04:20:47.199] Build status: STARTED
[04:20:47.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:22:0) after 5m34s
[04:26:21.722] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:22:0)
[04:26:21.742] Build status: STARTED
[04:26:21.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:23:0) after 3m7s
[04:29:29.101] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:23:0)
[04:29:29.119] Build status: STARTED
[04:29:29.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:24:0) after 8m41s
[04:38:10.128] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:24:0)
[04:38:10.147] Build status: STARTED
[04:38:10.147] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-coverage-e5a0ec7f:8882173277685752800:25:0) after 9m40s
[04:42:23.676] Received PubSub notification, asking Buildbucket for the build status
[04:42:23.707] Build:
{
"id": "8716743215750774913",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-coverage"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-24T02:48:14.638752348Z",
"startTime": "2025-04-24T02:48:23.623968625Z",
"endTime": "2025-04-24T04:42:11.693235703Z",
"updateTime": "2025-04-24T04:42:11.693235703Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d2a7fea25649c7124568fc8902e81c1bc531625c",
"ref": "refs/heads/main"
}
}
}
[04:42:23.707] Invocation finished in 1h54m10.298051164s with status SUCCEEDED