[19:42:15.185] New invocation is queued and will start shortly
[19:42:16.375] Starting the invocation (attempt 1)
[19:42:16.399] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/f75cce2cf6ca4b36712874641cf7e772b39aa54c"
[19:42:16.399] Popped gitiles commit info from properties and tags
[19:42:16.399] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:42:16.400] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:42:16.400] Buildbucket request:
{
"requestId": "8938641987500545856",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8938641987500545856",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8a60b70daf653be8de124386e2d24a1dc4fbccd7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8a60b70daf653be8de124386e2d24a1dc4fbccd7",
"title": "8a60b70daf653be8de124386e2d24a1dc4fbccd7",
"url": "https://fuchsia.googlesource.com/integration/+/8a60b70daf653be8de124386e2d24a1dc4fbccd7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "05b4ed2093c422c0a542f9a68860feadfd7679bf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@05b4ed2093c422c0a542f9a68860feadfd7679bf",
"title": "05b4ed2093c422c0a542f9a68860feadfd7679bf",
"url": "https://fuchsia.googlesource.com/integration/+/05b4ed2093c422c0a542f9a68860feadfd7679bf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bb3ab832ba5ae29bbf8159c24333e8db336f70b3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bb3ab832ba5ae29bbf8159c24333e8db336f70b3",
"title": "bb3ab832ba5ae29bbf8159c24333e8db336f70b3",
"url": "https://fuchsia.googlesource.com/integration/+/bb3ab832ba5ae29bbf8159c24333e8db336f70b3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f71d423e3a6ab5a4b2972257504a48bd7217c189"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f71d423e3a6ab5a4b2972257504a48bd7217c189",
"title": "f71d423e3a6ab5a4b2972257504a48bd7217c189",
"url": "https://fuchsia.googlesource.com/integration/+/f71d423e3a6ab5a4b2972257504a48bd7217c189"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ff95dc678efba79a2f7400a78f27fa603f6e87d0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ff95dc678efba79a2f7400a78f27fa603f6e87d0",
"title": "ff95dc678efba79a2f7400a78f27fa603f6e87d0",
"url": "https://fuchsia.googlesource.com/integration/+/ff95dc678efba79a2f7400a78f27fa603f6e87d0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "715cfa9dd29968941ff97d209e3ae21c511632be"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@715cfa9dd29968941ff97d209e3ae21c511632be",
"title": "715cfa9dd29968941ff97d209e3ae21c511632be",
"url": "https://fuchsia.googlesource.com/integration/+/715cfa9dd29968941ff97d209e3ae21c511632be"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "98573a183a502d2ca181d82d5deb46f88deb6d56"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@98573a183a502d2ca181d82d5deb46f88deb6d56",
"title": "98573a183a502d2ca181d82d5deb46f88deb6d56",
"url": "https://fuchsia.googlesource.com/integration/+/98573a183a502d2ca181d82d5deb46f88deb6d56"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c867bfc344f2e59fc57437be6d6e24f4361e1366"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c867bfc344f2e59fc57437be6d6e24f4361e1366",
"title": "c867bfc344f2e59fc57437be6d6e24f4361e1366",
"url": "https://fuchsia.googlesource.com/integration/+/c867bfc344f2e59fc57437be6d6e24f4361e1366"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8585ea7a872ee67d782c5d92ef129ffd2fe41002"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8585ea7a872ee67d782c5d92ef129ffd2fe41002",
"title": "8585ea7a872ee67d782c5d92ef129ffd2fe41002",
"url": "https://fuchsia.googlesource.com/integration/+/8585ea7a872ee67d782c5d92ef129ffd2fe41002"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "04bcc2fdb54a7b11d176c59624dad304e3254f9e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@04bcc2fdb54a7b11d176c59624dad304e3254f9e",
"title": "04bcc2fdb54a7b11d176c59624dad304e3254f9e",
"url": "https://fuchsia.googlesource.com/integration/+/04bcc2fdb54a7b11d176c59624dad304e3254f9e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c4ec3f19c370b2600e467e7b2679ac76ba2592a0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c4ec3f19c370b2600e467e7b2679ac76ba2592a0",
"title": "c4ec3f19c370b2600e467e7b2679ac76ba2592a0",
"url": "https://fuchsia.googlesource.com/integration/+/c4ec3f19c370b2600e467e7b2679ac76ba2592a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8079da6ab80509f7b2b754969cd44363aa8c69ed"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8079da6ab80509f7b2b754969cd44363aa8c69ed",
"title": "8079da6ab80509f7b2b754969cd44363aa8c69ed",
"url": "https://fuchsia.googlesource.com/integration/+/8079da6ab80509f7b2b754969cd44363aa8c69ed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f75cce2cf6ca4b36712874641cf7e772b39aa54c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f75cce2cf6ca4b36712874641cf7e772b39aa54c",
"title": "f75cce2cf6ca4b36712874641cf7e772b39aa54c",
"url": "https://fuchsia.googlesource.com/integration/+/f75cce2cf6ca4b36712874641cf7e772b39aa54c"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f75cce2cf6ca4b36712874641cf7e772b39aa54c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8938641987500545856"
},
{
"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:42:16.867] Scheduled build:
{
"id": "8773211925514837169",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-09T19:42:16.455722865Z",
"updateTime": "2023-08-09T19:42:16.455722865Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f75cce2cf6ca4b36712874641cf7e772b39aa54c",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:42:16.867] Task URL: https://cr-buildbucket.appspot.com/build/8773211925514837169
[19:42:16.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:2:0) after 3m30s
[19:42:17.801] Received PubSub notification, asking Buildbucket for the build status
[19:42:18.074] Build status: SCHEDULED
[19:42:32.617] Received PubSub notification, asking Buildbucket for the build status
[19:42:32.637] Build status: STARTED
[19:45:46.869] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:2:0)
[19:45:46.905] Build status: STARTED
[19:45:46.905] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:5:0) after 7m43s
[19:53:29.933] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:5:0)
[19:53:29.955] Build status: STARTED
[19:53:29.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:6:0) after 8m22s
[20:01:52.066] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:6:0)
[20:01:52.088] Build status: STARTED
[20:01:52.088] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:7:0) after 3m57s
[20:05:49.899] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:7:0)
[20:05:49.928] Build status: STARTED
[20:05:49.928] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:8:0) after 4m41s
[20:10:30.951] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:8:0)
[20:10:30.980] Build status: STARTED
[20:10:30.980] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:9:0) after 7m43s
[20:18:14.005] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:9:0)
[20:18:14.029] Build status: STARTED
[20:18:14.029] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:10:0) after 7m42s
[20:25:56.705] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:10:0)
[20:25:56.727] Build status: STARTED
[20:25:56.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:11:0) after 8m25s
[20:34:21.892] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:11:0)
[20:34:21.910] Build status: STARTED
[20:34:21.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:12:0) after 9m35s
[20:43:56.930] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:12:0)
[20:43:56.949] Build status: STARTED
[20:43:56.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:13:0) after 4m18s
[20:48:15.025] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:13:0)
[20:48:15.048] Build status: STARTED
[20:48:15.048] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:14:0) after 8m35s
[20:56:50.081] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:14:0)
[20:56:50.107] Build status: STARTED
[20:56:50.107] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:15:0) after 5m21s
[21:02:11.126] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:15:0)
[21:02:11.151] Build status: STARTED
[21:02:11.151] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:16:0) after 7m44s
[21:09:55.201] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:16:0)
[21:09:55.218] Build status: STARTED
[21:09:55.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938641987500545856:17:0) after 4m9s
[21:13:29.975] Received PubSub notification, asking Buildbucket for the build status
[21:13:29.991] Build:
{
"id": "8773211925514837169",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-09T19:42:16.455722865Z",
"startTime": "2023-08-09T19:42:31.430732Z",
"endTime": "2023-08-09T21:13:29.552750930Z",
"updateTime": "2023-08-09T21:13:29.552750930Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f75cce2cf6ca4b36712874641cf7e772b39aa54c",
"ref": "refs/heads/main"
}
},
"canary": true
}
[21:13:29.991] Invocation finished in 1h31m14.813499258s with status FAILED