[04:04:44.952] New invocation is queued and will start shortly
[04:04:46.027] Starting the invocation (attempt 1)
[04:04:46.054] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/9edc119537c3b4f35ab7b489a1fce1efac2edfe4"
[04:04:46.054] Popped gitiles commit info from properties and tags
[04:04:46.054] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:04:46.054] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:04:46.055] Buildbucket request:
{
"requestId": "8880447120746364432",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-full_determinism"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8880447120746364432",
"job": "fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6f4c3dab031f89e35fc77aecfe0131212b283f4a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6f4c3dab031f89e35fc77aecfe0131212b283f4a",
"title": "6f4c3dab031f89e35fc77aecfe0131212b283f4a",
"url": "https://fuchsia.googlesource.com/integration/+/6f4c3dab031f89e35fc77aecfe0131212b283f4a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aebc510d5642dc2b35bb457846b05a00be3af22d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aebc510d5642dc2b35bb457846b05a00be3af22d",
"title": "aebc510d5642dc2b35bb457846b05a00be3af22d",
"url": "https://fuchsia.googlesource.com/integration/+/aebc510d5642dc2b35bb457846b05a00be3af22d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "647577e6995ae723f9cd151229a0a6d5066af739"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@647577e6995ae723f9cd151229a0a6d5066af739",
"title": "647577e6995ae723f9cd151229a0a6d5066af739",
"url": "https://fuchsia.googlesource.com/integration/+/647577e6995ae723f9cd151229a0a6d5066af739"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a4747f227d13daadaa55e0c2f3045715d51e9969"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a4747f227d13daadaa55e0c2f3045715d51e9969",
"title": "a4747f227d13daadaa55e0c2f3045715d51e9969",
"url": "https://fuchsia.googlesource.com/integration/+/a4747f227d13daadaa55e0c2f3045715d51e9969"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3bf23d3c08ceae0084e6af027b5b65d5c51281e4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3bf23d3c08ceae0084e6af027b5b65d5c51281e4",
"title": "3bf23d3c08ceae0084e6af027b5b65d5c51281e4",
"url": "https://fuchsia.googlesource.com/integration/+/3bf23d3c08ceae0084e6af027b5b65d5c51281e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3f3ba5112d7d2a8cd5c1b4c109aa3719b643eb0e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3f3ba5112d7d2a8cd5c1b4c109aa3719b643eb0e",
"title": "3f3ba5112d7d2a8cd5c1b4c109aa3719b643eb0e",
"url": "https://fuchsia.googlesource.com/integration/+/3f3ba5112d7d2a8cd5c1b4c109aa3719b643eb0e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dbb8f1b614d307f9b7e9c116f5f15a80f9a695db"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dbb8f1b614d307f9b7e9c116f5f15a80f9a695db",
"title": "dbb8f1b614d307f9b7e9c116f5f15a80f9a695db",
"url": "https://fuchsia.googlesource.com/integration/+/dbb8f1b614d307f9b7e9c116f5f15a80f9a695db"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "517c32419cf8ae3278c1fa081abc974f2fe76211"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@517c32419cf8ae3278c1fa081abc974f2fe76211",
"title": "517c32419cf8ae3278c1fa081abc974f2fe76211",
"url": "https://fuchsia.googlesource.com/integration/+/517c32419cf8ae3278c1fa081abc974f2fe76211"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7f845acd61adffcded6629c7ef2251073e82693b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7f845acd61adffcded6629c7ef2251073e82693b",
"title": "7f845acd61adffcded6629c7ef2251073e82693b",
"url": "https://fuchsia.googlesource.com/integration/+/7f845acd61adffcded6629c7ef2251073e82693b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9edc119537c3b4f35ab7b489a1fce1efac2edfe4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9edc119537c3b4f35ab7b489a1fce1efac2edfe4",
"title": "9edc119537c3b4f35ab7b489a1fce1efac2edfe4",
"url": "https://fuchsia.googlesource.com/integration/+/9edc119537c3b4f35ab7b489a1fce1efac2edfe4"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9edc119537c3b4f35ab7b489a1fce1efac2edfe4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8880447120746364432"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:04:46.737] Scheduled build:
{
"id": "8715017058755986545",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-full_determinism"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-13T04:04:46.230845456Z",
"updateTime": "2025-05-13T04:04:46.230845456Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9edc119537c3b4f35ab7b489a1fce1efac2edfe4",
"ref": "refs/heads/main"
}
}
}
[04:04:46.737] Task URL: https://cr-buildbucket.appspot.com/build/8715017058755986545
[04:04:46.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:2:0) after 5m11s
[04:04:47.692] Received PubSub notification, asking Buildbucket for the build status
[04:04:47.717] Build status: SCHEDULED
[04:04:50.036] Received PubSub notification, asking Buildbucket for the build status
[04:04:50.057] Build status: STARTED
[04:09:57.789] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:2:0)
[04:09:57.815] Build status: STARTED
[04:09:57.815] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:5:0) after 2m59s
[04:12:56.797] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:5:0)
[04:12:56.951] Build status: STARTED
[04:12:56.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:6:0) after 8m13s
[04:21:10.027] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:6:0)
[04:21:10.095] Build status: STARTED
[04:21:10.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:7:0) after 5m54s
[04:27:04.289] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:7:0)
[04:27:04.451] Build status: STARTED
[04:27:04.451] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:8:0) after 9m33s
[04:36:37.472] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:8:0)
[04:36:37.499] Build status: STARTED
[04:36:37.499] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:9:0) after 1m47s
[04:38:24.529] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:9:0)
[04:38:24.549] Build status: STARTED
[04:38:24.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:10:0) after 1m13s
[04:39:37.700] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:10:0)
[04:39:37.728] Build status: STARTED
[04:39:37.728] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:11:0) after 6m45s
[04:46:22.752] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:11:0)
[04:46:22.781] Build status: STARTED
[04:46:22.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:12:0) after 9m43s
[04:56:05.806] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:12:0)
[04:56:05.875] Build status: STARTED
[04:56:05.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:13:0) after 4m53s
[05:00:58.932] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:13:0)
[05:00:58.956] Build status: STARTED
[05:00:58.956] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:14:0) after 3m46s
[05:04:44.977] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:14:0)
[05:04:44.992] Build status: STARTED
[05:04:44.992] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:15:0) after 9m17s
[05:14:02.011] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:15:0)
[05:14:02.038] Build status: STARTED
[05:14:02.038] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:16:0) after 5m10s
[05:19:12.060] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:16:0)
[05:19:12.087] Build status: STARTED
[05:19:12.087] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:17:0) after 2m59s
[05:22:11.135] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:17:0)
[05:22:11.151] Build status: STARTED
[05:22:11.151] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:18:0) after 5m34s
[05:27:45.206] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:18:0)
[05:27:45.232] Build status: STARTED
[05:27:45.232] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:19:0) after 9m7s
[05:36:52.256] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:19:0)
[05:36:52.335] Build status: STARTED
[05:36:52.335] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:20:0) after 8m6s
[05:44:58.429] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:20:0)
[05:44:58.446] Build status: STARTED
[05:44:58.446] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:21:0) after 2m58s
[05:47:56.460] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:21:0)
[05:47:56.584] Build status: STARTED
[05:47:56.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:22:0) after 6m9s
[05:54:05.617] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:22:0)
[05:54:05.640] Build status: STARTED
[05:54:05.640] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:23:0) after 7m54s
[06:01:59.663] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:23:0)
[06:01:59.694] Build status: STARTED
[06:01:59.694] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:24:0) after 9m4s
[06:11:03.722] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:24:0)
[06:11:03.746] Build status: STARTED
[06:11:03.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:25:0) after 3m15s
[06:14:18.772] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:25:0)
[06:14:18.796] Build status: STARTED
[06:14:18.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:26:0) after 2m45s
[06:17:03.867] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:26:0)
[06:17:03.885] Build status: STARTED
[06:17:03.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:27:0) after 7m36s
[06:24:39.957] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:27:0)
[06:24:39.977] Build status: STARTED
[06:24:39.977] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:28:0) after 6m23s
[06:31:03.011] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:28:0)
[06:31:03.070] Build status: STARTED
[06:31:03.070] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:29:0) after 5m14s
[06:36:17.081] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:29:0)
[06:36:17.102] Build status: STARTED
[06:36:17.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:30:0) after 7m36s
[06:43:53.128] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:30:0)
[06:43:53.153] Build status: STARTED
[06:43:53.153] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:31:0) after 3m29s
[06:47:22.184] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:31:0)
[06:47:22.210] Build status: STARTED
[06:47:22.210] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:32:0) after 5m31s
[06:52:53.274] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:32:0)
[06:52:53.332] Build status: STARTED
[06:52:53.332] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:33:0) after 5m35s
[06:58:28.358] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:33:0)
[06:58:28.403] Build status: STARTED
[06:58:28.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:34:0) after 6m6s
[07:04:34.432] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:34:0)
[07:04:34.453] Build status: STARTED
[07:04:34.453] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:35:0) after 3m34s
[07:08:08.475] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:35:0)
[07:08:08.506] Build status: STARTED
[07:08:08.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:36:0) after 1m22s
[07:09:30.583] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:36:0)
[07:09:30.610] Build status: STARTED
[07:09:30.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-full_determinism-e5a0ec7f:8880447120746364432:37:0) after 6m24s
[07:09:38.995] Received PubSub notification, asking Buildbucket for the build status
[07:09:39.014] Build:
{
"id": "8715017058755986545",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-full_determinism"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-13T04:04:46.230845456Z",
"startTime": "2025-05-13T04:04:49.518402351Z",
"endTime": "2025-05-13T07:09:38.548313068Z",
"updateTime": "2025-05-13T07:09:38.548313068Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9edc119537c3b4f35ab7b489a1fce1efac2edfe4",
"ref": "refs/heads/main"
}
}
}
[07:09:39.014] Invocation finished in 3h4m54.066335914s with status FAILED