[06:04:50.686] New invocation is queued and will start shortly
[06:04:51.863] Starting the invocation (attempt 1)
[06:04:51.903] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/b9718b378f4f1b35fb19cb64afe71f66f6becc10"
[06:04:51.903] Popped gitiles commit info from properties and tags
[06:04:51.903] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:04:51.903] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:04:51.904] Buildbucket request:
{
"requestId": "8939961771914868944",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8939961771914868944",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fd90337dac3489d8189d8f6e107ae849e279b0ac"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fd90337dac3489d8189d8f6e107ae849e279b0ac",
"title": "fd90337dac3489d8189d8f6e107ae849e279b0ac",
"url": "https://fuchsia.googlesource.com/integration/+/fd90337dac3489d8189d8f6e107ae849e279b0ac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8acc8c30cf86c1760701cfe83b090ae476a34b49"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8acc8c30cf86c1760701cfe83b090ae476a34b49",
"title": "8acc8c30cf86c1760701cfe83b090ae476a34b49",
"url": "https://fuchsia.googlesource.com/integration/+/8acc8c30cf86c1760701cfe83b090ae476a34b49"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d5792b123b285f737f4152e5d606d1c95ca1d584"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d5792b123b285f737f4152e5d606d1c95ca1d584",
"title": "d5792b123b285f737f4152e5d606d1c95ca1d584",
"url": "https://fuchsia.googlesource.com/integration/+/d5792b123b285f737f4152e5d606d1c95ca1d584"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "48b094ea5569048aec883f6c720bb420f7163f62"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@48b094ea5569048aec883f6c720bb420f7163f62",
"title": "48b094ea5569048aec883f6c720bb420f7163f62",
"url": "https://fuchsia.googlesource.com/integration/+/48b094ea5569048aec883f6c720bb420f7163f62"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b9718b378f4f1b35fb19cb64afe71f66f6becc10"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b9718b378f4f1b35fb19cb64afe71f66f6becc10",
"title": "b9718b378f4f1b35fb19cb64afe71f66f6becc10",
"url": "https://fuchsia.googlesource.com/integration/+/b9718b378f4f1b35fb19cb64afe71f66f6becc10"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b9718b378f4f1b35fb19cb64afe71f66f6becc10",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8939961771914868944"
},
{
"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"
}
}
[06:04:52.366] Scheduled build:
{
"id": "8774531709921814369",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-07-26T06:04:51.963320879Z",
"updateTime": "2023-07-26T06:04:51.963320879Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b9718b378f4f1b35fb19cb64afe71f66f6becc10",
"ref": "refs/heads/main"
}
}
}
[06:04:52.366] Task URL: https://cr-buildbucket.appspot.com/build/8774531709921814369
[06:04:52.366] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:2:0) after 5m54s
[06:04:53.350] Received PubSub notification, asking Buildbucket for the build status
[06:04:53.382] Build status: SCHEDULED
[06:05:07.570] Received PubSub notification, asking Buildbucket for the build status
[06:05:07.662] Build status: STARTED
[06:10:46.710] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:2:0)
[06:10:46.757] Build status: STARTED
[06:10:46.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:5:0) after 3m35s
[06:14:21.770] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:5:0)
[06:14:21.799] Build status: STARTED
[06:14:21.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:6:0) after 7m54s
[06:22:15.836] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:6:0)
[06:22:15.887] Build status: STARTED
[06:22:15.887] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:7:0) after 7m52s
[06:30:07.919] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:7:0)
[06:30:07.950] Build status: STARTED
[06:30:07.950] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:8:0) after 6m53s
[06:37:01.174] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:8:0)
[06:37:01.202] Build status: STARTED
[06:37:01.202] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:9:0) after 8m43s
[06:45:44.219] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:9:0)
[06:45:44.236] Build status: STARTED
[06:45:44.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:10:0) after 7m41s
[06:53:25.333] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:10:0)
[06:53:25.377] Build status: STARTED
[06:53:25.377] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:11:0) after 1m25s
[06:54:50.501] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:11:0)
[06:54:50.517] Build status: STARTED
[06:54:50.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:12:0) after 3m59s
[06:58:49.835] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:12:0)
[06:58:49.854] Build status: STARTED
[06:58:49.854] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:13:0) after 2m10s
[07:00:59.869] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:13:0)
[07:00:59.901] Build status: STARTED
[07:00:59.901] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:14:0) after 5m39s
[07:06:39.030] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:14:0)
[07:06:39.049] Build status: STARTED
[07:06:39.049] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:15:0) after 4m5s
[07:10:44.165] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:15:0)
[07:10:44.183] Build status: STARTED
[07:10:44.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:16:0) after 6m29s
[07:17:13.209] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:16:0)
[07:17:13.229] Build status: STARTED
[07:17:13.229] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:17:0) after 5m56s
[07:23:09.341] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:17:0)
[07:23:09.877] Build status: STARTED
[07:23:09.877] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:18:0) after 7m52s
[07:31:01.938] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:18:0)
[07:31:01.959] Build status: STARTED
[07:31:01.959] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8939961771914868944:19:0) after 9m40s
[07:35:07.842] Received PubSub notification, asking Buildbucket for the build status
[07:35:07.865] Build:
{
"id": "8774531709921814369",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-07-26T06:04:51.963320879Z",
"startTime": "2023-07-26T06:05:06.713656Z",
"endTime": "2023-07-26T07:35:07.251974003Z",
"updateTime": "2023-07-26T07:35:07.251974003Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b9718b378f4f1b35fb19cb64afe71f66f6becc10",
"ref": "refs/heads/main"
}
}
}
[07:35:07.865] Invocation finished in 1h30m17.185723969s with status FAILED