[01:26:36.742] New invocation is queued and will start shortly
[01:26:37.783] Starting the invocation (attempt 1)
[01:26:37.811] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/39c0d4767f68adef637e057e40ffd456d16700f0"
[01:26:37.811] Popped gitiles commit info from properties and tags
[01:26:37.811] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:26:37.812] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:26:37.812] Buildbucket request:
{
"requestId": "8941700619143672640",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8941700619143672640",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "893dfa6d2ede259acae4adcb12459db3dbb38186"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@893dfa6d2ede259acae4adcb12459db3dbb38186",
"title": "893dfa6d2ede259acae4adcb12459db3dbb38186",
"url": "https://fuchsia.googlesource.com/integration/+/893dfa6d2ede259acae4adcb12459db3dbb38186"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b96e5fa3b2a5a7529a9d219c6d6430fb0d20f429"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b96e5fa3b2a5a7529a9d219c6d6430fb0d20f429",
"title": "b96e5fa3b2a5a7529a9d219c6d6430fb0d20f429",
"url": "https://fuchsia.googlesource.com/integration/+/b96e5fa3b2a5a7529a9d219c6d6430fb0d20f429"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f155084d64584e4381da56adb14916a77337d33a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f155084d64584e4381da56adb14916a77337d33a",
"title": "f155084d64584e4381da56adb14916a77337d33a",
"url": "https://fuchsia.googlesource.com/integration/+/f155084d64584e4381da56adb14916a77337d33a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c92b21c7dda79990a6100365ed7169664a039689"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c92b21c7dda79990a6100365ed7169664a039689",
"title": "c92b21c7dda79990a6100365ed7169664a039689",
"url": "https://fuchsia.googlesource.com/integration/+/c92b21c7dda79990a6100365ed7169664a039689"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "59cac449492182211c72538ee3a5f1159cc55eed"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@59cac449492182211c72538ee3a5f1159cc55eed",
"title": "59cac449492182211c72538ee3a5f1159cc55eed",
"url": "https://fuchsia.googlesource.com/integration/+/59cac449492182211c72538ee3a5f1159cc55eed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0391305c5f5de82279027bc8243bc5849abbca7c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0391305c5f5de82279027bc8243bc5849abbca7c",
"title": "0391305c5f5de82279027bc8243bc5849abbca7c",
"url": "https://fuchsia.googlesource.com/integration/+/0391305c5f5de82279027bc8243bc5849abbca7c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3505d131e9fdeb6452373cb40abd1861c8703449"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3505d131e9fdeb6452373cb40abd1861c8703449",
"title": "3505d131e9fdeb6452373cb40abd1861c8703449",
"url": "https://fuchsia.googlesource.com/integration/+/3505d131e9fdeb6452373cb40abd1861c8703449"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a45fffde91a5e2af5be0faaa5da9de8b08f8ee5e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a45fffde91a5e2af5be0faaa5da9de8b08f8ee5e",
"title": "a45fffde91a5e2af5be0faaa5da9de8b08f8ee5e",
"url": "https://fuchsia.googlesource.com/integration/+/a45fffde91a5e2af5be0faaa5da9de8b08f8ee5e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "39c0d4767f68adef637e057e40ffd456d16700f0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@39c0d4767f68adef637e057e40ffd456d16700f0",
"title": "39c0d4767f68adef637e057e40ffd456d16700f0",
"url": "https://fuchsia.googlesource.com/integration/+/39c0d4767f68adef637e057e40ffd456d16700f0"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "39c0d4767f68adef637e057e40ffd456d16700f0",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8941700619143672640"
},
{
"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"
}
}
[01:26:38.087] Scheduled build:
{
"id": "8776270557315144689",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-07-07T01:26:37.864066833Z",
"updateTime": "2023-07-07T01:26:37.864066833Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "39c0d4767f68adef637e057e40ffd456d16700f0",
"ref": "refs/heads/main"
}
},
"canary": true
}
[01:26:38.087] Task URL: https://cr-buildbucket.appspot.com/build/8776270557315144689
[01:26:38.087] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:2:0) after 9m20s
[01:26:42.451] Received PubSub notification, asking Buildbucket for the build status
[01:26:42.473] Build status: STARTED
[01:35:58.103] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:2:0)
[01:35:58.133] Build status: STARTED
[01:35:58.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:4:0) after 7m23s
[01:43:21.279] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:4:0)
[01:43:21.301] Build status: STARTED
[01:43:21.301] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:5:0) after 8m25s
[01:51:46.345] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:5:0)
[01:51:46.382] Build status: STARTED
[01:51:46.382] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:6:0) after 1m19s
[01:53:05.395] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:6:0)
[01:53:05.456] Build status: STARTED
[01:53:05.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:7:0) after 3m20s
[01:56:25.520] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:7:0)
[01:56:25.562] Build status: STARTED
[01:56:25.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:8:0) after 8m37s
[02:05:02.609] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:8:0)
[02:05:02.690] Build status: STARTED
[02:05:02.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:9:0) after 3m39s
[02:08:41.812] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:9:0)
[02:08:41.869] Build status: STARTED
[02:08:41.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:10:0) after 5m57s
[02:14:39.002] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:10:0)
[02:14:39.029] Build status: STARTED
[02:14:39.029] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:11:0) after 3m42s
[02:18:21.302] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:11:0)
[02:18:21.319] Build status: STARTED
[02:18:21.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:12:0) after 1m51s
[02:20:12.666] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:12:0)
[02:20:12.722] Build status: STARTED
[02:20:12.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:13:0) after 3m51s
[02:24:03.707] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:13:0)
[02:24:03.731] Build status: STARTED
[02:24:03.731] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:14:0) after 9m42s
[02:33:45.761] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:14:0)
[02:33:45.776] Build status: STARTED
[02:33:45.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:15:0) after 3m24s
[02:37:10.019] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:15:0)
[02:37:10.037] Build status: STARTED
[02:37:10.037] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:16:0) after 1m12s
[02:38:22.158] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:16:0)
[02:38:22.177] Build status: STARTED
[02:38:22.177] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:17:0) after 6m36s
[02:44:58.289] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:17:0)
[02:44:58.306] Build status: STARTED
[02:44:58.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:18:0) after 1m6s
[02:46:04.321] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:18:0)
[02:46:04.360] Build status: STARTED
[02:46:04.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:19:0) after 9m56s
[02:56:00.400] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:19:0)
[02:56:00.428] Build status: STARTED
[02:56:00.428] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:20:0) after 2m3s
[02:58:03.447] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:20:0)
[02:58:03.462] Build status: STARTED
[02:58:03.462] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8941700619143672640:21:0) after 4m50s
[03:01:53.385] Received PubSub notification, asking Buildbucket for the build status
[03:01:53.401] Build:
{
"id": "8776270557315144689",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-07-07T01:26:37.864066833Z",
"startTime": "2023-07-07T01:26:41.102062Z",
"endTime": "2023-07-07T03:01:52.872286691Z",
"updateTime": "2023-07-07T03:01:52.872286691Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "39c0d4767f68adef637e057e40ffd456d16700f0",
"ref": "refs/heads/main"
}
},
"canary": true
}
[03:01:53.401] Invocation finished in 1h35m16.665094499s with status FAILED