[18:59:16.432] New invocation is queued and will start shortly
[18:59:17.506] Starting the invocation (attempt 1)
[18:59:17.544] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/810560edc5f6a167584dcb96766d06984ad3a452"
[18:59:17.544] Popped gitiles commit info from properties and tags
[18:59:17.545] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:59:17.545] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:59:17.546] Buildbucket request:
{
"requestId": "8907660529006944464",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-coverage"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8907660529006944464",
"job": "fuchsia/minimal.riscv64-coverage-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a854519c34bdbddc6fc6c19c18d60e21932007d5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a854519c34bdbddc6fc6c19c18d60e21932007d5",
"title": "a854519c34bdbddc6fc6c19c18d60e21932007d5",
"url": "https://fuchsia.googlesource.com/integration/+/a854519c34bdbddc6fc6c19c18d60e21932007d5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1254bae8d894de353952a3e7af6ba37af1461d7f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1254bae8d894de353952a3e7af6ba37af1461d7f",
"title": "1254bae8d894de353952a3e7af6ba37af1461d7f",
"url": "https://fuchsia.googlesource.com/integration/+/1254bae8d894de353952a3e7af6ba37af1461d7f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e4d70748c2835409751e8fdc72a43ba1f04d9b29"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e4d70748c2835409751e8fdc72a43ba1f04d9b29",
"title": "e4d70748c2835409751e8fdc72a43ba1f04d9b29",
"url": "https://fuchsia.googlesource.com/integration/+/e4d70748c2835409751e8fdc72a43ba1f04d9b29"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ed0ee5ee1beb2f2683c61701699463fc7883c81c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ed0ee5ee1beb2f2683c61701699463fc7883c81c",
"title": "ed0ee5ee1beb2f2683c61701699463fc7883c81c",
"url": "https://fuchsia.googlesource.com/integration/+/ed0ee5ee1beb2f2683c61701699463fc7883c81c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c681b0b7ea9e89b53967746f2ce84f6c5c7877b8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c681b0b7ea9e89b53967746f2ce84f6c5c7877b8",
"title": "c681b0b7ea9e89b53967746f2ce84f6c5c7877b8",
"url": "https://fuchsia.googlesource.com/integration/+/c681b0b7ea9e89b53967746f2ce84f6c5c7877b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d107205b03089a42c8ac0dfbeafeddc6c378026b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d107205b03089a42c8ac0dfbeafeddc6c378026b",
"title": "d107205b03089a42c8ac0dfbeafeddc6c378026b",
"url": "https://fuchsia.googlesource.com/integration/+/d107205b03089a42c8ac0dfbeafeddc6c378026b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9f74a76b8b57e464e02277781494a34dd2f57182"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9f74a76b8b57e464e02277781494a34dd2f57182",
"title": "9f74a76b8b57e464e02277781494a34dd2f57182",
"url": "https://fuchsia.googlesource.com/integration/+/9f74a76b8b57e464e02277781494a34dd2f57182"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1b038b5af28532afadf09ff2c66cfb58e79b14a3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1b038b5af28532afadf09ff2c66cfb58e79b14a3",
"title": "1b038b5af28532afadf09ff2c66cfb58e79b14a3",
"url": "https://fuchsia.googlesource.com/integration/+/1b038b5af28532afadf09ff2c66cfb58e79b14a3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d2094b6741430331386698f337d932d56a9b3b74"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d2094b6741430331386698f337d932d56a9b3b74",
"title": "d2094b6741430331386698f337d932d56a9b3b74",
"url": "https://fuchsia.googlesource.com/integration/+/d2094b6741430331386698f337d932d56a9b3b74"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3a7b32ef402edb5cc84be5d36f1793d3433c183f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3a7b32ef402edb5cc84be5d36f1793d3433c183f",
"title": "3a7b32ef402edb5cc84be5d36f1793d3433c183f",
"url": "https://fuchsia.googlesource.com/integration/+/3a7b32ef402edb5cc84be5d36f1793d3433c183f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5ca1abc58c81ea2c9e78455bdd86c7c6a8d2d66a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5ca1abc58c81ea2c9e78455bdd86c7c6a8d2d66a",
"title": "5ca1abc58c81ea2c9e78455bdd86c7c6a8d2d66a",
"url": "https://fuchsia.googlesource.com/integration/+/5ca1abc58c81ea2c9e78455bdd86c7c6a8d2d66a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b18c3a3a1c579d589243a99811475549154b10ad"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b18c3a3a1c579d589243a99811475549154b10ad",
"title": "b18c3a3a1c579d589243a99811475549154b10ad",
"url": "https://fuchsia.googlesource.com/integration/+/b18c3a3a1c579d589243a99811475549154b10ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a589acab38eef8d575f0959e69c3390af2e7a775"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a589acab38eef8d575f0959e69c3390af2e7a775",
"title": "a589acab38eef8d575f0959e69c3390af2e7a775",
"url": "https://fuchsia.googlesource.com/integration/+/a589acab38eef8d575f0959e69c3390af2e7a775"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "35be6272e662ccc09895e4f3af91fa18533e4589"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@35be6272e662ccc09895e4f3af91fa18533e4589",
"title": "35be6272e662ccc09895e4f3af91fa18533e4589",
"url": "https://fuchsia.googlesource.com/integration/+/35be6272e662ccc09895e4f3af91fa18533e4589"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b42a444fa9749711b920f5b7b94bf5a35694d923"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b42a444fa9749711b920f5b7b94bf5a35694d923",
"title": "b42a444fa9749711b920f5b7b94bf5a35694d923",
"url": "https://fuchsia.googlesource.com/integration/+/b42a444fa9749711b920f5b7b94bf5a35694d923"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "810560edc5f6a167584dcb96766d06984ad3a452"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@810560edc5f6a167584dcb96766d06984ad3a452",
"title": "810560edc5f6a167584dcb96766d06984ad3a452",
"url": "https://fuchsia.googlesource.com/integration/+/810560edc5f6a167584dcb96766d06984ad3a452"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "810560edc5f6a167584dcb96766d06984ad3a452",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8907660529006944464"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/minimal.riscv64-coverage-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:59:18.054] Scheduled build:
{
"id": "8742230467111185121",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-coverage"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-16T18:59:17.619452912Z",
"updateTime": "2024-07-16T18:59:17.619452912Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "810560edc5f6a167584dcb96766d06984ad3a452",
"ref": "refs/heads/main"
}
}
}
[18:59:18.054] Task URL: https://cr-buildbucket.appspot.com/build/8742230467111185121
[18:59:18.054] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:2:0) after 9m36s
[18:59:18.981] Received PubSub notification, asking Buildbucket for the build status
[18:59:19.028] Build status: SCHEDULED
[19:01:36.751] Received PubSub notification, asking Buildbucket for the build status
[19:01:36.775] Build status: STARTED
[19:08:54.095] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:2:0)
[19:08:54.118] Build status: STARTED
[19:08:54.118] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:5:0) after 1m6s
[19:10:00.170] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:5:0)
[19:10:00.193] Build status: STARTED
[19:10:00.193] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:6:0) after 2m8s
[19:12:08.187] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:6:0)
[19:12:08.216] Build status: STARTED
[19:12:08.216] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:7:0) after 8m18s
[19:20:26.318] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:7:0)
[19:20:26.340] Build status: STARTED
[19:20:26.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:8:0) after 9m3s
[19:29:29.359] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:8:0)
[19:29:29.378] Build status: STARTED
[19:29:29.378] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:9:0) after 1m58s
[19:31:27.397] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:9:0)
[19:31:27.491] Build status: STARTED
[19:31:27.491] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:10:0) after 9m47s
[19:41:14.537] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:10:0)
[19:41:14.572] Build status: STARTED
[19:41:14.572] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:11:0) after 2m54s
[19:44:08.589] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:11:0)
[19:44:08.608] Build status: STARTED
[19:44:08.608] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:12:0) after 4m2s
[19:48:10.633] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:12:0)
[19:48:10.664] Build status: STARTED
[19:48:10.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:13:0) after 2m25s
[19:50:35.680] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:13:0)
[19:50:35.698] Build status: STARTED
[19:50:35.698] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:14:0) after 3m53s
[19:54:28.672] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:14:0)
[19:54:28.697] Build status: STARTED
[19:54:28.697] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:15:0) after 2m47s
[19:57:15.811] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:15:0)
[19:57:15.830] Build status: STARTED
[19:57:15.830] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:16:0) after 5m40s
[20:02:55.864] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:16:0)
[20:02:55.880] Build status: STARTED
[20:02:55.880] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:17:0) after 1m50s
[20:04:45.897] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:17:0)
[20:04:45.915] Build status: STARTED
[20:04:45.915] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:18:0) after 3m16s
[20:08:01.955] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:18:0)
[20:08:02.019] Build status: STARTED
[20:08:02.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:19:0) after 3m23s
[20:11:25.018] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:19:0)
[20:11:25.044] Build status: STARTED
[20:11:25.044] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:20:0) after 1m31s
[20:12:56.122] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:20:0)
[20:12:56.142] Build status: STARTED
[20:12:56.142] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:21:0) after 6m53s
[20:19:49.162] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:21:0)
[20:19:49.180] Build status: STARTED
[20:19:49.180] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:22:0) after 6m53s
[20:26:42.200] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:22:0)
[20:26:42.219] Build status: STARTED
[20:26:42.219] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:23:0) after 2m34s
[20:29:16.290] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:23:0)
[20:29:16.307] Build status: STARTED
[20:29:16.307] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:24:0) after 8m35s
[20:37:51.326] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:24:0)
[20:37:51.343] Build status: STARTED
[20:37:51.343] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:25:0) after 2m51s
[20:40:42.375] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:25:0)
[20:40:42.393] Build status: STARTED
[20:40:42.393] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:26:0) after 8m9s
[20:48:51.427] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:26:0)
[20:48:51.451] Build status: STARTED
[20:48:51.451] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:27:0) after 1m30s
[20:50:21.486] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:27:0)
[20:50:21.504] Build status: STARTED
[20:50:21.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:28:0) after 8m47s
[20:59:08.521] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:28:0)
[20:59:08.586] Build status: STARTED
[20:59:08.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:29:0) after 4m41s
[21:03:49.794] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:29:0)
[21:03:49.816] Build status: STARTED
[21:03:49.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-coverage-e5a0ec7f:8907660529006944464:30:0) after 5m46s
[21:08:15.763] Received PubSub notification, asking Buildbucket for the build status
[21:08:15.790] Build:
{
"id": "8742230467111185121",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-coverage"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-16T18:59:17.619452912Z",
"startTime": "2024-07-16T19:01:36.514812661Z",
"endTime": "2024-07-16T21:08:07.313461247Z",
"updateTime": "2024-07-16T21:08:07.313461247Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "810560edc5f6a167584dcb96766d06984ad3a452",
"ref": "refs/heads/main"
}
}
}
[21:08:15.790] Invocation finished in 2h8m59.362289757s with status FAILED