[04:24:39.432] New invocation is queued and will start shortly
[04:24:40.519] Starting the invocation (attempt 1)
[04:24:40.542] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/05870bbee5f532337b3dca79e52fcc0b47da58c3"
[04:24:40.542] Popped gitiles commit info from properties and tags
[04:24:40.542] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:24:40.543] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:24:40.543] Buildbucket request:
{
"requestId": "8904544661310665632",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-cxx_determinism-build_only"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8904544661310665632",
"job": "fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6db1973c49ffc9a4cb3d18836c0f7122275da45f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6db1973c49ffc9a4cb3d18836c0f7122275da45f",
"title": "6db1973c49ffc9a4cb3d18836c0f7122275da45f",
"url": "https://fuchsia.googlesource.com/integration/+/6db1973c49ffc9a4cb3d18836c0f7122275da45f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "41c5b9d2b81236751bb1c729bad64b021dc72ae9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@41c5b9d2b81236751bb1c729bad64b021dc72ae9",
"title": "41c5b9d2b81236751bb1c729bad64b021dc72ae9",
"url": "https://fuchsia.googlesource.com/integration/+/41c5b9d2b81236751bb1c729bad64b021dc72ae9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "49ef98100bd3c912d8086ddcbdcc9a2d99400aab"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@49ef98100bd3c912d8086ddcbdcc9a2d99400aab",
"title": "49ef98100bd3c912d8086ddcbdcc9a2d99400aab",
"url": "https://fuchsia.googlesource.com/integration/+/49ef98100bd3c912d8086ddcbdcc9a2d99400aab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4bb959046e5fbe17518862ed3ae25136bee9a1df"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4bb959046e5fbe17518862ed3ae25136bee9a1df",
"title": "4bb959046e5fbe17518862ed3ae25136bee9a1df",
"url": "https://fuchsia.googlesource.com/integration/+/4bb959046e5fbe17518862ed3ae25136bee9a1df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f839ce7beb674d368ed598c3a233b36961018c8d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f839ce7beb674d368ed598c3a233b36961018c8d",
"title": "f839ce7beb674d368ed598c3a233b36961018c8d",
"url": "https://fuchsia.googlesource.com/integration/+/f839ce7beb674d368ed598c3a233b36961018c8d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e9b9cbf8f2db844b762d21c45efaeee269ce74a5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e9b9cbf8f2db844b762d21c45efaeee269ce74a5",
"title": "e9b9cbf8f2db844b762d21c45efaeee269ce74a5",
"url": "https://fuchsia.googlesource.com/integration/+/e9b9cbf8f2db844b762d21c45efaeee269ce74a5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "05870bbee5f532337b3dca79e52fcc0b47da58c3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@05870bbee5f532337b3dca79e52fcc0b47da58c3",
"title": "05870bbee5f532337b3dca79e52fcc0b47da58c3",
"url": "https://fuchsia.googlesource.com/integration/+/05870bbee5f532337b3dca79e52fcc0b47da58c3"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "05870bbee5f532337b3dca79e52fcc0b47da58c3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8904544661310665632"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:24:40.962] Scheduled build:
{
"id": "8739114599428614241",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-cxx_determinism-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-20T04:24:40.602648227Z",
"updateTime": "2024-08-20T04:24:40.602648227Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "05870bbee5f532337b3dca79e52fcc0b47da58c3",
"ref": "refs/heads/main"
}
}
}
[04:24:40.962] Task URL: https://cr-buildbucket.appspot.com/build/8739114599428614241
[04:24:40.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:2:0) after 4m40s
[04:24:42.007] Received PubSub notification, asking Buildbucket for the build status
[04:24:42.098] Build status: SCHEDULED
[04:24:46.695] Received PubSub notification, asking Buildbucket for the build status
[04:24:46.722] Build status: STARTED
[04:29:20.988] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:2:0)
[04:29:21.025] Build status: STARTED
[04:29:21.025] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:5:0) after 5m43s
[04:35:04.290] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:5:0)
[04:35:04.324] Build status: STARTED
[04:35:04.324] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:6:0) after 5m28s
[04:40:32.422] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:6:0)
[04:40:32.447] Build status: STARTED
[04:40:32.447] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:7:0) after 6m27s
[04:46:59.471] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:7:0)
[04:46:59.546] Build status: STARTED
[04:46:59.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:8:0) after 5m26s
[04:52:25.559] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:8:0)
[04:52:25.575] Build status: STARTED
[04:52:25.575] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:9:0) after 1m23s
[04:53:48.589] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:9:0)
[04:53:48.607] Build status: STARTED
[04:53:48.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:10:0) after 5m58s
[04:59:46.630] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:10:0)
[04:59:46.775] Build status: STARTED
[04:59:46.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:11:0) after 1m39s
[05:01:25.799] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:11:0)
[05:01:25.826] Build status: STARTED
[05:01:25.826] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:12:0) after 2m11s
[05:03:36.893] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:12:0)
[05:03:36.911] Build status: STARTED
[05:03:36.911] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:13:0) after 2m10s
[05:05:46.934] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:13:0)
[05:05:46.960] Build status: STARTED
[05:05:46.960] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:14:0) after 1m16s
[05:07:03.029] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:14:0)
[05:07:03.052] Build status: STARTED
[05:07:03.052] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:15:0) after 1m4s
[05:08:07.073] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:15:0)
[05:08:07.091] Build status: STARTED
[05:08:07.091] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:16:0) after 9m32s
[05:17:39.117] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:16:0)
[05:17:39.134] Build status: STARTED
[05:17:39.134] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:17:0) after 6m57s
[05:24:36.230] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:17:0)
[05:24:36.258] Build status: STARTED
[05:24:36.258] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:18:0) after 2m32s
[05:27:08.360] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:18:0)
[05:27:08.422] Build status: STARTED
[05:27:08.422] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:19:0) after 8m28s
[05:35:36.468] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:19:0)
[05:35:36.486] Build status: STARTED
[05:35:36.486] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:20:0) after 7m40s
[05:43:16.458] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:20:0)
[05:43:16.505] Build status: STARTED
[05:43:16.505] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:21:0) after 1m11s
[05:44:27.573] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:21:0)
[05:44:27.612] Build status: STARTED
[05:44:27.612] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:22:0) after 7m44s
[05:52:11.717] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:22:0)
[05:52:11.736] Build status: STARTED
[05:52:11.736] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:23:0) after 7m54s
[06:00:05.802] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:23:0)
[06:00:05.828] Build status: STARTED
[06:00:05.828] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:24:0) after 6m33s
[06:06:38.847] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:24:0)
[06:06:38.896] Build status: STARTED
[06:06:38.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:25:0) after 1m15s
[06:07:53.945] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:25:0)
[06:07:53.963] Build status: STARTED
[06:07:53.963] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:26:0) after 3m28s
[06:11:22.118] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:26:0)
[06:11:22.174] Build status: STARTED
[06:11:22.174] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:27:0) after 5m54s
[06:17:16.487] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:27:0)
[06:17:16.545] Build status: STARTED
[06:17:16.545] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:28:0) after 8m42s
[06:25:58.570] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:28:0)
[06:25:58.591] Build status: STARTED
[06:25:58.591] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:29:0) after 4m48s
[06:30:46.571] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:29:0)
[06:30:46.591] Build status: STARTED
[06:30:46.591] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:30:0) after 9m33s
[06:40:19.669] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:30:0)
[06:40:19.687] Build status: STARTED
[06:40:19.687] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:31:0) after 8m48s
[06:49:07.684] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:31:0)
[06:49:07.705] Build status: STARTED
[06:49:07.705] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:32:0) after 6m17s
[06:55:25.110] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:32:0)
[06:55:25.132] Build status: STARTED
[06:55:25.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:33:0) after 4m30s
[06:59:55.153] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:33:0)
[06:59:55.172] Build status: STARTED
[06:59:55.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:34:0) after 3m27s
[07:03:22.362] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:34:0)
[07:03:22.378] Build status: STARTED
[07:03:22.378] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:35:0) after 8m7s
[07:11:29.444] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:35:0)
[07:11:29.461] Build status: STARTED
[07:11:29.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:36:0) after 3m28s
[07:14:57.695] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:36:0)
[07:14:57.715] Build status: STARTED
[07:14:57.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:37:0) after 8m30s
[07:23:27.720] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:37:0)
[07:23:27.740] Build status: STARTED
[07:23:27.740] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:38:0) after 8m25s
[07:31:52.761] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-cxx_determinism-build_only-e5a0ec7f:8904544661310665632:38:0)
[07:31:52.839] Build:
{
"id": "8739114599428614241",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-cxx_determinism-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-20T04:24:40.602648227Z",
"startTime": "2024-08-20T04:24:46.399553785Z",
"endTime": "2024-08-20T07:31:30.710050185Z",
"updateTime": "2024-08-20T07:31:30.710050185Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "05870bbee5f532337b3dca79e52fcc0b47da58c3",
"ref": "refs/heads/main"
}
}
}
[07:31:52.839] Invocation finished in 3h7m13.416046636s with status FAILED