[00:04:46.214] New invocation is queued and will start shortly
[00:04:48.098] Starting the invocation (attempt 1)
[00:04:48.136] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/fd0f2ecdeb462bfd7ac3d2611be027281b4090df"
[00:04:48.136] Popped gitiles commit info from properties and tags
[00:04:48.136] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:04:48.136] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:04:48.137] Buildbucket request:
{
"requestId": "8945692034727619456",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8945692034727619456",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "074138c8d6cf8b3eb4942199eab8f13fa339d1a8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@074138c8d6cf8b3eb4942199eab8f13fa339d1a8",
"title": "074138c8d6cf8b3eb4942199eab8f13fa339d1a8",
"url": "https://fuchsia.googlesource.com/integration/+/074138c8d6cf8b3eb4942199eab8f13fa339d1a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "06562d3b0611ffe3100484108d4c65743fb25099"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@06562d3b0611ffe3100484108d4c65743fb25099",
"title": "06562d3b0611ffe3100484108d4c65743fb25099",
"url": "https://fuchsia.googlesource.com/integration/+/06562d3b0611ffe3100484108d4c65743fb25099"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a05fc30c5b91761456deaf237762605860cde626"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a05fc30c5b91761456deaf237762605860cde626",
"title": "a05fc30c5b91761456deaf237762605860cde626",
"url": "https://fuchsia.googlesource.com/integration/+/a05fc30c5b91761456deaf237762605860cde626"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ed9711193b066b570bda8c6ebdd4d2d28e4857fc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ed9711193b066b570bda8c6ebdd4d2d28e4857fc",
"title": "ed9711193b066b570bda8c6ebdd4d2d28e4857fc",
"url": "https://fuchsia.googlesource.com/integration/+/ed9711193b066b570bda8c6ebdd4d2d28e4857fc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "242bfb946c6bdeca4f71211db3778c06ee956d21"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@242bfb946c6bdeca4f71211db3778c06ee956d21",
"title": "242bfb946c6bdeca4f71211db3778c06ee956d21",
"url": "https://fuchsia.googlesource.com/integration/+/242bfb946c6bdeca4f71211db3778c06ee956d21"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1902172c7db0861b8ebb1d96d15f2c083aa69ad8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1902172c7db0861b8ebb1d96d15f2c083aa69ad8",
"title": "1902172c7db0861b8ebb1d96d15f2c083aa69ad8",
"url": "https://fuchsia.googlesource.com/integration/+/1902172c7db0861b8ebb1d96d15f2c083aa69ad8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f98b7b167d1d0d02b39e67dd4e1840ea5b5598de"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f98b7b167d1d0d02b39e67dd4e1840ea5b5598de",
"title": "f98b7b167d1d0d02b39e67dd4e1840ea5b5598de",
"url": "https://fuchsia.googlesource.com/integration/+/f98b7b167d1d0d02b39e67dd4e1840ea5b5598de"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ef3d48867b81c8af31a52d6ccf5768578dbf1dd8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ef3d48867b81c8af31a52d6ccf5768578dbf1dd8",
"title": "ef3d48867b81c8af31a52d6ccf5768578dbf1dd8",
"url": "https://fuchsia.googlesource.com/integration/+/ef3d48867b81c8af31a52d6ccf5768578dbf1dd8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4ab8eca9504faff36539c0b7bea4a9a8bbd6e214"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4ab8eca9504faff36539c0b7bea4a9a8bbd6e214",
"title": "4ab8eca9504faff36539c0b7bea4a9a8bbd6e214",
"url": "https://fuchsia.googlesource.com/integration/+/4ab8eca9504faff36539c0b7bea4a9a8bbd6e214"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "90f5989b0cd2538ed4122b94e5b38ba74e2b7500"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@90f5989b0cd2538ed4122b94e5b38ba74e2b7500",
"title": "90f5989b0cd2538ed4122b94e5b38ba74e2b7500",
"url": "https://fuchsia.googlesource.com/integration/+/90f5989b0cd2538ed4122b94e5b38ba74e2b7500"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "12d337b3104d8b0f13825e1e3063be6bc0c543b7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@12d337b3104d8b0f13825e1e3063be6bc0c543b7",
"title": "12d337b3104d8b0f13825e1e3063be6bc0c543b7",
"url": "https://fuchsia.googlesource.com/integration/+/12d337b3104d8b0f13825e1e3063be6bc0c543b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "53e601f93faac783fd00a3c3f37e2349433a72a3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@53e601f93faac783fd00a3c3f37e2349433a72a3",
"title": "53e601f93faac783fd00a3c3f37e2349433a72a3",
"url": "https://fuchsia.googlesource.com/integration/+/53e601f93faac783fd00a3c3f37e2349433a72a3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9cccbe7648235395dc4b0cdd11517041a72e283b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9cccbe7648235395dc4b0cdd11517041a72e283b",
"title": "9cccbe7648235395dc4b0cdd11517041a72e283b",
"url": "https://fuchsia.googlesource.com/integration/+/9cccbe7648235395dc4b0cdd11517041a72e283b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b90e85170b99ffa352213ed8b2298d729b7b75bc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b90e85170b99ffa352213ed8b2298d729b7b75bc",
"title": "b90e85170b99ffa352213ed8b2298d729b7b75bc",
"url": "https://fuchsia.googlesource.com/integration/+/b90e85170b99ffa352213ed8b2298d729b7b75bc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "04c38df58277bd60595ccbeae2fcf9a68e341078"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@04c38df58277bd60595ccbeae2fcf9a68e341078",
"title": "04c38df58277bd60595ccbeae2fcf9a68e341078",
"url": "https://fuchsia.googlesource.com/integration/+/04c38df58277bd60595ccbeae2fcf9a68e341078"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "905dbf939f45e1ec1b8598ccf23a67b640d2c0ad"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@905dbf939f45e1ec1b8598ccf23a67b640d2c0ad",
"title": "905dbf939f45e1ec1b8598ccf23a67b640d2c0ad",
"url": "https://fuchsia.googlesource.com/integration/+/905dbf939f45e1ec1b8598ccf23a67b640d2c0ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a1990d98c69e6457211313383a1c9ab9b8819986"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a1990d98c69e6457211313383a1c9ab9b8819986",
"title": "a1990d98c69e6457211313383a1c9ab9b8819986",
"url": "https://fuchsia.googlesource.com/integration/+/a1990d98c69e6457211313383a1c9ab9b8819986"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1dae6508627940254b6df169db2ee9438045426a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1dae6508627940254b6df169db2ee9438045426a",
"title": "1dae6508627940254b6df169db2ee9438045426a",
"url": "https://fuchsia.googlesource.com/integration/+/1dae6508627940254b6df169db2ee9438045426a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fd0f2ecdeb462bfd7ac3d2611be027281b4090df"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fd0f2ecdeb462bfd7ac3d2611be027281b4090df",
"title": "fd0f2ecdeb462bfd7ac3d2611be027281b4090df",
"url": "https://fuchsia.googlesource.com/integration/+/fd0f2ecdeb462bfd7ac3d2611be027281b4090df"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "fd0f2ecdeb462bfd7ac3d2611be027281b4090df",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8945692034727619456"
},
{
"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"
}
}
[00:04:48.596] Scheduled build:
{
"id": "8780261971918898081",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-24T00:04:48.270242855Z",
"updateTime": "2023-05-24T00:04:48.270242855Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "fd0f2ecdeb462bfd7ac3d2611be027281b4090df",
"ref": "refs/heads/main"
}
}
}
[00:04:48.596] Task URL: https://cr-buildbucket.appspot.com/build/8780261971918898081
[00:04:48.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:2:0) after 2m28s
[00:04:57.157] Received PubSub notification, asking Buildbucket for the build status
[00:04:57.179] Build status: STARTED
[00:07:16.696] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:2:0)
[00:07:16.729] Build status: STARTED
[00:07:16.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:4:0) after 1m16s
[00:08:32.749] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:4:0)
[00:08:32.773] Build status: STARTED
[00:08:32.773] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:5:0) after 9m26s
[00:17:58.878] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:5:0)
[00:17:58.902] Build status: STARTED
[00:17:58.903] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:6:0) after 5m24s
[00:23:23.172] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:6:0)
[00:23:23.195] Build status: STARTED
[00:23:23.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:7:0) after 1m20s
[00:24:43.279] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:7:0)
[00:24:43.316] Build status: STARTED
[00:24:43.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:8:0) after 9m27s
[00:34:10.830] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:8:0)
[00:34:10.920] Build status: STARTED
[00:34:10.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:9:0) after 8m4s
[00:42:15.036] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:9:0)
[00:42:15.080] Build status: STARTED
[00:42:15.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:10:0) after 1m21s
[00:43:36.064] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:10:0)
[00:43:36.084] Build status: STARTED
[00:43:36.084] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:11:0) after 6m28s
[00:50:04.246] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:11:0)
[00:50:04.269] Build status: STARTED
[00:50:04.269] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:12:0) after 3m41s
[00:53:45.296] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:12:0)
[00:53:45.316] Build status: STARTED
[00:53:45.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:13:0) after 9m52s
[01:03:37.348] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:13:0)
[01:03:37.416] Build status: STARTED
[01:03:37.416] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:14:0) after 8m26s
[01:12:03.438] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:14:0)
[01:12:03.461] Build status: STARTED
[01:12:03.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:15:0) after 2m34s
[01:14:37.481] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:15:0)
[01:14:37.505] Build status: STARTED
[01:14:37.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:16:0) after 1m20s
[01:15:57.530] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:16:0)
[01:15:57.556] Build status: STARTED
[01:15:57.556] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:17:0) after 9m10s
[01:25:07.675] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:17:0)
[01:25:07.692] Build status: STARTED
[01:25:07.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:18:0) after 1m21s
[01:26:28.905] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:18:0)
[01:26:28.965] Build status: STARTED
[01:26:28.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945692034727619456:19:0) after 7m48s
[01:32:58.543] Received PubSub notification, asking Buildbucket for the build status
[01:32:58.627] Build:
{
"id": "8780261971918898081",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-24T00:04:48.270242855Z",
"startTime": "2023-05-24T00:04:56.503654Z",
"endTime": "2023-05-24T01:32:58.193829871Z",
"updateTime": "2023-05-24T01:32:58.193829871Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "fd0f2ecdeb462bfd7ac3d2611be027281b4090df",
"ref": "refs/heads/main"
}
}
}
[01:32:58.627] Invocation finished in 1h28m12.419228529s with status FAILED