[19:38:29.197] New invocation is queued and will start shortly
[19:38:31.176] Starting the invocation (attempt 1)
[19:38:31.202] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/517fd372677f92604332336eaaa6652626a67d68"
[19:38:31.202] Popped gitiles commit info from properties and tags
[19:38:31.202] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:38:31.202] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:38:31.202] Buildbucket request:
{
"requestId": "8931847451995649472",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8931847451995649472",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "92244262ed1b5d804d74cc0f6cdfbea460c3a02c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@92244262ed1b5d804d74cc0f6cdfbea460c3a02c",
"title": "92244262ed1b5d804d74cc0f6cdfbea460c3a02c",
"url": "https://fuchsia.googlesource.com/integration/+/92244262ed1b5d804d74cc0f6cdfbea460c3a02c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f8d180925f53f4f8c43df52eaf08ee8936840ed4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f8d180925f53f4f8c43df52eaf08ee8936840ed4",
"title": "f8d180925f53f4f8c43df52eaf08ee8936840ed4",
"url": "https://fuchsia.googlesource.com/integration/+/f8d180925f53f4f8c43df52eaf08ee8936840ed4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "36a517ef02140b64045f5bca1201343f7201e11c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@36a517ef02140b64045f5bca1201343f7201e11c",
"title": "36a517ef02140b64045f5bca1201343f7201e11c",
"url": "https://fuchsia.googlesource.com/integration/+/36a517ef02140b64045f5bca1201343f7201e11c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6bac040b1c5e313f2eb09c11b11cff2e489593d9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6bac040b1c5e313f2eb09c11b11cff2e489593d9",
"title": "6bac040b1c5e313f2eb09c11b11cff2e489593d9",
"url": "https://fuchsia.googlesource.com/integration/+/6bac040b1c5e313f2eb09c11b11cff2e489593d9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3f8bd9a9820a632a0d61fb6d93aa00bfdde6ef7b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3f8bd9a9820a632a0d61fb6d93aa00bfdde6ef7b",
"title": "3f8bd9a9820a632a0d61fb6d93aa00bfdde6ef7b",
"url": "https://fuchsia.googlesource.com/integration/+/3f8bd9a9820a632a0d61fb6d93aa00bfdde6ef7b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ccdc82799aacdc970aaa61d667fdebe0893c7956"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ccdc82799aacdc970aaa61d667fdebe0893c7956",
"title": "ccdc82799aacdc970aaa61d667fdebe0893c7956",
"url": "https://fuchsia.googlesource.com/integration/+/ccdc82799aacdc970aaa61d667fdebe0893c7956"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c4a999e145d741fd73c638f0e2fc467856fe515f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c4a999e145d741fd73c638f0e2fc467856fe515f",
"title": "c4a999e145d741fd73c638f0e2fc467856fe515f",
"url": "https://fuchsia.googlesource.com/integration/+/c4a999e145d741fd73c638f0e2fc467856fe515f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cff05151330ad36a442a1e65353210a33c69410c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cff05151330ad36a442a1e65353210a33c69410c",
"title": "cff05151330ad36a442a1e65353210a33c69410c",
"url": "https://fuchsia.googlesource.com/integration/+/cff05151330ad36a442a1e65353210a33c69410c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e6b607885fd48335d842e1cc3f45922e4fd6da01"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e6b607885fd48335d842e1cc3f45922e4fd6da01",
"title": "e6b607885fd48335d842e1cc3f45922e4fd6da01",
"url": "https://fuchsia.googlesource.com/integration/+/e6b607885fd48335d842e1cc3f45922e4fd6da01"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ccee799555043c3203ce51c913baf9d8d313edb1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ccee799555043c3203ce51c913baf9d8d313edb1",
"title": "ccee799555043c3203ce51c913baf9d8d313edb1",
"url": "https://fuchsia.googlesource.com/integration/+/ccee799555043c3203ce51c913baf9d8d313edb1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "797b1090563358f345146748d9b779955ee92f53"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@797b1090563358f345146748d9b779955ee92f53",
"title": "797b1090563358f345146748d9b779955ee92f53",
"url": "https://fuchsia.googlesource.com/integration/+/797b1090563358f345146748d9b779955ee92f53"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1639d18c0ff278442be550bdf24422ed29e3bd5e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1639d18c0ff278442be550bdf24422ed29e3bd5e",
"title": "1639d18c0ff278442be550bdf24422ed29e3bd5e",
"url": "https://fuchsia.googlesource.com/integration/+/1639d18c0ff278442be550bdf24422ed29e3bd5e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "53f384ceed238112c587f39e4b0fc8d10baa184f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@53f384ceed238112c587f39e4b0fc8d10baa184f",
"title": "53f384ceed238112c587f39e4b0fc8d10baa184f",
"url": "https://fuchsia.googlesource.com/integration/+/53f384ceed238112c587f39e4b0fc8d10baa184f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cd3f23ee12c45868dc6996d8099216160a3701b7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cd3f23ee12c45868dc6996d8099216160a3701b7",
"title": "cd3f23ee12c45868dc6996d8099216160a3701b7",
"url": "https://fuchsia.googlesource.com/integration/+/cd3f23ee12c45868dc6996d8099216160a3701b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "517fd372677f92604332336eaaa6652626a67d68"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@517fd372677f92604332336eaaa6652626a67d68",
"title": "517fd372677f92604332336eaaa6652626a67d68",
"url": "https://fuchsia.googlesource.com/integration/+/517fd372677f92604332336eaaa6652626a67d68"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "517fd372677f92604332336eaaa6652626a67d68",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8931847451995649472"
},
{
"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:38:31.775] Scheduled build:
{
"id": "8766417389154194097",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-23T19:38:31.274904090Z",
"updateTime": "2023-10-23T19:38:31.274904090Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "517fd372677f92604332336eaaa6652626a67d68",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:38:31.775] Task URL: https://cr-buildbucket.appspot.com/build/8766417389154194097
[19:38:31.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:2:0) after 2m49s
[19:38:32.794] Received PubSub notification, asking Buildbucket for the build status
[19:38:32.898] Build status: SCHEDULED
[19:39:55.731] Received PubSub notification, asking Buildbucket for the build status
[19:39:55.822] Build status: STARTED
[19:41:20.794] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:2:0)
[19:41:20.824] Build status: STARTED
[19:41:20.824] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:5:0) after 7m43s
[19:49:04.206] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:5:0)
[19:49:04.227] Build status: STARTED
[19:49:04.227] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:6:0) after 3m40s
[19:52:44.491] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:6:0)
[19:52:44.510] Build status: STARTED
[19:52:44.510] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:7:0) after 6m2s
[19:58:46.542] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:7:0)
[19:58:46.561] Build status: STARTED
[19:58:46.561] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:8:0) after 5m7s
[20:03:53.587] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:8:0)
[20:03:53.646] Build status: STARTED
[20:03:53.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:9:0) after 8m34s
[20:12:27.749] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:9:0)
[20:12:27.781] Build status: STARTED
[20:12:27.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:10:0) after 2m53s
[20:15:20.815] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:10:0)
[20:15:20.843] Build status: STARTED
[20:15:20.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:11:0) after 2m57s
[20:18:17.897] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:11:0)
[20:18:17.967] Build status: STARTED
[20:18:17.967] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:12:0) after 7m19s
[20:25:36.998] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:12:0)
[20:25:37.020] Build status: STARTED
[20:25:37.020] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:13:0) after 9m59s
[20:35:36.133] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:13:0)
[20:35:36.152] Build status: STARTED
[20:35:36.152] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:14:0) after 3m40s
[20:39:16.229] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:14:0)
[20:39:16.250] Build status: STARTED
[20:39:16.250] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:15:0) after 2m2s
[20:41:18.895] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:15:0)
[20:41:18.916] Build status: STARTED
[20:41:18.916] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:16:0) after 7m6s
[20:48:25.170] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:16:0)
[20:48:25.197] Build status: STARTED
[20:48:25.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:17:0) after 3m40s
[20:52:05.388] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:17:0)
[20:52:05.413] Build status: STARTED
[20:52:05.413] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:18:0) after 9m47s
[21:01:52.489] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:18:0)
[21:01:52.514] Build status: STARTED
[21:01:52.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8931847451995649472:19:0) after 7m52s
[21:03:33.853] Received PubSub notification, asking Buildbucket for the build status
[21:03:33.877] Build:
{
"id": "8766417389154194097",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-23T19:38:31.274904090Z",
"startTime": "2023-10-23T19:39:53.303823Z",
"endTime": "2023-10-23T21:03:33.171725884Z",
"updateTime": "2023-10-23T21:03:33.171725884Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "517fd372677f92604332336eaaa6652626a67d68",
"ref": "refs/heads/main"
}
},
"canary": true
}
[21:03:33.877] Invocation finished in 1h25m4.695633404s with status FAILED