[03:17:32.431] New invocation is queued and will start shortly
[03:17:33.539] Starting the invocation (attempt 1)
[03:17:33.567] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/fa46de901a646313bf646087acc76c3eda87d58d"
[03:17:33.567] Popped gitiles commit info from properties and tags
[03:17:33.567] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:17:33.567] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:17:33.567] Buildbucket request:
{
"requestId": "8901649781003500896",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8901649781003500896",
"job": "fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9714e3c258ef4276749433a6e3e15c4ca190262e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9714e3c258ef4276749433a6e3e15c4ca190262e",
"title": "9714e3c258ef4276749433a6e3e15c4ca190262e",
"url": "https://fuchsia.googlesource.com/integration/+/9714e3c258ef4276749433a6e3e15c4ca190262e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a3dfbfce1325d4bb87761545faa964ee4fd16544"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a3dfbfce1325d4bb87761545faa964ee4fd16544",
"title": "a3dfbfce1325d4bb87761545faa964ee4fd16544",
"url": "https://fuchsia.googlesource.com/integration/+/a3dfbfce1325d4bb87761545faa964ee4fd16544"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3638f9cb392ef7dc55f5a9895fbe42c8979ce3be"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3638f9cb392ef7dc55f5a9895fbe42c8979ce3be",
"title": "3638f9cb392ef7dc55f5a9895fbe42c8979ce3be",
"url": "https://fuchsia.googlesource.com/integration/+/3638f9cb392ef7dc55f5a9895fbe42c8979ce3be"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "520f2d832a9ce73b4de9c540ec1b0a91d6b15b23"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@520f2d832a9ce73b4de9c540ec1b0a91d6b15b23",
"title": "520f2d832a9ce73b4de9c540ec1b0a91d6b15b23",
"url": "https://fuchsia.googlesource.com/integration/+/520f2d832a9ce73b4de9c540ec1b0a91d6b15b23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0d3ca5f54aefbc47ab3250ca9b6384cb993af513"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0d3ca5f54aefbc47ab3250ca9b6384cb993af513",
"title": "0d3ca5f54aefbc47ab3250ca9b6384cb993af513",
"url": "https://fuchsia.googlesource.com/integration/+/0d3ca5f54aefbc47ab3250ca9b6384cb993af513"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "65a7bf7b59502f09b7ffb0b589819af519bdc77e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@65a7bf7b59502f09b7ffb0b589819af519bdc77e",
"title": "65a7bf7b59502f09b7ffb0b589819af519bdc77e",
"url": "https://fuchsia.googlesource.com/integration/+/65a7bf7b59502f09b7ffb0b589819af519bdc77e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e2f8892ad4b7d45b6f31d19b1fe9aef97458ae6d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e2f8892ad4b7d45b6f31d19b1fe9aef97458ae6d",
"title": "e2f8892ad4b7d45b6f31d19b1fe9aef97458ae6d",
"url": "https://fuchsia.googlesource.com/integration/+/e2f8892ad4b7d45b6f31d19b1fe9aef97458ae6d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fa46de901a646313bf646087acc76c3eda87d58d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fa46de901a646313bf646087acc76c3eda87d58d",
"title": "fa46de901a646313bf646087acc76c3eda87d58d",
"url": "https://fuchsia.googlesource.com/integration/+/fa46de901a646313bf646087acc76c3eda87d58d"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "fa46de901a646313bf646087acc76c3eda87d58d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901649781003500896"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:17:34.036] Scheduled build:
{
"id": "8736219719096268529",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-21T03:17:33.624008641Z",
"updateTime": "2024-09-21T03:17:33.624008641Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "fa46de901a646313bf646087acc76c3eda87d58d",
"ref": "refs/heads/main"
}
}
}
[03:17:34.036] Task URL: https://cr-buildbucket.appspot.com/build/8736219719096268529
[03:17:34.036] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:2:0) after 2m4s
[03:17:35.021] Received PubSub notification, asking Buildbucket for the build status
[03:17:35.036] Build status: SCHEDULED
[03:17:39.136] Received PubSub notification, asking Buildbucket for the build status
[03:17:39.162] Build status: STARTED
[03:19:38.116] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:2:0)
[03:19:38.232] Build status: STARTED
[03:19:38.232] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:5:0) after 3m27s
[03:23:05.589] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:5:0)
[03:23:05.613] Build status: STARTED
[03:23:05.613] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:6:0) after 2m1s
[03:25:06.761] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:6:0)
[03:25:06.785] Build status: STARTED
[03:25:06.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:7:0) after 9m24s
[03:34:31.267] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:7:0)
[03:34:31.285] Build status: STARTED
[03:34:31.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:8:0) after 8m1s
[03:42:32.440] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:8:0)
[03:42:32.456] Build status: STARTED
[03:42:32.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:9:0) after 4m42s
[03:47:14.478] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:9:0)
[03:47:14.519] Build status: STARTED
[03:47:14.519] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:10:0) after 3m13s
[03:50:27.796] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:10:0)
[03:50:27.820] Build status: STARTED
[03:50:27.820] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:11:0) after 2m48s
[03:53:16.031] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:11:0)
[03:53:16.051] Build status: STARTED
[03:53:16.051] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:12:0) after 3m7s
[03:56:23.258] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:12:0)
[03:56:23.280] Build status: STARTED
[03:56:23.280] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:13:0) after 9m44s
[04:06:07.299] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:13:0)
[04:06:07.344] Build status: STARTED
[04:06:07.344] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:14:0) after 3m52s
[04:09:59.527] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:14:0)
[04:09:59.548] Build status: STARTED
[04:09:59.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:15:0) after 2m5s
[04:12:04.825] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:15:0)
[04:12:04.841] Build status: STARTED
[04:12:04.841] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:16:0) after 9m31s
[04:21:35.860] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:16:0)
[04:21:35.948] Build status: STARTED
[04:21:35.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:17:0) after 3m18s
[04:24:53.961] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:17:0)
[04:24:53.982] Build status: STARTED
[04:24:53.982] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:18:0) after 2m49s
[04:27:43.008] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:18:0)
[04:27:43.026] Build status: STARTED
[04:27:43.026] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:19:0) after 5m19s
[04:33:02.042] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:19:0)
[04:33:02.081] Build status: STARTED
[04:33:02.081] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:20:0) after 4m2s
[04:37:04.100] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:20:0)
[04:37:04.116] Build status: STARTED
[04:37:04.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:21:0) after 8m28s
[04:45:32.304] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:21:0)
[04:45:32.323] Build status: STARTED
[04:45:32.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:22:0) after 9m48s
[04:55:20.377] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:22:0)
[04:55:20.446] Build status: STARTED
[04:55:20.446] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:23:0) after 4m42s
[05:00:02.565] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:23:0)
[05:00:02.581] Build status: STARTED
[05:00:02.581] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:24:0) after 8m6s
[05:08:08.600] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:24:0)
[05:08:08.619] Build status: STARTED
[05:08:08.619] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:25:0) after 5m24s
[05:13:32.634] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:25:0)
[05:13:32.654] Build status: STARTED
[05:13:32.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:26:0) after 7m39s
[05:21:11.961] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:26:0)
[05:21:11.981] Build status: STARTED
[05:21:11.981] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:27:0) after 1m5s
[05:22:17.009] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:27:0)
[05:22:17.029] Build status: STARTED
[05:22:17.029] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:28:0) after 1m57s
[05:24:14.224] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:28:0)
[05:24:14.242] Build status: STARTED
[05:24:14.242] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:29:0) after 4m35s
[05:28:49.269] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:29:0)
[05:28:49.291] Build status: STARTED
[05:28:49.291] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:30:0) after 9m45s
[05:38:34.504] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:30:0)
[05:38:34.524] Build status: STARTED
[05:38:34.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:31:0) after 5m39s
[05:44:13.627] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:31:0)
[05:44:13.645] Build status: STARTED
[05:44:13.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:32:0) after 7m29s
[05:51:42.770] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:32:0)
[05:51:42.789] Build status: STARTED
[05:51:42.789] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:33:0) after 7m14s
[05:58:56.807] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:33:0)
[05:58:56.824] Build status: STARTED
[05:58:56.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901649781003500896:34:0) after 9m42s
[05:59:41.524] Received PubSub notification, asking Buildbucket for the build status
[05:59:41.576] Build:
{
"id": "8736219719096268529",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-21T03:17:33.624008641Z",
"startTime": "2024-09-21T03:17:38.864384582Z",
"endTime": "2024-09-21T05:59:40.853437052Z",
"updateTime": "2024-09-21T05:59:40.853437052Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "fa46de901a646313bf646087acc76c3eda87d58d",
"ref": "refs/heads/main"
}
}
}
[05:59:41.576] Invocation finished in 2h42m9.155084586s with status FAILED