[23:05:26.861] New invocation is queued and will start shortly
[23:05:27.979] Starting the invocation (attempt 1)
[23:05:28.015] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/4ae49ee893dd70bafc3f75b55bacc57bcf0b59d9"
[23:05:28.015] Popped gitiles commit info from properties and tags
[23:05:28.015] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:05:28.015] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:05:28.016] Buildbucket request:
{
"requestId": "8898132359626600544",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-asan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8898132359626600544",
"job": "fuchsia/minimal.riscv64-asan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f41d39db06f02164d4ea6a2434ac5d24c498e45f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f41d39db06f02164d4ea6a2434ac5d24c498e45f",
"title": "f41d39db06f02164d4ea6a2434ac5d24c498e45f",
"url": "https://fuchsia.googlesource.com/integration/+/f41d39db06f02164d4ea6a2434ac5d24c498e45f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "361f06c6a6e845a54c01f9998c0417e9c5565174"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@361f06c6a6e845a54c01f9998c0417e9c5565174",
"title": "361f06c6a6e845a54c01f9998c0417e9c5565174",
"url": "https://fuchsia.googlesource.com/integration/+/361f06c6a6e845a54c01f9998c0417e9c5565174"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "912d9e698d188cba28635d574f863a999238c778"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@912d9e698d188cba28635d574f863a999238c778",
"title": "912d9e698d188cba28635d574f863a999238c778",
"url": "https://fuchsia.googlesource.com/integration/+/912d9e698d188cba28635d574f863a999238c778"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8347ce2127297ac96d50bd9b06dced4c27eafa82"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8347ce2127297ac96d50bd9b06dced4c27eafa82",
"title": "8347ce2127297ac96d50bd9b06dced4c27eafa82",
"url": "https://fuchsia.googlesource.com/integration/+/8347ce2127297ac96d50bd9b06dced4c27eafa82"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "934a99d29f22974cc17268d153d17deb17fef0aa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@934a99d29f22974cc17268d153d17deb17fef0aa",
"title": "934a99d29f22974cc17268d153d17deb17fef0aa",
"url": "https://fuchsia.googlesource.com/integration/+/934a99d29f22974cc17268d153d17deb17fef0aa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bd45de90dae085ded0c1e939851debb62100df3c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bd45de90dae085ded0c1e939851debb62100df3c",
"title": "bd45de90dae085ded0c1e939851debb62100df3c",
"url": "https://fuchsia.googlesource.com/integration/+/bd45de90dae085ded0c1e939851debb62100df3c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "654bda86ad1562b1d30a5da6bef68a15ad293fc0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@654bda86ad1562b1d30a5da6bef68a15ad293fc0",
"title": "654bda86ad1562b1d30a5da6bef68a15ad293fc0",
"url": "https://fuchsia.googlesource.com/integration/+/654bda86ad1562b1d30a5da6bef68a15ad293fc0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fe91297571be449af1dc9d9826766fcc272c7baf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fe91297571be449af1dc9d9826766fcc272c7baf",
"title": "fe91297571be449af1dc9d9826766fcc272c7baf",
"url": "https://fuchsia.googlesource.com/integration/+/fe91297571be449af1dc9d9826766fcc272c7baf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cfaf1d3fcba33f4999e4517bf1473f2f397d27fd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cfaf1d3fcba33f4999e4517bf1473f2f397d27fd",
"title": "cfaf1d3fcba33f4999e4517bf1473f2f397d27fd",
"url": "https://fuchsia.googlesource.com/integration/+/cfaf1d3fcba33f4999e4517bf1473f2f397d27fd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c4e0bd3c6f21f6de4d7ce3263d0c61f4b4830d22"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c4e0bd3c6f21f6de4d7ce3263d0c61f4b4830d22",
"title": "c4e0bd3c6f21f6de4d7ce3263d0c61f4b4830d22",
"url": "https://fuchsia.googlesource.com/integration/+/c4e0bd3c6f21f6de4d7ce3263d0c61f4b4830d22"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0b334ab92d728201c7879bd6707e10a1d8bdfb26"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0b334ab92d728201c7879bd6707e10a1d8bdfb26",
"title": "0b334ab92d728201c7879bd6707e10a1d8bdfb26",
"url": "https://fuchsia.googlesource.com/integration/+/0b334ab92d728201c7879bd6707e10a1d8bdfb26"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8e3d9b2e0dd26ecf51903b3bbb626f1147c5b3bf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8e3d9b2e0dd26ecf51903b3bbb626f1147c5b3bf",
"title": "8e3d9b2e0dd26ecf51903b3bbb626f1147c5b3bf",
"url": "https://fuchsia.googlesource.com/integration/+/8e3d9b2e0dd26ecf51903b3bbb626f1147c5b3bf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a2b9c76749a38ec25b2d71797aa24a183b471c2d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a2b9c76749a38ec25b2d71797aa24a183b471c2d",
"title": "a2b9c76749a38ec25b2d71797aa24a183b471c2d",
"url": "https://fuchsia.googlesource.com/integration/+/a2b9c76749a38ec25b2d71797aa24a183b471c2d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e70648fb17c7e60b9591980fbfb9a0611706a792"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e70648fb17c7e60b9591980fbfb9a0611706a792",
"title": "e70648fb17c7e60b9591980fbfb9a0611706a792",
"url": "https://fuchsia.googlesource.com/integration/+/e70648fb17c7e60b9591980fbfb9a0611706a792"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9aac1cf7532191f9ebaa4b75accdcbc24caf1c72"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9aac1cf7532191f9ebaa4b75accdcbc24caf1c72",
"title": "9aac1cf7532191f9ebaa4b75accdcbc24caf1c72",
"url": "https://fuchsia.googlesource.com/integration/+/9aac1cf7532191f9ebaa4b75accdcbc24caf1c72"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "86d1dc8269b3c045aebc8016637581fabfc75721"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@86d1dc8269b3c045aebc8016637581fabfc75721",
"title": "86d1dc8269b3c045aebc8016637581fabfc75721",
"url": "https://fuchsia.googlesource.com/integration/+/86d1dc8269b3c045aebc8016637581fabfc75721"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8b9d1a74b44f4529988cc13e4a71e70b8e5fbafd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8b9d1a74b44f4529988cc13e4a71e70b8e5fbafd",
"title": "8b9d1a74b44f4529988cc13e4a71e70b8e5fbafd",
"url": "https://fuchsia.googlesource.com/integration/+/8b9d1a74b44f4529988cc13e4a71e70b8e5fbafd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "10deb08f18cfc8d667e3826639b42454403b1d89"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@10deb08f18cfc8d667e3826639b42454403b1d89",
"title": "10deb08f18cfc8d667e3826639b42454403b1d89",
"url": "https://fuchsia.googlesource.com/integration/+/10deb08f18cfc8d667e3826639b42454403b1d89"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5eb3325a7b5d633dec55e7501473606cb22b1573"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5eb3325a7b5d633dec55e7501473606cb22b1573",
"title": "5eb3325a7b5d633dec55e7501473606cb22b1573",
"url": "https://fuchsia.googlesource.com/integration/+/5eb3325a7b5d633dec55e7501473606cb22b1573"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "af287566705cb1f35cbf1570b5bbde234ba17340"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@af287566705cb1f35cbf1570b5bbde234ba17340",
"title": "af287566705cb1f35cbf1570b5bbde234ba17340",
"url": "https://fuchsia.googlesource.com/integration/+/af287566705cb1f35cbf1570b5bbde234ba17340"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8e46b1f057754982643b8bc15370cb2e2b465dbd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8e46b1f057754982643b8bc15370cb2e2b465dbd",
"title": "8e46b1f057754982643b8bc15370cb2e2b465dbd",
"url": "https://fuchsia.googlesource.com/integration/+/8e46b1f057754982643b8bc15370cb2e2b465dbd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3643df5ecc8714e3d9f7730e4e8a85998ac1c01b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3643df5ecc8714e3d9f7730e4e8a85998ac1c01b",
"title": "3643df5ecc8714e3d9f7730e4e8a85998ac1c01b",
"url": "https://fuchsia.googlesource.com/integration/+/3643df5ecc8714e3d9f7730e4e8a85998ac1c01b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4ae49ee893dd70bafc3f75b55bacc57bcf0b59d9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4ae49ee893dd70bafc3f75b55bacc57bcf0b59d9",
"title": "4ae49ee893dd70bafc3f75b55bacc57bcf0b59d9",
"url": "https://fuchsia.googlesource.com/integration/+/4ae49ee893dd70bafc3f75b55bacc57bcf0b59d9"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4ae49ee893dd70bafc3f75b55bacc57bcf0b59d9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8898132359626600544"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/minimal.riscv64-asan-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:05:28.478] Scheduled build:
{
"id": "8732702297701195713",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-29T23:05:28.068952048Z",
"updateTime": "2024-10-29T23:05:28.068952048Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4ae49ee893dd70bafc3f75b55bacc57bcf0b59d9",
"ref": "refs/heads/main"
}
}
}
[23:05:28.478] Task URL: https://cr-buildbucket.appspot.com/build/8732702297701195713
[23:05:28.479] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:2:0) after 9m9s
[23:05:29.447] Received PubSub notification, asking Buildbucket for the build status
[23:05:29.526] Build status: SCHEDULED
[23:05:51.294] Received PubSub notification, asking Buildbucket for the build status
[23:05:51.312] Build status: STARTED
[23:14:37.594] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:2:0)
[23:14:37.621] Build status: STARTED
[23:14:37.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:5:0) after 6m47s
[23:21:24.705] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:5:0)
[23:21:24.798] Build status: STARTED
[23:21:24.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:6:0) after 7m48s
[23:29:12.870] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:6:0)
[23:29:12.902] Build status: STARTED
[23:29:12.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:7:0) after 2m4s
[23:31:16.920] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:7:0)
[23:31:16.938] Build status: STARTED
[23:31:16.938] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:8:0) after 7m10s
[23:38:26.932] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:8:0)
[23:38:26.952] Build status: STARTED
[23:38:26.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:9:0) after 5m28s
[23:43:54.983] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:9:0)
[23:43:55.001] Build status: STARTED
[23:43:55.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:10:0) after 6m13s
[23:50:08.131] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:10:0)
[23:50:08.149] Build status: STARTED
[23:50:08.149] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:11:0) after 2m45s
[23:52:53.220] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:11:0)
[23:52:53.251] Build status: STARTED
[23:52:53.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:12:0) after 8m11s
[00:01:04.270] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:12:0)
[00:01:04.303] Build status: STARTED
[00:01:04.303] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:13:0) after 3m12s
[00:04:16.326] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:13:0)
[00:04:16.347] Build status: STARTED
[00:04:16.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:14:0) after 5m50s
[00:10:06.567] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:14:0)
[00:10:06.658] Build status: STARTED
[00:10:06.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:15:0) after 9m25s
[00:19:31.759] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:15:0)
[00:19:31.780] Build status: STARTED
[00:19:31.780] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:16:0) after 1m58s
[00:21:29.798] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:16:0)
[00:21:29.817] Build status: STARTED
[00:21:29.817] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:17:0) after 4m9s
[00:25:38.833] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:17:0)
[00:25:38.902] Build status: STARTED
[00:25:38.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:18:0) after 5m13s
[00:30:51.917] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:18:0)
[00:30:51.954] Build status: STARTED
[00:30:51.954] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:19:0) after 2m20s
[00:33:11.974] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:19:0)
[00:33:12.014] Build status: STARTED
[00:33:12.014] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:20:0) after 5m4s
[00:38:16.134] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:20:0)
[00:38:16.156] Build status: STARTED
[00:38:16.156] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-asan-e5a0ec7f:8898132359626600544:21:0) after 1m27s
[00:39:01.624] Received PubSub notification, asking Buildbucket for the build status
[00:39:01.653] Build:
{
"id": "8732702297701195713",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-29T23:05:28.068952048Z",
"startTime": "2024-10-29T23:05:51.049625777Z",
"endTime": "2024-10-30T00:39:01.173538095Z",
"updateTime": "2024-10-30T00:39:01.173538095Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4ae49ee893dd70bafc3f75b55bacc57bcf0b59d9",
"ref": "refs/heads/main"
}
}
}
[00:39:01.653] Invocation finished in 1h33m34.804768938s with status FAILED