[00:51:56.289] New invocation is queued and will start shortly
[00:51:57.403] Starting the invocation (attempt 1)
[00:51:57.429] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/b4080e21bd755ab3b3d2db14db289f59b7e8dcd1"
[00:51:57.429] Popped gitiles commit info from properties and tags
[00:51:57.429] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:51:57.430] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:51:57.430] Buildbucket request:
{
"requestId": "8935270416043391568",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8935270416043391568",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e0407e7bf6867b2b4eb8980cdf2b799e638a09ca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e0407e7bf6867b2b4eb8980cdf2b799e638a09ca",
"title": "e0407e7bf6867b2b4eb8980cdf2b799e638a09ca",
"url": "https://fuchsia.googlesource.com/integration/+/e0407e7bf6867b2b4eb8980cdf2b799e638a09ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1f2bf801b93ac7930de8cdc24807c01ef0af90b8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1f2bf801b93ac7930de8cdc24807c01ef0af90b8",
"title": "1f2bf801b93ac7930de8cdc24807c01ef0af90b8",
"url": "https://fuchsia.googlesource.com/integration/+/1f2bf801b93ac7930de8cdc24807c01ef0af90b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d7eff8df0aec99f32b2ac5c5dd547de6952a5d4c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d7eff8df0aec99f32b2ac5c5dd547de6952a5d4c",
"title": "d7eff8df0aec99f32b2ac5c5dd547de6952a5d4c",
"url": "https://fuchsia.googlesource.com/integration/+/d7eff8df0aec99f32b2ac5c5dd547de6952a5d4c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fd59a43b0f72ce5de95dbcda3520a8d6f6ba7019"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fd59a43b0f72ce5de95dbcda3520a8d6f6ba7019",
"title": "fd59a43b0f72ce5de95dbcda3520a8d6f6ba7019",
"url": "https://fuchsia.googlesource.com/integration/+/fd59a43b0f72ce5de95dbcda3520a8d6f6ba7019"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ce8f94ec7fd8d1d643390e5f68b55ae05df3e45f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ce8f94ec7fd8d1d643390e5f68b55ae05df3e45f",
"title": "ce8f94ec7fd8d1d643390e5f68b55ae05df3e45f",
"url": "https://fuchsia.googlesource.com/integration/+/ce8f94ec7fd8d1d643390e5f68b55ae05df3e45f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "78eef73253976d15ce6575cd09bca56406668c08"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@78eef73253976d15ce6575cd09bca56406668c08",
"title": "78eef73253976d15ce6575cd09bca56406668c08",
"url": "https://fuchsia.googlesource.com/integration/+/78eef73253976d15ce6575cd09bca56406668c08"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3a19690d9829551c46c4e7d71e42a7cb61374fcd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3a19690d9829551c46c4e7d71e42a7cb61374fcd",
"title": "3a19690d9829551c46c4e7d71e42a7cb61374fcd",
"url": "https://fuchsia.googlesource.com/integration/+/3a19690d9829551c46c4e7d71e42a7cb61374fcd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9b1be60ab7f425d1608c2ef77537c4dcf9505165"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9b1be60ab7f425d1608c2ef77537c4dcf9505165",
"title": "9b1be60ab7f425d1608c2ef77537c4dcf9505165",
"url": "https://fuchsia.googlesource.com/integration/+/9b1be60ab7f425d1608c2ef77537c4dcf9505165"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4663c9e8ac99fbb1b4d0594bebd4dabc261b4f01"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4663c9e8ac99fbb1b4d0594bebd4dabc261b4f01",
"title": "4663c9e8ac99fbb1b4d0594bebd4dabc261b4f01",
"url": "https://fuchsia.googlesource.com/integration/+/4663c9e8ac99fbb1b4d0594bebd4dabc261b4f01"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8b14207631bed39d02e7554188861a03a72ce486"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8b14207631bed39d02e7554188861a03a72ce486",
"title": "8b14207631bed39d02e7554188861a03a72ce486",
"url": "https://fuchsia.googlesource.com/integration/+/8b14207631bed39d02e7554188861a03a72ce486"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e31cc5aab14f8f63a97d235d3f0cb1cab87d4aa5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e31cc5aab14f8f63a97d235d3f0cb1cab87d4aa5",
"title": "e31cc5aab14f8f63a97d235d3f0cb1cab87d4aa5",
"url": "https://fuchsia.googlesource.com/integration/+/e31cc5aab14f8f63a97d235d3f0cb1cab87d4aa5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7d2e5482f60b54b770fbf28ee25afa3904546883"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7d2e5482f60b54b770fbf28ee25afa3904546883",
"title": "7d2e5482f60b54b770fbf28ee25afa3904546883",
"url": "https://fuchsia.googlesource.com/integration/+/7d2e5482f60b54b770fbf28ee25afa3904546883"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9273af43eb1c3167314677e480d0467df4494561"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9273af43eb1c3167314677e480d0467df4494561",
"title": "9273af43eb1c3167314677e480d0467df4494561",
"url": "https://fuchsia.googlesource.com/integration/+/9273af43eb1c3167314677e480d0467df4494561"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "211861dee4e4ff30a6bc69b0449d997d35d561c3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@211861dee4e4ff30a6bc69b0449d997d35d561c3",
"title": "211861dee4e4ff30a6bc69b0449d997d35d561c3",
"url": "https://fuchsia.googlesource.com/integration/+/211861dee4e4ff30a6bc69b0449d997d35d561c3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b4080e21bd755ab3b3d2db14db289f59b7e8dcd1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b4080e21bd755ab3b3d2db14db289f59b7e8dcd1",
"title": "b4080e21bd755ab3b3d2db14db289f59b7e8dcd1",
"url": "https://fuchsia.googlesource.com/integration/+/b4080e21bd755ab3b3d2db14db289f59b7e8dcd1"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b4080e21bd755ab3b3d2db14db289f59b7e8dcd1",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8935270416043391568"
},
{
"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"
}
}
[00:51:57.860] Scheduled build:
{
"id": "8769840354137837265",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-16T00:51:57.483932037Z",
"updateTime": "2023-09-16T00:51:57.483932037Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b4080e21bd755ab3b3d2db14db289f59b7e8dcd1",
"ref": "refs/heads/main"
}
}
}
[00:51:57.860] Task URL: https://cr-buildbucket.appspot.com/build/8769840354137837265
[00:51:57.860] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:2:0) after 3m28s
[00:51:58.882] Received PubSub notification, asking Buildbucket for the build status
[00:51:58.922] Build status: SCHEDULED
[00:52:02.227] Received PubSub notification, asking Buildbucket for the build status
[00:52:02.243] Build status: STARTED
[00:55:25.933] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:2:0)
[00:55:25.957] Build status: STARTED
[00:55:25.957] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:5:0) after 4m20s
[00:59:46.193] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:5:0)
[00:59:46.214] Build status: STARTED
[00:59:46.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:6:0) after 6m41s
[01:06:27.282] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:6:0)
[01:06:27.313] Build status: STARTED
[01:06:27.313] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:7:0) after 7m29s
[01:13:56.688] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:7:0)
[01:13:56.712] Build status: STARTED
[01:13:56.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:8:0) after 2m48s
[01:16:44.982] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:8:0)
[01:16:45.142] Build status: STARTED
[01:16:45.142] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:9:0) after 6m39s
[01:23:24.170] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:9:0)
[01:23:24.188] Build status: STARTED
[01:23:24.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:10:0) after 7m12s
[01:30:36.230] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:10:0)
[01:30:36.249] Build status: STARTED
[01:30:36.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:11:0) after 3m13s
[01:33:49.401] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:11:0)
[01:33:49.439] Build status: STARTED
[01:33:49.439] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:12:0) after 7m38s
[01:41:27.773] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:12:0)
[01:41:27.797] Build status: STARTED
[01:41:27.797] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:13:0) after 4m7s
[01:45:34.830] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:13:0)
[01:45:34.847] Build status: STARTED
[01:45:34.847] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:14:0) after 2m34s
[01:48:09.158] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:14:0)
[01:48:09.195] Build status: STARTED
[01:48:09.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:15:0) after 4m58s
[01:53:07.319] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:15:0)
[01:53:07.388] Build status: STARTED
[01:53:07.388] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:16:0) after 2m30s
[01:55:37.654] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:16:0)
[01:55:37.704] Build status: STARTED
[01:55:37.704] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:17:0) after 2m0s
[01:57:37.733] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:17:0)
[01:57:37.752] Build status: STARTED
[01:57:37.752] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:18:0) after 5m15s
[02:02:52.765] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:18:0)
[02:02:52.880] Build status: STARTED
[02:02:52.880] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8935270416043391568:19:0) after 4m32s
[02:05:06.487] Received PubSub notification, asking Buildbucket for the build status
[02:05:06.508] Build:
{
"id": "8769840354137837265",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-16T00:51:57.483932037Z",
"startTime": "2023-09-16T00:52:00.837760Z",
"endTime": "2023-09-16T02:05:06.145659118Z",
"updateTime": "2023-09-16T02:05:06.145659118Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b4080e21bd755ab3b3d2db14db289f59b7e8dcd1",
"ref": "refs/heads/main"
}
}
}
[02:05:06.508] Invocation finished in 1h13m10.226235673s with status FAILED