[02:20:16.604] New invocation is queued and will start shortly
[02:20:17.683] Starting the invocation (attempt 1)
[02:20:17.714] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/5a92306d8f3a3935e8bb3b623e923149e1182e4a"
[02:20:17.714] Popped gitiles commit info from properties and tags
[02:20:17.714] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:20:17.715] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:20:17.715] Buildbucket request:
{
"requestId": "8943509182211703008",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8943509182211703008",
"job": "fuchsia/core.x64-release-vulkan_cts-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "33f79e9954c372e9592e866d7089866a643c40a3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@33f79e9954c372e9592e866d7089866a643c40a3",
"title": "33f79e9954c372e9592e866d7089866a643c40a3",
"url": "https://fuchsia.googlesource.com/integration/+/33f79e9954c372e9592e866d7089866a643c40a3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "70a6267cc4605979a975ce8df6b3e8d24678ecd3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@70a6267cc4605979a975ce8df6b3e8d24678ecd3",
"title": "70a6267cc4605979a975ce8df6b3e8d24678ecd3",
"url": "https://fuchsia.googlesource.com/integration/+/70a6267cc4605979a975ce8df6b3e8d24678ecd3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "101d115691e541cbbe92554518da093105d7bda0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@101d115691e541cbbe92554518da093105d7bda0",
"title": "101d115691e541cbbe92554518da093105d7bda0",
"url": "https://fuchsia.googlesource.com/integration/+/101d115691e541cbbe92554518da093105d7bda0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "79192c9d1a38d31de1e3bbc2743a47f23b9b884f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@79192c9d1a38d31de1e3bbc2743a47f23b9b884f",
"title": "79192c9d1a38d31de1e3bbc2743a47f23b9b884f",
"url": "https://fuchsia.googlesource.com/integration/+/79192c9d1a38d31de1e3bbc2743a47f23b9b884f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b8a194687029c89e871a8b69b9cb6741fda7b1a0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b8a194687029c89e871a8b69b9cb6741fda7b1a0",
"title": "b8a194687029c89e871a8b69b9cb6741fda7b1a0",
"url": "https://fuchsia.googlesource.com/integration/+/b8a194687029c89e871a8b69b9cb6741fda7b1a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ee54b1bb16b835953844fa7dcf927df541f94064"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ee54b1bb16b835953844fa7dcf927df541f94064",
"title": "ee54b1bb16b835953844fa7dcf927df541f94064",
"url": "https://fuchsia.googlesource.com/integration/+/ee54b1bb16b835953844fa7dcf927df541f94064"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7f0c924b696d0c2051457f795c951e55b5eab5e5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7f0c924b696d0c2051457f795c951e55b5eab5e5",
"title": "7f0c924b696d0c2051457f795c951e55b5eab5e5",
"url": "https://fuchsia.googlesource.com/integration/+/7f0c924b696d0c2051457f795c951e55b5eab5e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "48380a8136bdde5e7ba1d8f4a17215e94e22edd2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@48380a8136bdde5e7ba1d8f4a17215e94e22edd2",
"title": "48380a8136bdde5e7ba1d8f4a17215e94e22edd2",
"url": "https://fuchsia.googlesource.com/integration/+/48380a8136bdde5e7ba1d8f4a17215e94e22edd2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5a92306d8f3a3935e8bb3b623e923149e1182e4a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5a92306d8f3a3935e8bb3b623e923149e1182e4a",
"title": "5a92306d8f3a3935e8bb3b623e923149e1182e4a",
"url": "https://fuchsia.googlesource.com/integration/+/5a92306d8f3a3935e8bb3b623e923149e1182e4a"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5a92306d8f3a3935e8bb3b623e923149e1182e4a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8943509182211703008"
},
{
"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"
}
}
[02:20:17.997] Scheduled build:
{
"id": "8778079120293269729",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-06-17T02:20:17.802895293Z",
"updateTime": "2023-06-17T02:20:17.802895293Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5a92306d8f3a3935e8bb3b623e923149e1182e4a",
"ref": "refs/heads/main"
}
}
}
[02:20:17.997] Task URL: https://cr-buildbucket.appspot.com/build/8778079120293269729
[02:20:17.997] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:2:0) after 5m23s
[02:20:18.867] Received PubSub notification, asking Buildbucket for the build status
[02:20:18.885] Build status: STARTED
[02:25:41.016] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:2:0)
[02:25:41.033] Build status: STARTED
[02:25:41.033] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:4:0) after 3m34s
[02:29:15.087] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:4:0)
[02:29:15.110] Build status: STARTED
[02:29:15.110] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:5:0) after 5m21s
[02:34:36.127] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:5:0)
[02:34:36.185] Build status: STARTED
[02:34:36.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:6:0) after 9m32s
[02:44:08.216] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:6:0)
[02:44:08.382] Build status: STARTED
[02:44:08.382] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:7:0) after 5m48s
[02:49:56.400] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:7:0)
[02:49:56.424] Build status: STARTED
[02:49:56.425] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:8:0) after 8m15s
[02:58:11.622] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:8:0)
[02:58:11.643] Build status: STARTED
[02:58:11.643] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:9:0) after 1m41s
[02:59:52.778] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:9:0)
[02:59:52.811] Build status: STARTED
[02:59:52.811] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:10:0) after 5m20s
[03:05:12.848] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:10:0)
[03:05:12.871] Build status: STARTED
[03:05:12.871] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:11:0) after 1m1s
[03:06:14.265] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:11:0)
[03:06:14.280] Build status: STARTED
[03:06:14.280] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:12:0) after 4m41s
[03:10:55.323] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:12:0)
[03:10:55.405] Build status: STARTED
[03:10:55.405] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:13:0) after 1m14s
[03:12:09.638] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:13:0)
[03:12:09.653] Build status: STARTED
[03:12:09.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:14:0) after 1m48s
[03:13:57.648] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:14:0)
[03:13:57.671] Build status: STARTED
[03:13:57.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:15:0) after 3m58s
[03:17:55.746] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:15:0)
[03:17:55.768] Build status: STARTED
[03:17:55.768] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:16:0) after 3m25s
[03:21:20.809] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:16:0)
[03:21:20.836] Build status: STARTED
[03:21:20.836] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:17:0) after 9m12s
[03:30:32.881] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:17:0)
[03:30:32.902] Build status: STARTED
[03:30:32.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:18:0) after 6m49s
[03:37:22.120] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:18:0)
[03:37:22.169] Build status: STARTED
[03:37:22.169] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:19:0) after 6m45s
[03:44:07.369] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:19:0)
[03:44:07.395] Build status: STARTED
[03:44:07.395] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:20:0) after 2m5s
[03:46:12.453] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:20:0)
[03:46:12.478] Build status: STARTED
[03:46:12.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:21:0) after 1m3s
[03:47:15.566] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:21:0)
[03:47:15.584] Build status: STARTED
[03:47:15.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:22:0) after 7m1s
[03:54:16.599] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:22:0)
[03:54:16.618] Build status: STARTED
[03:54:16.618] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-vulkan_cts-e5a0ec7f:8943509182211703008:23:0) after 8m37s
[03:56:42.657] Received PubSub notification, asking Buildbucket for the build status
[03:56:42.710] Build:
{
"id": "8778079120293269729",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-vulkan_cts"
},
"createdBy": "project:fuchsia",
"createTime": "2023-06-17T02:20:17.802895293Z",
"startTime": "2023-06-17T02:20:18.306843Z",
"endTime": "2023-06-17T03:56:42.323634112Z",
"updateTime": "2023-06-17T03:56:42.323634112Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5a92306d8f3a3935e8bb3b623e923149e1182e4a",
"ref": "refs/heads/main"
}
}
}
[03:56:42.710] Invocation finished in 1h36m26.12134412s with status FAILED