[20:14:40.269] New invocation is queued and will start shortly
[20:14:41.495] Starting the invocation (attempt 1)
[20:14:41.528] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/8bb5476cf5d042af64d9e6c2be3060019b372d46"
[20:14:41.528] Popped gitiles commit info from properties and tags
[20:14:41.528] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:14:41.528] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:14:41.529] Buildbucket request:
{
"requestId": "8949964568737861760",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8949964568737861760",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ce0beb1050bf396d7ed051cca8ce53da0bbe7185"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ce0beb1050bf396d7ed051cca8ce53da0bbe7185",
"title": "ce0beb1050bf396d7ed051cca8ce53da0bbe7185",
"url": "https://fuchsia.googlesource.com/integration/+/ce0beb1050bf396d7ed051cca8ce53da0bbe7185"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d3114b2e90925d2e09d9b9fd51aafdb5e1d28b3f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d3114b2e90925d2e09d9b9fd51aafdb5e1d28b3f",
"title": "d3114b2e90925d2e09d9b9fd51aafdb5e1d28b3f",
"url": "https://fuchsia.googlesource.com/integration/+/d3114b2e90925d2e09d9b9fd51aafdb5e1d28b3f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f0c68d354ddbff63175ff1af5ad65fd97e4c2510"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f0c68d354ddbff63175ff1af5ad65fd97e4c2510",
"title": "f0c68d354ddbff63175ff1af5ad65fd97e4c2510",
"url": "https://fuchsia.googlesource.com/integration/+/f0c68d354ddbff63175ff1af5ad65fd97e4c2510"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a41c08c590885e169303e5478a05c41baf0eae01"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a41c08c590885e169303e5478a05c41baf0eae01",
"title": "a41c08c590885e169303e5478a05c41baf0eae01",
"url": "https://fuchsia.googlesource.com/integration/+/a41c08c590885e169303e5478a05c41baf0eae01"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ab0562b34fe6ba697172f7310b2d408d1b54b1a0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ab0562b34fe6ba697172f7310b2d408d1b54b1a0",
"title": "ab0562b34fe6ba697172f7310b2d408d1b54b1a0",
"url": "https://fuchsia.googlesource.com/integration/+/ab0562b34fe6ba697172f7310b2d408d1b54b1a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c23681a9cf974b0ba2bd30c8bee991aa5e46fe09"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c23681a9cf974b0ba2bd30c8bee991aa5e46fe09",
"title": "c23681a9cf974b0ba2bd30c8bee991aa5e46fe09",
"url": "https://fuchsia.googlesource.com/integration/+/c23681a9cf974b0ba2bd30c8bee991aa5e46fe09"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c523d38b242cdeefad235aefc4b08fbb6a05a29c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c523d38b242cdeefad235aefc4b08fbb6a05a29c",
"title": "c523d38b242cdeefad235aefc4b08fbb6a05a29c",
"url": "https://fuchsia.googlesource.com/integration/+/c523d38b242cdeefad235aefc4b08fbb6a05a29c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "13def9fafa2282f9dcb77dcd6f3c20c373c06895"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@13def9fafa2282f9dcb77dcd6f3c20c373c06895",
"title": "13def9fafa2282f9dcb77dcd6f3c20c373c06895",
"url": "https://fuchsia.googlesource.com/integration/+/13def9fafa2282f9dcb77dcd6f3c20c373c06895"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0a857c677d911a7ec06ccb9bea9c3f947ca03f71"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0a857c677d911a7ec06ccb9bea9c3f947ca03f71",
"title": "0a857c677d911a7ec06ccb9bea9c3f947ca03f71",
"url": "https://fuchsia.googlesource.com/integration/+/0a857c677d911a7ec06ccb9bea9c3f947ca03f71"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "123fb25b782152ca51e8d07506f99961d64564c0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@123fb25b782152ca51e8d07506f99961d64564c0",
"title": "123fb25b782152ca51e8d07506f99961d64564c0",
"url": "https://fuchsia.googlesource.com/integration/+/123fb25b782152ca51e8d07506f99961d64564c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "04d8b06c53837a33d7d6aab5c78009994ef3ad6a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@04d8b06c53837a33d7d6aab5c78009994ef3ad6a",
"title": "04d8b06c53837a33d7d6aab5c78009994ef3ad6a",
"url": "https://fuchsia.googlesource.com/integration/+/04d8b06c53837a33d7d6aab5c78009994ef3ad6a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "87f52faf1162d0094b3cce3e9bacead5323d9095"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@87f52faf1162d0094b3cce3e9bacead5323d9095",
"title": "87f52faf1162d0094b3cce3e9bacead5323d9095",
"url": "https://fuchsia.googlesource.com/integration/+/87f52faf1162d0094b3cce3e9bacead5323d9095"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "08b784034f5279fb6c001d41f1c1b303269292b2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@08b784034f5279fb6c001d41f1c1b303269292b2",
"title": "08b784034f5279fb6c001d41f1c1b303269292b2",
"url": "https://fuchsia.googlesource.com/integration/+/08b784034f5279fb6c001d41f1c1b303269292b2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1e075dacd34b37aa8911a381b5bda15ee82eb896"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1e075dacd34b37aa8911a381b5bda15ee82eb896",
"title": "1e075dacd34b37aa8911a381b5bda15ee82eb896",
"url": "https://fuchsia.googlesource.com/integration/+/1e075dacd34b37aa8911a381b5bda15ee82eb896"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8bb5476cf5d042af64d9e6c2be3060019b372d46"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8bb5476cf5d042af64d9e6c2be3060019b372d46",
"title": "8bb5476cf5d042af64d9e6c2be3060019b372d46",
"url": "https://fuchsia.googlesource.com/integration/+/8bb5476cf5d042af64d9e6c2be3060019b372d46"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8bb5476cf5d042af64d9e6c2be3060019b372d46",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8949964568737861760"
},
{
"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"
}
}
[20:14:41.872] Scheduled build:
{
"id": "8784534506684183281",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-06T20:14:41.598138978Z",
"updateTime": "2023-04-06T20:14:41.598138978Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8bb5476cf5d042af64d9e6c2be3060019b372d46",
"ref": "refs/heads/main"
}
}
}
[20:14:41.872] Task URL: https://cr-buildbucket.appspot.com/build/8784534506684183281
[20:14:41.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:2:0) after 3m40s
[20:16:27.367] Received PubSub notification, asking Buildbucket for the build status
[20:16:27.387] Build status: STARTED
[20:18:21.945] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:2:0)
[20:18:21.971] Build status: STARTED
[20:18:21.971] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:4:0) after 6m57s
[20:25:19.143] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:4:0)
[20:25:19.168] Build status: STARTED
[20:25:19.168] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:5:0) after 6m49s
[20:32:08.241] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:5:0)
[20:32:08.267] Build status: STARTED
[20:32:08.267] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:6:0) after 8m2s
[20:40:10.708] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:6:0)
[20:40:10.769] Build status: STARTED
[20:40:10.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:7:0) after 2m48s
[20:42:58.909] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:7:0)
[20:42:58.930] Build status: STARTED
[20:42:58.930] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:8:0) after 1m32s
[20:44:31.043] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:8:0)
[20:44:31.067] Build status: STARTED
[20:44:31.067] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:9:0) after 6m14s
[20:50:45.156] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:9:0)
[20:50:45.177] Build status: STARTED
[20:50:45.177] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:10:0) after 5m52s
[20:56:37.200] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:10:0)
[20:56:37.232] Build status: STARTED
[20:56:37.232] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:11:0) after 1m2s
[20:57:39.218] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:11:0)
[20:57:39.240] Build status: STARTED
[20:57:39.240] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:12:0) after 1m30s
[20:59:09.448] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:12:0)
[20:59:09.478] Build status: STARTED
[20:59:09.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:13:0) after 5m1s
[21:04:10.571] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:13:0)
[21:04:10.654] Build status: STARTED
[21:04:10.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:14:0) after 2m31s
[21:06:41.875] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:14:0)
[21:06:41.898] Build status: STARTED
[21:06:41.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:15:0) after 6m27s
[21:13:09.342] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:15:0)
[21:13:09.364] Build status: STARTED
[21:13:09.364] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:16:0) after 5m22s
[21:18:31.388] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:16:0)
[21:18:31.420] Build status: STARTED
[21:18:31.420] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:17:0) after 5m20s
[21:23:51.499] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:17:0)
[21:23:51.521] Build status: STARTED
[21:23:51.521] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:18:0) after 3m36s
[21:27:27.723] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:18:0)
[21:27:27.740] Build status: STARTED
[21:27:27.740] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:19:0) after 3m40s
[21:31:07.772] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:19:0)
[21:31:07.800] Build status: STARTED
[21:31:07.800] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:20:0) after 8m18s
[21:39:25.964] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:20:0)
[21:39:25.984] Build status: STARTED
[21:39:25.984] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:21:0) after 2m30s
[21:41:56.092] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:21:0)
[21:41:56.111] Build status: STARTED
[21:41:56.111] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8949964568737861760:22:0) after 8m18s
[21:48:39.946] Received PubSub notification, asking Buildbucket for the build status
[21:48:39.986] Build:
{
"id": "8784534506684183281",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-06T20:14:41.598138978Z",
"startTime": "2023-04-06T20:16:26.843033Z",
"endTime": "2023-04-06T21:48:39.496933503Z",
"updateTime": "2023-04-06T21:48:39.496933503Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8bb5476cf5d042af64d9e6c2be3060019b372d46",
"ref": "refs/heads/main"
}
}
}
[21:48:39.986] Invocation finished in 1h33m59.729457926s with status FAILED