[23:47:29.375] New invocation is queued and will start shortly
[23:47:30.897] Starting the invocation (attempt 1)
[23:47:30.931] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/09108a00ddf90f6068797855c196287cf23287ac"
[23:47:30.931] Popped gitiles commit info from properties and tags
[23:47:30.931] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:47:30.931] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:47:30.935] Buildbucket request:
{
"requestId": "8937448797992108736",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8937448797992108736",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1457c3da3bfbf4d69c45041a48c88b64ab3fd90e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1457c3da3bfbf4d69c45041a48c88b64ab3fd90e",
"title": "1457c3da3bfbf4d69c45041a48c88b64ab3fd90e",
"url": "https://fuchsia.googlesource.com/integration/+/1457c3da3bfbf4d69c45041a48c88b64ab3fd90e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a890f756d3e0b0a49c4256a404f91c7d8160bf12"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a890f756d3e0b0a49c4256a404f91c7d8160bf12",
"title": "a890f756d3e0b0a49c4256a404f91c7d8160bf12",
"url": "https://fuchsia.googlesource.com/integration/+/a890f756d3e0b0a49c4256a404f91c7d8160bf12"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "243cffe178ae8899e07f1ef7ad8eefee559417cc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@243cffe178ae8899e07f1ef7ad8eefee559417cc",
"title": "243cffe178ae8899e07f1ef7ad8eefee559417cc",
"url": "https://fuchsia.googlesource.com/integration/+/243cffe178ae8899e07f1ef7ad8eefee559417cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "952ef0a1f903939f5f24c3083629cb9dece9540b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@952ef0a1f903939f5f24c3083629cb9dece9540b",
"title": "952ef0a1f903939f5f24c3083629cb9dece9540b",
"url": "https://fuchsia.googlesource.com/integration/+/952ef0a1f903939f5f24c3083629cb9dece9540b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4c80cf5300408a9e50e278401df30113538533ca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4c80cf5300408a9e50e278401df30113538533ca",
"title": "4c80cf5300408a9e50e278401df30113538533ca",
"url": "https://fuchsia.googlesource.com/integration/+/4c80cf5300408a9e50e278401df30113538533ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "885e11992e5e54e24a92bad1d09e3633d02f17e7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@885e11992e5e54e24a92bad1d09e3633d02f17e7",
"title": "885e11992e5e54e24a92bad1d09e3633d02f17e7",
"url": "https://fuchsia.googlesource.com/integration/+/885e11992e5e54e24a92bad1d09e3633d02f17e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "98cc8846a9da10ddd8ebda2ac3979a556b38a449"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@98cc8846a9da10ddd8ebda2ac3979a556b38a449",
"title": "98cc8846a9da10ddd8ebda2ac3979a556b38a449",
"url": "https://fuchsia.googlesource.com/integration/+/98cc8846a9da10ddd8ebda2ac3979a556b38a449"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c71590fbf3761d94273fed78ce99c76856618a35"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c71590fbf3761d94273fed78ce99c76856618a35",
"title": "c71590fbf3761d94273fed78ce99c76856618a35",
"url": "https://fuchsia.googlesource.com/integration/+/c71590fbf3761d94273fed78ce99c76856618a35"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "235656fc5a4ebfa658ec0d91cab4650bc29b8f2e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@235656fc5a4ebfa658ec0d91cab4650bc29b8f2e",
"title": "235656fc5a4ebfa658ec0d91cab4650bc29b8f2e",
"url": "https://fuchsia.googlesource.com/integration/+/235656fc5a4ebfa658ec0d91cab4650bc29b8f2e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "48445361409da701260560619d43bafd1ef4d00a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@48445361409da701260560619d43bafd1ef4d00a",
"title": "48445361409da701260560619d43bafd1ef4d00a",
"url": "https://fuchsia.googlesource.com/integration/+/48445361409da701260560619d43bafd1ef4d00a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b002ac57d62da304c606ec9a9bcb5cbe21da8dc6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b002ac57d62da304c606ec9a9bcb5cbe21da8dc6",
"title": "b002ac57d62da304c606ec9a9bcb5cbe21da8dc6",
"url": "https://fuchsia.googlesource.com/integration/+/b002ac57d62da304c606ec9a9bcb5cbe21da8dc6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "74474397a4d5297c93802e21b059879ade82b21a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@74474397a4d5297c93802e21b059879ade82b21a",
"title": "74474397a4d5297c93802e21b059879ade82b21a",
"url": "https://fuchsia.googlesource.com/integration/+/74474397a4d5297c93802e21b059879ade82b21a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "09108a00ddf90f6068797855c196287cf23287ac"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@09108a00ddf90f6068797855c196287cf23287ac",
"title": "09108a00ddf90f6068797855c196287cf23287ac",
"url": "https://fuchsia.googlesource.com/integration/+/09108a00ddf90f6068797855c196287cf23287ac"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "09108a00ddf90f6068797855c196287cf23287ac",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8937448797992108736"
},
{
"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"
}
}
[23:47:31.410] Scheduled build:
{
"id": "8772018735626796545",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-22T23:47:31.006775147Z",
"updateTime": "2023-08-22T23:47:31.006775147Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "09108a00ddf90f6068797855c196287cf23287ac",
"ref": "refs/heads/main"
}
}
}
[23:47:31.410] Task URL: https://cr-buildbucket.appspot.com/build/8772018735626796545
[23:47:31.410] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:2:0) after 1m46s
[23:47:32.398] Received PubSub notification, asking Buildbucket for the build status
[23:47:32.435] Build status: SCHEDULED
[23:47:36.502] Received PubSub notification, asking Buildbucket for the build status
[23:47:36.534] Build status: STARTED
[23:49:17.509] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:2:0)
[23:49:17.538] Build status: STARTED
[23:49:17.538] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:5:0) after 1m36s
[23:50:53.543] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:5:0)
[23:50:53.562] Build status: STARTED
[23:50:53.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:6:0) after 6m57s
[23:57:50.774] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:6:0)
[23:57:50.825] Build status: STARTED
[23:57:50.826] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:7:0) after 1m11s
[23:59:02.032] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:7:0)
[23:59:02.053] Build status: STARTED
[23:59:02.053] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:8:0) after 9m11s
[00:08:13.555] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:8:0)
[00:08:13.581] Build status: STARTED
[00:08:13.581] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:9:0) after 5m0s
[00:13:13.842] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:9:0)
[00:13:13.860] Build status: STARTED
[00:13:13.860] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:10:0) after 6m12s
[00:19:26.094] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:10:0)
[00:19:26.134] Build status: STARTED
[00:19:26.134] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:11:0) after 5m33s
[00:24:59.159] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:11:0)
[00:24:59.185] Build status: STARTED
[00:24:59.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:12:0) after 6m0s
[00:30:59.200] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:12:0)
[00:30:59.233] Build status: STARTED
[00:30:59.233] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:13:0) after 3m52s
[00:34:51.513] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:13:0)
[00:34:51.527] Build status: STARTED
[00:34:51.527] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:14:0) after 2m34s
[00:37:25.716] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:14:0)
[00:37:25.788] Build status: STARTED
[00:37:25.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:15:0) after 3m56s
[00:41:21.912] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:15:0)
[00:41:21.931] Build status: STARTED
[00:41:21.931] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:16:0) after 5m2s
[00:46:24.408] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:16:0)
[00:46:24.427] Build status: STARTED
[00:46:24.427] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:17:0) after 2m32s
[00:48:56.441] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:17:0)
[00:48:56.464] Build status: STARTED
[00:48:56.464] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:18:0) after 6m2s
[00:54:58.510] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:18:0)
[00:54:58.529] Build status: STARTED
[00:54:58.529] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:19:0) after 7m13s
[01:02:11.537] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:19:0)
[01:02:11.558] Build status: STARTED
[01:02:11.558] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8937448797992108736:20:0) after 9m3s
[01:05:40.710] Received PubSub notification, asking Buildbucket for the build status
[01:05:40.746] Build:
{
"id": "8772018735626796545",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-22T23:47:31.006775147Z",
"startTime": "2023-08-22T23:47:36.285355030Z",
"endTime": "2023-08-23T01:05:39.811675157Z",
"updateTime": "2023-08-23T01:05:39.811675157Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "09108a00ddf90f6068797855c196287cf23287ac",
"ref": "refs/heads/main"
}
}
}
[01:05:40.746] Invocation finished in 1h18m11.378516966s with status FAILED