[19:25:02.137] New invocation is queued and will start shortly
[19:25:03.217] Starting the invocation (attempt 1)
[19:25:03.259] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/cc8843c5a60a650cd2ba089df36ad5877103d307"
[19:25:03.259] Popped gitiles commit info from properties and tags
[19:25:03.259] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:25:03.259] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:25:03.260] Buildbucket request:
{
"requestId": "8948155752201949440",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8948155752201949440",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1877a01a2817eef2584e25709895f5c401be8835"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1877a01a2817eef2584e25709895f5c401be8835",
"title": "1877a01a2817eef2584e25709895f5c401be8835",
"url": "https://fuchsia.googlesource.com/integration/+/1877a01a2817eef2584e25709895f5c401be8835"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7711b17c28d2ac09e390099992ef405c7d56ddc0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7711b17c28d2ac09e390099992ef405c7d56ddc0",
"title": "7711b17c28d2ac09e390099992ef405c7d56ddc0",
"url": "https://fuchsia.googlesource.com/integration/+/7711b17c28d2ac09e390099992ef405c7d56ddc0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d03dd09af43bdd5193fd617a4c7a7232f85c9ddf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d03dd09af43bdd5193fd617a4c7a7232f85c9ddf",
"title": "d03dd09af43bdd5193fd617a4c7a7232f85c9ddf",
"url": "https://fuchsia.googlesource.com/integration/+/d03dd09af43bdd5193fd617a4c7a7232f85c9ddf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d79d9a602b0f9d700b993880a585615751c85e2a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d79d9a602b0f9d700b993880a585615751c85e2a",
"title": "d79d9a602b0f9d700b993880a585615751c85e2a",
"url": "https://fuchsia.googlesource.com/integration/+/d79d9a602b0f9d700b993880a585615751c85e2a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0a97ed0b8d002f13d30673e54ce74f4e1433522d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0a97ed0b8d002f13d30673e54ce74f4e1433522d",
"title": "0a97ed0b8d002f13d30673e54ce74f4e1433522d",
"url": "https://fuchsia.googlesource.com/integration/+/0a97ed0b8d002f13d30673e54ce74f4e1433522d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "27cfec12bc97f7a7d0f7c79d8d30149efe229f96"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@27cfec12bc97f7a7d0f7c79d8d30149efe229f96",
"title": "27cfec12bc97f7a7d0f7c79d8d30149efe229f96",
"url": "https://fuchsia.googlesource.com/integration/+/27cfec12bc97f7a7d0f7c79d8d30149efe229f96"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "92aeb3796040b81f9da8c1082279aedc9eb0f8fe"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@92aeb3796040b81f9da8c1082279aedc9eb0f8fe",
"title": "92aeb3796040b81f9da8c1082279aedc9eb0f8fe",
"url": "https://fuchsia.googlesource.com/integration/+/92aeb3796040b81f9da8c1082279aedc9eb0f8fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f46c6054b1d2062bfbda0d6d3172290807f05d3d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f46c6054b1d2062bfbda0d6d3172290807f05d3d",
"title": "f46c6054b1d2062bfbda0d6d3172290807f05d3d",
"url": "https://fuchsia.googlesource.com/integration/+/f46c6054b1d2062bfbda0d6d3172290807f05d3d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "79585cd1a9c86019286e9607809b1bc96fe9fcc1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@79585cd1a9c86019286e9607809b1bc96fe9fcc1",
"title": "79585cd1a9c86019286e9607809b1bc96fe9fcc1",
"url": "https://fuchsia.googlesource.com/integration/+/79585cd1a9c86019286e9607809b1bc96fe9fcc1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b27001fc16367bf05493bcdfd99f4c975edae05d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b27001fc16367bf05493bcdfd99f4c975edae05d",
"title": "b27001fc16367bf05493bcdfd99f4c975edae05d",
"url": "https://fuchsia.googlesource.com/integration/+/b27001fc16367bf05493bcdfd99f4c975edae05d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "245f1d99baad3cceff4723c9e7d728f51c60dedc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@245f1d99baad3cceff4723c9e7d728f51c60dedc",
"title": "245f1d99baad3cceff4723c9e7d728f51c60dedc",
"url": "https://fuchsia.googlesource.com/integration/+/245f1d99baad3cceff4723c9e7d728f51c60dedc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "658fbc986538fd884cd30be774c3447a427a9e85"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@658fbc986538fd884cd30be774c3447a427a9e85",
"title": "658fbc986538fd884cd30be774c3447a427a9e85",
"url": "https://fuchsia.googlesource.com/integration/+/658fbc986538fd884cd30be774c3447a427a9e85"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "deb293c8ba4e5b9ec7cd6d00c267a821edf8d22e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@deb293c8ba4e5b9ec7cd6d00c267a821edf8d22e",
"title": "deb293c8ba4e5b9ec7cd6d00c267a821edf8d22e",
"url": "https://fuchsia.googlesource.com/integration/+/deb293c8ba4e5b9ec7cd6d00c267a821edf8d22e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1d49c526b788d399d3d05074c7a30c69505e6b3f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1d49c526b788d399d3d05074c7a30c69505e6b3f",
"title": "1d49c526b788d399d3d05074c7a30c69505e6b3f",
"url": "https://fuchsia.googlesource.com/integration/+/1d49c526b788d399d3d05074c7a30c69505e6b3f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7ef85fca804acd55291548c1186a8c9a842f2cc4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7ef85fca804acd55291548c1186a8c9a842f2cc4",
"title": "7ef85fca804acd55291548c1186a8c9a842f2cc4",
"url": "https://fuchsia.googlesource.com/integration/+/7ef85fca804acd55291548c1186a8c9a842f2cc4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fa6cac33537a2f8c4884a3092a53279b0c9da82d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fa6cac33537a2f8c4884a3092a53279b0c9da82d",
"title": "fa6cac33537a2f8c4884a3092a53279b0c9da82d",
"url": "https://fuchsia.googlesource.com/integration/+/fa6cac33537a2f8c4884a3092a53279b0c9da82d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fd5ada093f940a10c753f09a97ccabb7de49f1c7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fd5ada093f940a10c753f09a97ccabb7de49f1c7",
"title": "fd5ada093f940a10c753f09a97ccabb7de49f1c7",
"url": "https://fuchsia.googlesource.com/integration/+/fd5ada093f940a10c753f09a97ccabb7de49f1c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0578d4b0762995aa614c6e74f50501d1348eb835"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0578d4b0762995aa614c6e74f50501d1348eb835",
"title": "0578d4b0762995aa614c6e74f50501d1348eb835",
"url": "https://fuchsia.googlesource.com/integration/+/0578d4b0762995aa614c6e74f50501d1348eb835"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "51eab3c686c0cfa0a7a23be91953a0cfb8476568"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@51eab3c686c0cfa0a7a23be91953a0cfb8476568",
"title": "51eab3c686c0cfa0a7a23be91953a0cfb8476568",
"url": "https://fuchsia.googlesource.com/integration/+/51eab3c686c0cfa0a7a23be91953a0cfb8476568"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "34e8f3a94e862feff8fca493ce454317b67f1b82"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@34e8f3a94e862feff8fca493ce454317b67f1b82",
"title": "34e8f3a94e862feff8fca493ce454317b67f1b82",
"url": "https://fuchsia.googlesource.com/integration/+/34e8f3a94e862feff8fca493ce454317b67f1b82"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cc8843c5a60a650cd2ba089df36ad5877103d307"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cc8843c5a60a650cd2ba089df36ad5877103d307",
"title": "cc8843c5a60a650cd2ba089df36ad5877103d307",
"url": "https://fuchsia.googlesource.com/integration/+/cc8843c5a60a650cd2ba089df36ad5877103d307"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "cc8843c5a60a650cd2ba089df36ad5877103d307",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8948155752201949440"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:25:03.934] Scheduled build:
{
"id": "8782725690247200481",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-26T19:25:03.377315104Z",
"updateTime": "2023-04-26T19:25:03.377315104Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "cc8843c5a60a650cd2ba089df36ad5877103d307",
"ref": "refs/heads/main"
}
}
}
[19:25:03.934] Task URL: https://cr-buildbucket.appspot.com/build/8782725690247200481
[19:25:03.934] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:2:0) after 3m5s
[19:25:45.758] Received PubSub notification, asking Buildbucket for the build status
[19:25:45.820] Build status: STARTED
[19:28:09.098] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:2:0)
[19:28:09.128] Build status: STARTED
[19:28:09.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:4:0) after 7m10s
[19:35:19.156] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:4:0)
[19:35:19.175] Build status: STARTED
[19:35:19.175] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:5:0) after 3m33s
[19:38:52.201] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:5:0)
[19:38:52.224] Build status: STARTED
[19:38:52.224] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:6:0) after 1m8s
[19:40:00.253] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:6:0)
[19:40:00.285] Build status: STARTED
[19:40:00.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:7:0) after 6m39s
[19:46:39.312] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:7:0)
[19:46:39.335] Build status: STARTED
[19:46:39.335] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:8:0) after 2m42s
[19:49:21.461] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:8:0)
[19:49:21.480] Build status: STARTED
[19:49:21.480] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:9:0) after 3m36s
[19:52:57.732] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:9:0)
[19:52:57.761] Build status: STARTED
[19:52:57.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:10:0) after 1m23s
[19:54:20.869] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:10:0)
[19:54:20.895] Build status: STARTED
[19:54:20.895] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:11:0) after 5m23s
[19:59:44.411] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:11:0)
[19:59:44.430] Build status: STARTED
[19:59:44.430] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:12:0) after 6m41s
[20:06:25.504] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:12:0)
[20:06:25.524] Build status: STARTED
[20:06:25.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:13:0) after 2m53s
[20:09:18.641] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:13:0)
[20:09:18.667] Build status: STARTED
[20:09:18.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:14:0) after 4m59s
[20:14:17.687] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:14:0)
[20:14:17.709] Build status: STARTED
[20:14:17.709] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:15:0) after 8m12s
[20:22:29.728] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:15:0)
[20:22:29.746] Build status: STARTED
[20:22:29.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:16:0) after 7m56s
[20:30:25.817] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:16:0)
[20:30:25.838] Build status: STARTED
[20:30:25.838] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:17:0) after 3m5s
[20:33:30.879] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:17:0)
[20:33:30.900] Build status: STARTED
[20:33:30.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:18:0) after 1m39s
[20:35:10.223] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:18:0)
[20:35:10.255] Build status: STARTED
[20:35:10.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:19:0) after 7m49s
[20:42:59.273] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:19:0)
[20:42:59.360] Build status: STARTED
[20:42:59.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:20:0) after 9m51s
[20:52:50.810] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:20:0)
[20:52:50.862] Build status: STARTED
[20:52:50.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:21:0) after 9m42s
[21:02:32.912] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:21:0)
[21:02:32.945] Build status: STARTED
[21:02:32.946] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:22:0) after 1m3s
[21:03:35.954] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:22:0)
[21:03:35.974] Build status: STARTED
[21:03:35.974] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:23:0) after 9m51s
[21:13:26.993] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:23:0)
[21:13:27.014] Build status: STARTED
[21:13:27.014] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8948155752201949440:24:0) after 6m9s
[21:15:31.273] Received PubSub notification, asking Buildbucket for the build status
[21:15:31.297] Build:
{
"id": "8782725690247200481",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-26T19:25:03.377315104Z",
"startTime": "2023-04-26T19:25:45.125659Z",
"endTime": "2023-04-26T21:15:31.011886327Z",
"updateTime": "2023-04-26T21:15:31.011886327Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "cc8843c5a60a650cd2ba089df36ad5877103d307",
"ref": "refs/heads/main"
}
}
}
[21:15:31.297] Invocation finished in 1h50m29.166977298s with status FAILED