[23:42:02.223] New invocation is queued and will start shortly
[23:42:03.319] Starting the invocation (attempt 1)
[23:42:03.347] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/8715bf0ea44111a5255b189e6948481cd7fc058c"
[23:42:03.347] Popped gitiles commit info from properties and tags
[23:42:03.347] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:42:03.347] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:42:03.348] Buildbucket request:
{
"requestId": "8934640635080698080",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8934640635080698080",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e7cd9417c82c560476c1530ecf05ded603f8f6bd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e7cd9417c82c560476c1530ecf05ded603f8f6bd",
"title": "e7cd9417c82c560476c1530ecf05ded603f8f6bd",
"url": "https://fuchsia.googlesource.com/integration/+/e7cd9417c82c560476c1530ecf05ded603f8f6bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a66bf3813ba2e8d56194a827b5c170a04b3f88ed"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a66bf3813ba2e8d56194a827b5c170a04b3f88ed",
"title": "a66bf3813ba2e8d56194a827b5c170a04b3f88ed",
"url": "https://fuchsia.googlesource.com/integration/+/a66bf3813ba2e8d56194a827b5c170a04b3f88ed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "05fff569b64ab38819853567d76f4af2b369bb4a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@05fff569b64ab38819853567d76f4af2b369bb4a",
"title": "05fff569b64ab38819853567d76f4af2b369bb4a",
"url": "https://fuchsia.googlesource.com/integration/+/05fff569b64ab38819853567d76f4af2b369bb4a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1cda6b3ca3f4c6ef0fa473b777b22a1ed929e885"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1cda6b3ca3f4c6ef0fa473b777b22a1ed929e885",
"title": "1cda6b3ca3f4c6ef0fa473b777b22a1ed929e885",
"url": "https://fuchsia.googlesource.com/integration/+/1cda6b3ca3f4c6ef0fa473b777b22a1ed929e885"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0f85c001c5c6e4139b52b2b07e96bedae1f27ab8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0f85c001c5c6e4139b52b2b07e96bedae1f27ab8",
"title": "0f85c001c5c6e4139b52b2b07e96bedae1f27ab8",
"url": "https://fuchsia.googlesource.com/integration/+/0f85c001c5c6e4139b52b2b07e96bedae1f27ab8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6026911a285a0163da7238ac584c8443b1af5cb5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6026911a285a0163da7238ac584c8443b1af5cb5",
"title": "6026911a285a0163da7238ac584c8443b1af5cb5",
"url": "https://fuchsia.googlesource.com/integration/+/6026911a285a0163da7238ac584c8443b1af5cb5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "40a8a159d0b0f74942ebebc5c6101e8be0d3c342"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@40a8a159d0b0f74942ebebc5c6101e8be0d3c342",
"title": "40a8a159d0b0f74942ebebc5c6101e8be0d3c342",
"url": "https://fuchsia.googlesource.com/integration/+/40a8a159d0b0f74942ebebc5c6101e8be0d3c342"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "742b493914dc8ef5c58053819d4aa24d99272afa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@742b493914dc8ef5c58053819d4aa24d99272afa",
"title": "742b493914dc8ef5c58053819d4aa24d99272afa",
"url": "https://fuchsia.googlesource.com/integration/+/742b493914dc8ef5c58053819d4aa24d99272afa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "31713c22ab3bdf5de07d686b61a15324f4128348"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@31713c22ab3bdf5de07d686b61a15324f4128348",
"title": "31713c22ab3bdf5de07d686b61a15324f4128348",
"url": "https://fuchsia.googlesource.com/integration/+/31713c22ab3bdf5de07d686b61a15324f4128348"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "da7bb424e9c185d5304d5c3cd9e008faf19b5944"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@da7bb424e9c185d5304d5c3cd9e008faf19b5944",
"title": "da7bb424e9c185d5304d5c3cd9e008faf19b5944",
"url": "https://fuchsia.googlesource.com/integration/+/da7bb424e9c185d5304d5c3cd9e008faf19b5944"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c60e634b385782d2ad8e7aa40f555faa068634a6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c60e634b385782d2ad8e7aa40f555faa068634a6",
"title": "c60e634b385782d2ad8e7aa40f555faa068634a6",
"url": "https://fuchsia.googlesource.com/integration/+/c60e634b385782d2ad8e7aa40f555faa068634a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8715bf0ea44111a5255b189e6948481cd7fc058c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8715bf0ea44111a5255b189e6948481cd7fc058c",
"title": "8715bf0ea44111a5255b189e6948481cd7fc058c",
"url": "https://fuchsia.googlesource.com/integration/+/8715bf0ea44111a5255b189e6948481cd7fc058c"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8715bf0ea44111a5255b189e6948481cd7fc058c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8934640635080698080"
},
{
"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"
}
}
[23:42:03.805] Scheduled build:
{
"id": "8769210573172806849",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-22T23:42:03.414843590Z",
"updateTime": "2023-09-22T23:42:03.414843590Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8715bf0ea44111a5255b189e6948481cd7fc058c",
"ref": "refs/heads/main"
}
}
}
[23:42:03.805] Task URL: https://cr-buildbucket.appspot.com/build/8769210573172806849
[23:42:03.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:2:0) after 6m1s
[23:42:04.727] Received PubSub notification, asking Buildbucket for the build status
[23:42:04.743] Build status: SCHEDULED
[23:42:09.271] Received PubSub notification, asking Buildbucket for the build status
[23:42:09.290] Build status: STARTED
[23:48:05.215] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:2:0)
[23:48:05.262] Build status: STARTED
[23:48:05.262] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:5:0) after 6m53s
[23:54:58.599] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:5:0)
[23:54:58.621] Build status: STARTED
[23:54:58.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:6:0) after 4m24s
[23:59:22.671] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:6:0)
[23:59:22.704] Build status: STARTED
[23:59:22.704] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:7:0) after 7m2s
[00:06:24.718] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:7:0)
[00:06:24.735] Build status: STARTED
[00:06:24.735] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:8:0) after 9m10s
[00:15:34.854] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:8:0)
[00:15:34.894] Build status: STARTED
[00:15:34.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:9:0) after 9m55s
[00:25:29.924] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:9:0)
[00:25:29.943] Build status: STARTED
[00:25:29.943] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:10:0) after 5m32s
[00:31:01.983] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:10:0)
[00:31:02.101] Build status: STARTED
[00:31:02.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:11:0) after 3m57s
[00:34:59.551] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:11:0)
[00:34:59.582] Build status: STARTED
[00:34:59.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:12:0) after 2m22s
[00:37:21.983] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:12:0)
[00:37:22.001] Build status: STARTED
[00:37:22.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:13:0) after 4m58s
[00:42:20.655] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:13:0)
[00:42:20.678] Build status: STARTED
[00:42:20.678] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:14:0) after 1m16s
[00:43:37.046] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:14:0)
[00:43:37.066] Build status: STARTED
[00:43:37.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:15:0) after 7m13s
[00:50:50.089] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:15:0)
[00:50:50.114] Build status: STARTED
[00:50:50.115] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8934640635080698080:16:0) after 7m31s
[00:54:29.025] Received PubSub notification, asking Buildbucket for the build status
[00:54:29.111] Build:
{
"id": "8769210573172806849",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-22T23:42:03.414843590Z",
"startTime": "2023-09-22T23:42:08.056861Z",
"endTime": "2023-09-23T00:54:28.764777369Z",
"updateTime": "2023-09-23T00:54:28.764777369Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8715bf0ea44111a5255b189e6948481cd7fc058c",
"ref": "refs/heads/main"
}
}
}
[00:54:29.111] Invocation finished in 1h12m26.900055512s with status FAILED