[16:14:04.822] New invocation is queued and will start shortly
[16:14:05.926] Starting the invocation (attempt 1)
[16:14:05.955] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/11e21f2d28f2b03c02d5fef513b764eaf0e5bd4a"
[16:14:05.955] Popped gitiles commit info from properties and tags
[16:14:05.955] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:14:05.955] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:14:05.955] Buildbucket request:
{
"requestId": "8945540454047871952",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8945540454047871952",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8e43bc5d7ff981a5a7ea9b8243d2682610905249"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8e43bc5d7ff981a5a7ea9b8243d2682610905249",
"title": "8e43bc5d7ff981a5a7ea9b8243d2682610905249",
"url": "https://fuchsia.googlesource.com/integration/+/8e43bc5d7ff981a5a7ea9b8243d2682610905249"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9bd1184e6dd44fe0064659b90fe41435571ed208"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9bd1184e6dd44fe0064659b90fe41435571ed208",
"title": "9bd1184e6dd44fe0064659b90fe41435571ed208",
"url": "https://fuchsia.googlesource.com/integration/+/9bd1184e6dd44fe0064659b90fe41435571ed208"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d9daa67a131c84ae8338d5febdde9d6a9c95c259"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d9daa67a131c84ae8338d5febdde9d6a9c95c259",
"title": "d9daa67a131c84ae8338d5febdde9d6a9c95c259",
"url": "https://fuchsia.googlesource.com/integration/+/d9daa67a131c84ae8338d5febdde9d6a9c95c259"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2efb955f9a9fd0c3807f836d1e592acdcd5b7f34"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2efb955f9a9fd0c3807f836d1e592acdcd5b7f34",
"title": "2efb955f9a9fd0c3807f836d1e592acdcd5b7f34",
"url": "https://fuchsia.googlesource.com/integration/+/2efb955f9a9fd0c3807f836d1e592acdcd5b7f34"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fe1b37fa8034620f05120eec9d6c19d9e52dabc1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fe1b37fa8034620f05120eec9d6c19d9e52dabc1",
"title": "fe1b37fa8034620f05120eec9d6c19d9e52dabc1",
"url": "https://fuchsia.googlesource.com/integration/+/fe1b37fa8034620f05120eec9d6c19d9e52dabc1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1acb4b9784b23e903088b31eec90dec93f04425d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1acb4b9784b23e903088b31eec90dec93f04425d",
"title": "1acb4b9784b23e903088b31eec90dec93f04425d",
"url": "https://fuchsia.googlesource.com/integration/+/1acb4b9784b23e903088b31eec90dec93f04425d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4b055fe7861a998b6085316ce989bdc3edb09c7e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4b055fe7861a998b6085316ce989bdc3edb09c7e",
"title": "4b055fe7861a998b6085316ce989bdc3edb09c7e",
"url": "https://fuchsia.googlesource.com/integration/+/4b055fe7861a998b6085316ce989bdc3edb09c7e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ff7aa6a0413ed87a6dc40840986efbb17432c295"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ff7aa6a0413ed87a6dc40840986efbb17432c295",
"title": "ff7aa6a0413ed87a6dc40840986efbb17432c295",
"url": "https://fuchsia.googlesource.com/integration/+/ff7aa6a0413ed87a6dc40840986efbb17432c295"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c393011aa391e4765201a1fe617d0b0817f90674"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c393011aa391e4765201a1fe617d0b0817f90674",
"title": "c393011aa391e4765201a1fe617d0b0817f90674",
"url": "https://fuchsia.googlesource.com/integration/+/c393011aa391e4765201a1fe617d0b0817f90674"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6bd03c412e5f6bea3430b6abd2490f9743b6af3c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6bd03c412e5f6bea3430b6abd2490f9743b6af3c",
"title": "6bd03c412e5f6bea3430b6abd2490f9743b6af3c",
"url": "https://fuchsia.googlesource.com/integration/+/6bd03c412e5f6bea3430b6abd2490f9743b6af3c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "eee1771c42e1153d8b891b8bc878251d9e162cea"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@eee1771c42e1153d8b891b8bc878251d9e162cea",
"title": "eee1771c42e1153d8b891b8bc878251d9e162cea",
"url": "https://fuchsia.googlesource.com/integration/+/eee1771c42e1153d8b891b8bc878251d9e162cea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5f0fed9d3b53c50c89587be91bfbc649a22c97e9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5f0fed9d3b53c50c89587be91bfbc649a22c97e9",
"title": "5f0fed9d3b53c50c89587be91bfbc649a22c97e9",
"url": "https://fuchsia.googlesource.com/integration/+/5f0fed9d3b53c50c89587be91bfbc649a22c97e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "11e21f2d28f2b03c02d5fef513b764eaf0e5bd4a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@11e21f2d28f2b03c02d5fef513b764eaf0e5bd4a",
"title": "11e21f2d28f2b03c02d5fef513b764eaf0e5bd4a",
"url": "https://fuchsia.googlesource.com/integration/+/11e21f2d28f2b03c02d5fef513b764eaf0e5bd4a"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "11e21f2d28f2b03c02d5fef513b764eaf0e5bd4a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8945540454047871952"
},
{
"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"
}
}
[16:14:06.344] Scheduled build:
{
"id": "8780110392124662369",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-25T16:14:06.027790593Z",
"updateTime": "2023-05-25T16:14:06.027790593Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "11e21f2d28f2b03c02d5fef513b764eaf0e5bd4a",
"ref": "refs/heads/main"
}
}
}
[16:14:06.344] Task URL: https://cr-buildbucket.appspot.com/build/8780110392124662369
[16:14:06.344] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:2:0) after 9m19s
[16:15:21.870] Received PubSub notification, asking Buildbucket for the build status
[16:15:21.898] Build status: STARTED
[16:23:25.361] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:2:0)
[16:23:25.525] Build status: STARTED
[16:23:25.525] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:4:0) after 5m44s
[16:29:09.543] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:4:0)
[16:29:09.577] Build status: STARTED
[16:29:09.577] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:5:0) after 9m45s
[16:38:54.598] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:5:0)
[16:38:54.666] Build status: STARTED
[16:38:54.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:6:0) after 8m27s
[16:47:21.680] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:6:0)
[16:47:21.704] Build status: STARTED
[16:47:21.704] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:7:0) after 8m23s
[16:55:44.758] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:7:0)
[16:55:44.785] Build status: STARTED
[16:55:44.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:8:0) after 9m53s
[17:05:37.864] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:8:0)
[17:05:37.890] Build status: STARTED
[17:05:37.890] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:9:0) after 4m39s
[17:10:16.916] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:9:0)
[17:10:16.937] Build status: STARTED
[17:10:16.937] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:10:0) after 9m59s
[17:20:15.989] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:10:0)
[17:20:16.008] Build status: STARTED
[17:20:16.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:11:0) after 6m58s
[17:27:14.076] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:11:0)
[17:27:14.093] Build status: STARTED
[17:27:14.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8945540454047871952:12:0) after 5m8s
[17:28:18.354] Received PubSub notification, asking Buildbucket for the build status
[17:28:18.527] Build:
{
"id": "8780110392124662369",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-25T16:14:06.027790593Z",
"startTime": "2023-05-25T16:15:05.631513Z",
"endTime": "2023-05-25T17:28:17.849382722Z",
"updateTime": "2023-05-25T17:28:17.849382722Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "11e21f2d28f2b03c02d5fef513b764eaf0e5bd4a",
"ref": "refs/heads/main"
}
}
}
[17:28:18.527] Invocation finished in 1h14m13.718568975s with status FAILED