[22:05:39.102] New invocation is queued and will start shortly
[22:05:40.795] Starting the invocation (attempt 1)
[22:05:40.822] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/ae66547acd6aeb6b79ead2e47bdb1e05f1eb0650"
[22:05:40.822] Popped gitiles commit info from properties and tags
[22:05:40.822] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:05:40.822] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:05:40.823] Buildbucket request:
{
"requestId": "8935462071814915504",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8935462071814915504",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fc028d0bf861b6e0df4e83c25f9199f692d08a12"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fc028d0bf861b6e0df4e83c25f9199f692d08a12",
"title": "fc028d0bf861b6e0df4e83c25f9199f692d08a12",
"url": "https://fuchsia.googlesource.com/integration/+/fc028d0bf861b6e0df4e83c25f9199f692d08a12"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "adb3d4e27d1a74d2ffbdea2326a02ab68c3412a8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@adb3d4e27d1a74d2ffbdea2326a02ab68c3412a8",
"title": "adb3d4e27d1a74d2ffbdea2326a02ab68c3412a8",
"url": "https://fuchsia.googlesource.com/integration/+/adb3d4e27d1a74d2ffbdea2326a02ab68c3412a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e1ef1f65b09c9487bc1fb29cdbf04437bba61b00"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e1ef1f65b09c9487bc1fb29cdbf04437bba61b00",
"title": "e1ef1f65b09c9487bc1fb29cdbf04437bba61b00",
"url": "https://fuchsia.googlesource.com/integration/+/e1ef1f65b09c9487bc1fb29cdbf04437bba61b00"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a30890c0025484fea787fca677c784b0d76ff48d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a30890c0025484fea787fca677c784b0d76ff48d",
"title": "a30890c0025484fea787fca677c784b0d76ff48d",
"url": "https://fuchsia.googlesource.com/integration/+/a30890c0025484fea787fca677c784b0d76ff48d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "40cee5807902f3fbb6da5c3b92b6deb95d3d6971"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@40cee5807902f3fbb6da5c3b92b6deb95d3d6971",
"title": "40cee5807902f3fbb6da5c3b92b6deb95d3d6971",
"url": "https://fuchsia.googlesource.com/integration/+/40cee5807902f3fbb6da5c3b92b6deb95d3d6971"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6d886b04a8eb04a6f5c9036800d180fec87a1ee0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6d886b04a8eb04a6f5c9036800d180fec87a1ee0",
"title": "6d886b04a8eb04a6f5c9036800d180fec87a1ee0",
"url": "https://fuchsia.googlesource.com/integration/+/6d886b04a8eb04a6f5c9036800d180fec87a1ee0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aef2358b93c724d3230c5a55230be2be2e2fd5a9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aef2358b93c724d3230c5a55230be2be2e2fd5a9",
"title": "aef2358b93c724d3230c5a55230be2be2e2fd5a9",
"url": "https://fuchsia.googlesource.com/integration/+/aef2358b93c724d3230c5a55230be2be2e2fd5a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0778fdabf473a335e653e9b0150f67d5f75acfca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0778fdabf473a335e653e9b0150f67d5f75acfca",
"title": "0778fdabf473a335e653e9b0150f67d5f75acfca",
"url": "https://fuchsia.googlesource.com/integration/+/0778fdabf473a335e653e9b0150f67d5f75acfca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "66e50b643bda0030c3f2fb5ef26449d14b7df6d6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@66e50b643bda0030c3f2fb5ef26449d14b7df6d6",
"title": "66e50b643bda0030c3f2fb5ef26449d14b7df6d6",
"url": "https://fuchsia.googlesource.com/integration/+/66e50b643bda0030c3f2fb5ef26449d14b7df6d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ae66547acd6aeb6b79ead2e47bdb1e05f1eb0650"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ae66547acd6aeb6b79ead2e47bdb1e05f1eb0650",
"title": "ae66547acd6aeb6b79ead2e47bdb1e05f1eb0650",
"url": "https://fuchsia.googlesource.com/integration/+/ae66547acd6aeb6b79ead2e47bdb1e05f1eb0650"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ae66547acd6aeb6b79ead2e47bdb1e05f1eb0650",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8935462071814915504"
},
{
"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"
}
}
[22:05:41.390] Scheduled build:
{
"id": "8770032009297381905",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-13T22:05:40.880809784Z",
"updateTime": "2023-09-13T22:05:40.880809784Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ae66547acd6aeb6b79ead2e47bdb1e05f1eb0650",
"ref": "refs/heads/main"
}
}
}
[22:05:41.390] Task URL: https://cr-buildbucket.appspot.com/build/8770032009297381905
[22:05:41.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:2:0) after 2m14s
[22:05:42.239] Received PubSub notification, asking Buildbucket for the build status
[22:05:42.266] Build status: SCHEDULED
[22:06:47.751] Received PubSub notification, asking Buildbucket for the build status
[22:06:47.772] Build status: STARTED
[22:07:55.409] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:2:0)
[22:07:55.425] Build status: STARTED
[22:07:55.425] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:5:0) after 7m51s
[22:15:46.460] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:5:0)
[22:15:46.486] Build status: STARTED
[22:15:46.487] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:6:0) after 1m56s
[22:17:42.503] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:6:0)
[22:17:42.544] Build status: STARTED
[22:17:42.544] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:7:0) after 9m17s
[22:26:59.657] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:7:0)
[22:26:59.684] Build status: STARTED
[22:26:59.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:8:0) after 3m30s
[22:30:29.717] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:8:0)
[22:30:29.743] Build status: STARTED
[22:30:29.743] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:9:0) after 3m55s
[22:34:25.263] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:9:0)
[22:34:25.284] Build status: STARTED
[22:34:25.284] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:10:0) after 3m49s
[22:38:14.725] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:10:0)
[22:38:14.745] Build status: STARTED
[22:38:14.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:11:0) after 9m6s
[22:47:20.975] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:11:0)
[22:47:20.994] Build status: STARTED
[22:47:20.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:12:0) after 7m38s
[22:54:59.258] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:12:0)
[22:54:59.283] Build status: STARTED
[22:54:59.283] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:13:0) after 6m9s
[23:01:08.658] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:13:0)
[23:01:08.693] Build status: STARTED
[23:01:08.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:14:0) after 5m10s
[23:06:18.807] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:14:0)
[23:06:18.845] Build status: STARTED
[23:06:18.845] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:15:0) after 6m46s
[23:13:04.866] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:15:0)
[23:13:04.948] Build status: STARTED
[23:13:04.948] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935462071814915504:16:0) after 7m16s
[23:16:58.920] Received PubSub notification, asking Buildbucket for the build status
[23:16:59.083] Build:
{
"id": "8770032009297381905",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-13T22:05:40.880809784Z",
"startTime": "2023-09-13T22:06:47.184667Z",
"endTime": "2023-09-13T23:16:58.238568292Z",
"updateTime": "2023-09-13T23:16:58.238568292Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ae66547acd6aeb6b79ead2e47bdb1e05f1eb0650",
"ref": "refs/heads/main"
}
}
}
[23:16:59.083] Invocation finished in 1h11m19.987765982s with status FAILED