[19:56:56.908] New invocation is queued and will start shortly
[19:56:58.408] Starting the invocation (attempt 1)
[19:56:58.441] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/fa9f52ee7fd3e56f524e09ad37e6846885c43eec"
[19:56:58.441] Popped gitiles commit info from properties and tags
[19:56:58.441] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:56:58.441] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:56:58.442] Buildbucket request:
{
"requestId": "8950781056446149584",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8950781056446149584",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fbed7aace7e14356f65730dc9c9cc65f5d1e455d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fbed7aace7e14356f65730dc9c9cc65f5d1e455d",
"title": "fbed7aace7e14356f65730dc9c9cc65f5d1e455d",
"url": "https://fuchsia.googlesource.com/integration/+/fbed7aace7e14356f65730dc9c9cc65f5d1e455d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4111c30f7bd2aa69c2f501a2cf92c578336ceae6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4111c30f7bd2aa69c2f501a2cf92c578336ceae6",
"title": "4111c30f7bd2aa69c2f501a2cf92c578336ceae6",
"url": "https://fuchsia.googlesource.com/integration/+/4111c30f7bd2aa69c2f501a2cf92c578336ceae6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8e538a00d6731cb2668e2c9b3d684a987bf1428d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8e538a00d6731cb2668e2c9b3d684a987bf1428d",
"title": "8e538a00d6731cb2668e2c9b3d684a987bf1428d",
"url": "https://fuchsia.googlesource.com/integration/+/8e538a00d6731cb2668e2c9b3d684a987bf1428d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "98375211309fc0f7f6db1004c031d2e623a343e4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@98375211309fc0f7f6db1004c031d2e623a343e4",
"title": "98375211309fc0f7f6db1004c031d2e623a343e4",
"url": "https://fuchsia.googlesource.com/integration/+/98375211309fc0f7f6db1004c031d2e623a343e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e91109f9e8b769acaad25cc0ca38a94e6d064dae"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e91109f9e8b769acaad25cc0ca38a94e6d064dae",
"title": "e91109f9e8b769acaad25cc0ca38a94e6d064dae",
"url": "https://fuchsia.googlesource.com/integration/+/e91109f9e8b769acaad25cc0ca38a94e6d064dae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0c661be3c90ab908d7ab0c4bb4ed324f2eaa65d3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0c661be3c90ab908d7ab0c4bb4ed324f2eaa65d3",
"title": "0c661be3c90ab908d7ab0c4bb4ed324f2eaa65d3",
"url": "https://fuchsia.googlesource.com/integration/+/0c661be3c90ab908d7ab0c4bb4ed324f2eaa65d3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d68bbc1ecd33cb96fb9b8a832c82406f4177fdc9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d68bbc1ecd33cb96fb9b8a832c82406f4177fdc9",
"title": "d68bbc1ecd33cb96fb9b8a832c82406f4177fdc9",
"url": "https://fuchsia.googlesource.com/integration/+/d68bbc1ecd33cb96fb9b8a832c82406f4177fdc9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "236510e03cb5af8febb40a930de76ac7973e7612"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@236510e03cb5af8febb40a930de76ac7973e7612",
"title": "236510e03cb5af8febb40a930de76ac7973e7612",
"url": "https://fuchsia.googlesource.com/integration/+/236510e03cb5af8febb40a930de76ac7973e7612"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d63c16c269970134c6ac1d73875b91e1262da1f9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d63c16c269970134c6ac1d73875b91e1262da1f9",
"title": "d63c16c269970134c6ac1d73875b91e1262da1f9",
"url": "https://fuchsia.googlesource.com/integration/+/d63c16c269970134c6ac1d73875b91e1262da1f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "771f5a310ab53690ef919028a380b95ff735982b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@771f5a310ab53690ef919028a380b95ff735982b",
"title": "771f5a310ab53690ef919028a380b95ff735982b",
"url": "https://fuchsia.googlesource.com/integration/+/771f5a310ab53690ef919028a380b95ff735982b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a1c2ceaad3f71e08602b73c03eab5319d5df9143"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a1c2ceaad3f71e08602b73c03eab5319d5df9143",
"title": "a1c2ceaad3f71e08602b73c03eab5319d5df9143",
"url": "https://fuchsia.googlesource.com/integration/+/a1c2ceaad3f71e08602b73c03eab5319d5df9143"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "643a8659a133d32b75f0325a7b170f555aaad01c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@643a8659a133d32b75f0325a7b170f555aaad01c",
"title": "643a8659a133d32b75f0325a7b170f555aaad01c",
"url": "https://fuchsia.googlesource.com/integration/+/643a8659a133d32b75f0325a7b170f555aaad01c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0c6f0a11ce3d36af898e9c0d2f35ec781b66dbf8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0c6f0a11ce3d36af898e9c0d2f35ec781b66dbf8",
"title": "0c6f0a11ce3d36af898e9c0d2f35ec781b66dbf8",
"url": "https://fuchsia.googlesource.com/integration/+/0c6f0a11ce3d36af898e9c0d2f35ec781b66dbf8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cce95477ad86a9a301e4e0633870b27429dc7725"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cce95477ad86a9a301e4e0633870b27429dc7725",
"title": "cce95477ad86a9a301e4e0633870b27429dc7725",
"url": "https://fuchsia.googlesource.com/integration/+/cce95477ad86a9a301e4e0633870b27429dc7725"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f296f2189cfc9f1b27f1c5f608d5dbd356deae8f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f296f2189cfc9f1b27f1c5f608d5dbd356deae8f",
"title": "f296f2189cfc9f1b27f1c5f608d5dbd356deae8f",
"url": "https://fuchsia.googlesource.com/integration/+/f296f2189cfc9f1b27f1c5f608d5dbd356deae8f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ad4173d5669187066f63e087e5c6c6b658dd5392"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ad4173d5669187066f63e087e5c6c6b658dd5392",
"title": "ad4173d5669187066f63e087e5c6c6b658dd5392",
"url": "https://fuchsia.googlesource.com/integration/+/ad4173d5669187066f63e087e5c6c6b658dd5392"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dcc8ddb20a4d2be306004c9cd5dcaa3418e9ddb1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dcc8ddb20a4d2be306004c9cd5dcaa3418e9ddb1",
"title": "dcc8ddb20a4d2be306004c9cd5dcaa3418e9ddb1",
"url": "https://fuchsia.googlesource.com/integration/+/dcc8ddb20a4d2be306004c9cd5dcaa3418e9ddb1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7c35b31c4404b54d064ec5a782f74c803f83ff2e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7c35b31c4404b54d064ec5a782f74c803f83ff2e",
"title": "7c35b31c4404b54d064ec5a782f74c803f83ff2e",
"url": "https://fuchsia.googlesource.com/integration/+/7c35b31c4404b54d064ec5a782f74c803f83ff2e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fa9f52ee7fd3e56f524e09ad37e6846885c43eec"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fa9f52ee7fd3e56f524e09ad37e6846885c43eec",
"title": "fa9f52ee7fd3e56f524e09ad37e6846885c43eec",
"url": "https://fuchsia.googlesource.com/integration/+/fa9f52ee7fd3e56f524e09ad37e6846885c43eec"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "fa9f52ee7fd3e56f524e09ad37e6846885c43eec",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8950781056446149584"
},
{
"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:56:58.923] Scheduled build:
{
"id": "8785350994096273153",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-03-28T19:56:58.524061913Z",
"updateTime": "2023-03-28T19:56:58.524061913Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "fa9f52ee7fd3e56f524e09ad37e6846885c43eec",
"ref": "refs/heads/main"
}
}
}
[19:56:58.923] Task URL: https://cr-buildbucket.appspot.com/build/8785350994096273153
[19:56:58.923] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:2:0) after 5m57s
[19:57:03.786] Received PubSub notification, asking Buildbucket for the build status
[19:57:03.847] Build status: STARTED
[20:02:56.146] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:2:0)
[20:02:56.182] Build status: STARTED
[20:02:56.182] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:4:0) after 4m24s
[20:07:20.200] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:4:0)
[20:07:20.231] Build status: STARTED
[20:07:20.231] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:5:0) after 7m3s
[20:14:23.387] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:5:0)
[20:14:23.448] Build status: STARTED
[20:14:23.448] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:6:0) after 3m22s
[20:17:45.469] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:6:0)
[20:17:45.490] Build status: STARTED
[20:17:45.490] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:7:0) after 7m4s
[20:24:49.900] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:7:0)
[20:24:49.924] Build status: STARTED
[20:24:49.924] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:8:0) after 8m3s
[20:32:52.949] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:8:0)
[20:32:52.990] Build status: STARTED
[20:32:52.990] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:9:0) after 9m52s
[20:42:45.336] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:9:0)
[20:42:45.364] Build status: STARTED
[20:42:45.364] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:10:0) after 5m3s
[20:47:48.835] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:10:0)
[20:47:48.869] Build status: STARTED
[20:47:48.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:11:0) after 6m44s
[20:54:32.979] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:11:0)
[20:54:33.059] Build status: STARTED
[20:54:33.059] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:12:0) after 9m22s
[21:03:55.652] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:12:0)
[21:03:55.684] Build status: STARTED
[21:03:55.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:13:0) after 5m4s
[21:08:59.714] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:13:0)
[21:08:59.740] Build status: STARTED
[21:08:59.740] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:14:0) after 1m47s
[21:10:46.758] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:14:0)
[21:10:46.784] Build status: STARTED
[21:10:46.784] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:15:0) after 6m25s
[21:17:11.865] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:15:0)
[21:17:11.885] Build status: STARTED
[21:17:11.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:16:0) after 2m57s
[21:20:08.925] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:16:0)
[21:20:08.955] Build status: STARTED
[21:20:08.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:17:0) after 2m48s
[21:22:56.976] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:17:0)
[21:22:57.075] Build status: STARTED
[21:22:57.075] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:18:0) after 2m23s
[21:25:20.114] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:18:0)
[21:25:20.138] Build status: STARTED
[21:25:20.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8950781056446149584:19:0) after 3m29s
[21:25:57.864] Received PubSub notification, asking Buildbucket for the build status
[21:25:57.914] Build:
{
"id": "8785350994096273153",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-03-28T19:56:58.524061913Z",
"startTime": "2023-03-28T19:57:03.151507Z",
"endTime": "2023-03-28T21:25:57.365132926Z",
"updateTime": "2023-03-28T21:25:57.365132926Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "fa9f52ee7fd3e56f524e09ad37e6846885c43eec",
"ref": "refs/heads/main"
}
}
}
[21:25:57.914] Invocation finished in 1h29m1.01466132s with status FAILED