[18:26:34.798] New invocation is queued and will start shortly
[18:26:36.408] Starting the invocation (attempt 1)
[18:26:36.442] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/72409fba628c0e82eb3cdb1b273888184f132579"
[18:26:36.442] Popped gitiles commit info from properties and tags
[18:26:36.442] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:26:36.442] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:26:36.443] Buildbucket request:
{
"requestId": "8929134066976622048",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8929134066976622048",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "447a18e6f58c07db79130cd81fd4b31968fac5ec"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@447a18e6f58c07db79130cd81fd4b31968fac5ec",
"title": "447a18e6f58c07db79130cd81fd4b31968fac5ec",
"url": "https://fuchsia.googlesource.com/integration/+/447a18e6f58c07db79130cd81fd4b31968fac5ec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "494b195e5bb4bf4b4acc4fbc07b104893555e8f6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@494b195e5bb4bf4b4acc4fbc07b104893555e8f6",
"title": "494b195e5bb4bf4b4acc4fbc07b104893555e8f6",
"url": "https://fuchsia.googlesource.com/integration/+/494b195e5bb4bf4b4acc4fbc07b104893555e8f6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "344d1476c2feb19fdb1aedbf3d78f025726cc3c6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@344d1476c2feb19fdb1aedbf3d78f025726cc3c6",
"title": "344d1476c2feb19fdb1aedbf3d78f025726cc3c6",
"url": "https://fuchsia.googlesource.com/integration/+/344d1476c2feb19fdb1aedbf3d78f025726cc3c6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "91c1dcb1abe2f213f311c5470b178b86b84ee239"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@91c1dcb1abe2f213f311c5470b178b86b84ee239",
"title": "91c1dcb1abe2f213f311c5470b178b86b84ee239",
"url": "https://fuchsia.googlesource.com/integration/+/91c1dcb1abe2f213f311c5470b178b86b84ee239"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e5496b375d7e8ae3f622012c99938e88081ddb35"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e5496b375d7e8ae3f622012c99938e88081ddb35",
"title": "e5496b375d7e8ae3f622012c99938e88081ddb35",
"url": "https://fuchsia.googlesource.com/integration/+/e5496b375d7e8ae3f622012c99938e88081ddb35"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "758381872efad966a2be63e3c4a340c3bd39277d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@758381872efad966a2be63e3c4a340c3bd39277d",
"title": "758381872efad966a2be63e3c4a340c3bd39277d",
"url": "https://fuchsia.googlesource.com/integration/+/758381872efad966a2be63e3c4a340c3bd39277d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ff43583ee8b4b4e354cd8b1e4f827966e0388a4f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ff43583ee8b4b4e354cd8b1e4f827966e0388a4f",
"title": "ff43583ee8b4b4e354cd8b1e4f827966e0388a4f",
"url": "https://fuchsia.googlesource.com/integration/+/ff43583ee8b4b4e354cd8b1e4f827966e0388a4f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "84a5e4821d7d054530c79c7f92a64a85ccdd2d06"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@84a5e4821d7d054530c79c7f92a64a85ccdd2d06",
"title": "84a5e4821d7d054530c79c7f92a64a85ccdd2d06",
"url": "https://fuchsia.googlesource.com/integration/+/84a5e4821d7d054530c79c7f92a64a85ccdd2d06"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "72409fba628c0e82eb3cdb1b273888184f132579"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@72409fba628c0e82eb3cdb1b273888184f132579",
"title": "72409fba628c0e82eb3cdb1b273888184f132579",
"url": "https://fuchsia.googlesource.com/integration/+/72409fba628c0e82eb3cdb1b273888184f132579"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "72409fba628c0e82eb3cdb1b273888184f132579",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8929134066976622048"
},
{
"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"
}
}
[18:26:37.085] Scheduled build:
{
"id": "8763704004381857473",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-22T18:26:36.642361997Z",
"updateTime": "2023-11-22T18:26:36.642361997Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "72409fba628c0e82eb3cdb1b273888184f132579",
"ref": "refs/heads/main"
}
}
}
[18:26:37.085] Task URL: https://cr-buildbucket.appspot.com/build/8763704004381857473
[18:26:37.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:2:0) after 2m13s
[18:26:38.039] Received PubSub notification, asking Buildbucket for the build status
[18:26:38.066] Build status: SCHEDULED
[18:28:50.158] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:2:0)
[18:28:50.191] Build status: SCHEDULED
[18:28:50.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:4:0) after 6m10s
[18:29:15.518] Received PubSub notification, asking Buildbucket for the build status
[18:29:15.560] Build status: STARTED
[18:35:00.209] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:4:0)
[18:35:00.249] Build status: STARTED
[18:35:00.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:6:0) after 7m6s
[18:42:06.327] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:6:0)
[18:42:06.422] Build status: STARTED
[18:42:06.422] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:7:0) after 8m55s
[18:51:01.637] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:7:0)
[18:51:01.678] Build status: STARTED
[18:51:01.678] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:8:0) after 6m0s
[18:57:01.739] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:8:0)
[18:57:01.775] Build status: STARTED
[18:57:01.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:9:0) after 5m0s
[19:02:01.795] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:9:0)
[19:02:01.817] Build status: STARTED
[19:02:01.817] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:10:0) after 4m29s
[19:06:30.838] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:10:0)
[19:06:30.857] Build status: STARTED
[19:06:30.857] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:11:0) after 1m43s
[19:08:13.891] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:11:0)
[19:08:13.945] Build status: STARTED
[19:08:13.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:12:0) after 3m17s
[19:11:30.947] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:12:0)
[19:11:31.042] Build status: STARTED
[19:11:31.042] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:13:0) after 2m32s
[19:14:03.058] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:13:0)
[19:14:03.090] Build status: STARTED
[19:14:03.090] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:14:0) after 1m14s
[19:15:17.192] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:14:0)
[19:15:17.218] Build status: STARTED
[19:15:17.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:15:0) after 6m15s
[19:21:32.362] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:15:0)
[19:21:32.394] Build status: STARTED
[19:21:32.394] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:16:0) after 9m5s
[19:30:37.868] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:16:0)
[19:30:37.900] Build status: STARTED
[19:30:37.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:17:0) after 1m41s
[19:32:19.403] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:17:0)
[19:32:19.433] Build status: STARTED
[19:32:19.433] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:18:0) after 1m53s
[19:34:12.921] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:18:0)
[19:34:13.101] Build status: STARTED
[19:34:13.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:19:0) after 1m36s
[19:35:49.156] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:19:0)
[19:35:49.247] Build status: STARTED
[19:35:49.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:20:0) after 1m34s
[19:37:23.676] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:20:0)
[19:37:23.692] Build status: STARTED
[19:37:23.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:21:0) after 2m21s
[19:39:44.913] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:21:0)
[19:39:44.940] Build status: STARTED
[19:39:44.940] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:22:0) after 7m46s
[19:47:30.958] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:22:0)
[19:47:30.978] Build status: STARTED
[19:47:30.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:23:0) after 4m33s
[19:52:04.006] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:23:0)
[19:52:04.068] Build status: STARTED
[19:52:04.068] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:24:0) after 7m13s
[19:59:17.329] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:24:0)
[19:59:17.349] Build status: STARTED
[19:59:17.349] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8929134066976622048:25:0) after 7m9s
[20:04:25.726] Received PubSub notification, asking Buildbucket for the build status
[20:04:25.771] Build:
{
"id": "8763704004381857473",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-22T18:26:36.642361997Z",
"startTime": "2023-11-22T18:29:13.833988Z",
"endTime": "2023-11-22T20:04:24.649480Z",
"updateTime": "2023-11-22T20:04:24.649480Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "72409fba628c0e82eb3cdb1b273888184f132579",
"ref": "refs/heads/main"
}
}
}
[20:04:25.771] Invocation finished in 1h37m50.987312293s with status FAILED