[21:13:32.445] New invocation is queued and will start shortly
[21:13:33.710] Starting the invocation (attempt 1)
[21:13:33.736] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/40925fe5800133aeb12432cada8163f36b0a3e44"
[21:13:33.736] Popped gitiles commit info from properties and tags
[21:13:33.736] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:13:33.736] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:13:33.737] Buildbucket request:
{
"requestId": "8938636244182948688",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8938636244182948688",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8a81bb641adecdbafc5a07b13bff02cd58f5c1c2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8a81bb641adecdbafc5a07b13bff02cd58f5c1c2",
"title": "8a81bb641adecdbafc5a07b13bff02cd58f5c1c2",
"url": "https://fuchsia.googlesource.com/integration/+/8a81bb641adecdbafc5a07b13bff02cd58f5c1c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "087bada3d62e2e2b5b8f4b8e10bd9b88a724b064"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@087bada3d62e2e2b5b8f4b8e10bd9b88a724b064",
"title": "087bada3d62e2e2b5b8f4b8e10bd9b88a724b064",
"url": "https://fuchsia.googlesource.com/integration/+/087bada3d62e2e2b5b8f4b8e10bd9b88a724b064"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "46c78e43495629c60ecbacf81e81b894bb80cc0a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@46c78e43495629c60ecbacf81e81b894bb80cc0a",
"title": "46c78e43495629c60ecbacf81e81b894bb80cc0a",
"url": "https://fuchsia.googlesource.com/integration/+/46c78e43495629c60ecbacf81e81b894bb80cc0a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5c39fc8acf5d3ec6af141470ff8d946ca27dfd98"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5c39fc8acf5d3ec6af141470ff8d946ca27dfd98",
"title": "5c39fc8acf5d3ec6af141470ff8d946ca27dfd98",
"url": "https://fuchsia.googlesource.com/integration/+/5c39fc8acf5d3ec6af141470ff8d946ca27dfd98"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0b15a4ef1b8bf4ff08d4e2445697dc12eb9f6ce0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0b15a4ef1b8bf4ff08d4e2445697dc12eb9f6ce0",
"title": "0b15a4ef1b8bf4ff08d4e2445697dc12eb9f6ce0",
"url": "https://fuchsia.googlesource.com/integration/+/0b15a4ef1b8bf4ff08d4e2445697dc12eb9f6ce0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ad88a028dab120be85c8b318e441b054b8606b17"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ad88a028dab120be85c8b318e441b054b8606b17",
"title": "ad88a028dab120be85c8b318e441b054b8606b17",
"url": "https://fuchsia.googlesource.com/integration/+/ad88a028dab120be85c8b318e441b054b8606b17"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "09a6c1802e7bf3df94f88d5b6827aa590d10c7c7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@09a6c1802e7bf3df94f88d5b6827aa590d10c7c7",
"title": "09a6c1802e7bf3df94f88d5b6827aa590d10c7c7",
"url": "https://fuchsia.googlesource.com/integration/+/09a6c1802e7bf3df94f88d5b6827aa590d10c7c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2e885929acc08c0d9c314c337af855a3bb7b342e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2e885929acc08c0d9c314c337af855a3bb7b342e",
"title": "2e885929acc08c0d9c314c337af855a3bb7b342e",
"url": "https://fuchsia.googlesource.com/integration/+/2e885929acc08c0d9c314c337af855a3bb7b342e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c8e7414bcfb1e123f5b4aa145135617fda3a26fe"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c8e7414bcfb1e123f5b4aa145135617fda3a26fe",
"title": "c8e7414bcfb1e123f5b4aa145135617fda3a26fe",
"url": "https://fuchsia.googlesource.com/integration/+/c8e7414bcfb1e123f5b4aa145135617fda3a26fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "efe81bf0cc435369c1ce661c124c48147f7cd757"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@efe81bf0cc435369c1ce661c124c48147f7cd757",
"title": "efe81bf0cc435369c1ce661c124c48147f7cd757",
"url": "https://fuchsia.googlesource.com/integration/+/efe81bf0cc435369c1ce661c124c48147f7cd757"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7b8572e619e3cdd151c63884f8a5ab2dd18b2662"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7b8572e619e3cdd151c63884f8a5ab2dd18b2662",
"title": "7b8572e619e3cdd151c63884f8a5ab2dd18b2662",
"url": "https://fuchsia.googlesource.com/integration/+/7b8572e619e3cdd151c63884f8a5ab2dd18b2662"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5edb3e1401ef01c13e7f2dad947389e25402786d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5edb3e1401ef01c13e7f2dad947389e25402786d",
"title": "5edb3e1401ef01c13e7f2dad947389e25402786d",
"url": "https://fuchsia.googlesource.com/integration/+/5edb3e1401ef01c13e7f2dad947389e25402786d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "89f3117cb610ab26beb8494dc419a6fc5e3139ba"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@89f3117cb610ab26beb8494dc419a6fc5e3139ba",
"title": "89f3117cb610ab26beb8494dc419a6fc5e3139ba",
"url": "https://fuchsia.googlesource.com/integration/+/89f3117cb610ab26beb8494dc419a6fc5e3139ba"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b23916b6967f296d0285010a620aecd7a0367e9b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b23916b6967f296d0285010a620aecd7a0367e9b",
"title": "b23916b6967f296d0285010a620aecd7a0367e9b",
"url": "https://fuchsia.googlesource.com/integration/+/b23916b6967f296d0285010a620aecd7a0367e9b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "245c9be5d531bbb305cc230b9529e09bf80d57fe"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@245c9be5d531bbb305cc230b9529e09bf80d57fe",
"title": "245c9be5d531bbb305cc230b9529e09bf80d57fe",
"url": "https://fuchsia.googlesource.com/integration/+/245c9be5d531bbb305cc230b9529e09bf80d57fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c021225bf4ba37a9fbc115d05f36d8ca127e74c8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c021225bf4ba37a9fbc115d05f36d8ca127e74c8",
"title": "c021225bf4ba37a9fbc115d05f36d8ca127e74c8",
"url": "https://fuchsia.googlesource.com/integration/+/c021225bf4ba37a9fbc115d05f36d8ca127e74c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f48688ce3b14f2cd773ec705e3f30b8bec304f64"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f48688ce3b14f2cd773ec705e3f30b8bec304f64",
"title": "f48688ce3b14f2cd773ec705e3f30b8bec304f64",
"url": "https://fuchsia.googlesource.com/integration/+/f48688ce3b14f2cd773ec705e3f30b8bec304f64"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "40925fe5800133aeb12432cada8163f36b0a3e44"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@40925fe5800133aeb12432cada8163f36b0a3e44",
"title": "40925fe5800133aeb12432cada8163f36b0a3e44",
"url": "https://fuchsia.googlesource.com/integration/+/40925fe5800133aeb12432cada8163f36b0a3e44"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "40925fe5800133aeb12432cada8163f36b0a3e44",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8938636244182948688"
},
{
"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"
}
}
[21:13:34.335] Scheduled build:
{
"id": "8773206182106399601",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-09T21:13:33.796682416Z",
"updateTime": "2023-08-09T21:13:33.796682416Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "40925fe5800133aeb12432cada8163f36b0a3e44",
"ref": "refs/heads/main"
}
},
"canary": true
}
[21:13:34.335] Task URL: https://cr-buildbucket.appspot.com/build/8773206182106399601
[21:13:34.335] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:2:0) after 2m30s
[21:13:35.221] Received PubSub notification, asking Buildbucket for the build status
[21:13:35.242] Build status: SCHEDULED
[21:14:23.699] Received PubSub notification, asking Buildbucket for the build status
[21:14:23.719] Build status: STARTED
[21:16:04.461] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:2:0)
[21:16:04.490] Build status: STARTED
[21:16:04.490] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:5:0) after 6m11s
[21:22:15.559] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:5:0)
[21:22:15.690] Build status: STARTED
[21:22:15.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:6:0) after 7m5s
[21:29:20.714] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:6:0)
[21:29:20.738] Build status: STARTED
[21:29:20.738] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:7:0) after 6m23s
[21:35:44.006] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:7:0)
[21:35:44.096] Build status: STARTED
[21:35:44.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:8:0) after 9m34s
[21:45:18.226] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:8:0)
[21:45:18.254] Build status: STARTED
[21:45:18.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:9:0) after 1m3s
[21:46:21.286] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:9:0)
[21:46:21.313] Build status: STARTED
[21:46:21.313] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:10:0) after 2m57s
[21:49:18.431] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:10:0)
[21:49:18.449] Build status: STARTED
[21:49:18.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:11:0) after 3m36s
[21:52:54.466] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:11:0)
[21:52:54.495] Build status: STARTED
[21:52:54.495] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:12:0) after 7m17s
[22:00:11.839] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:12:0)
[22:00:11.859] Build status: STARTED
[22:00:11.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:13:0) after 5m7s
[22:05:18.880] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:13:0)
[22:05:18.899] Build status: STARTED
[22:05:18.899] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:14:0) after 4m23s
[22:09:41.920] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:14:0)
[22:09:41.940] Build status: STARTED
[22:09:41.940] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:15:0) after 5m34s
[22:15:15.956] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:15:0)
[22:15:15.980] Build status: STARTED
[22:15:15.980] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:16:0) after 1m9s
[22:16:25.204] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:16:0)
[22:16:25.224] Build status: STARTED
[22:16:25.224] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:17:0) after 1m33s
[22:17:58.241] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:17:0)
[22:17:58.259] Build status: STARTED
[22:17:58.259] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:18:0) after 1m2s
[22:19:00.389] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:18:0)
[22:19:00.407] Build status: STARTED
[22:19:00.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:19:0) after 2m51s
[22:21:51.913] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:19:0)
[22:21:51.953] Build status: STARTED
[22:21:51.953] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:20:0) after 9m0s
[22:30:52.637] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:20:0)
[22:30:52.654] Build status: STARTED
[22:30:52.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:21:0) after 5m48s
[22:36:40.671] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:21:0)
[22:36:40.708] Build status: STARTED
[22:36:40.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:22:0) after 1m14s
[22:37:54.858] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:22:0)
[22:37:54.941] Build status: STARTED
[22:37:54.941] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8938636244182948688:23:0) after 8m31s
[22:43:48.199] Received PubSub notification, asking Buildbucket for the build status
[22:43:48.254] Build:
{
"id": "8773206182106399601",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-09T21:13:33.796682416Z",
"startTime": "2023-08-09T21:14:23.185387Z",
"endTime": "2023-08-09T22:43:47.810571815Z",
"updateTime": "2023-08-09T22:43:47.810571815Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "40925fe5800133aeb12432cada8163f36b0a3e44",
"ref": "refs/heads/main"
}
},
"canary": true
}
[22:43:48.254] Invocation finished in 1h30m15.82262203s with status FAILED