[07:14:34.545] New invocation is queued and will start shortly
[07:14:35.700] Starting the invocation (attempt 1)
[07:14:35.727] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/6c0416d55b7647c7449919c5504fe18ba2e3b866"
[07:14:35.727] Popped gitiles commit info from properties and tags
[07:14:35.727] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:14:35.727] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:14:35.727] Buildbucket request:
{
"requestId": "8901816061965044224",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8901816061965044224",
"job": "fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "74e81e835b369e6d257a95cb3ceaf73b3ff6648d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@74e81e835b369e6d257a95cb3ceaf73b3ff6648d",
"title": "74e81e835b369e6d257a95cb3ceaf73b3ff6648d",
"url": "https://fuchsia.googlesource.com/integration/+/74e81e835b369e6d257a95cb3ceaf73b3ff6648d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "96fce0f71b3eb0249a9aa6548fab54c21d00f2cd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@96fce0f71b3eb0249a9aa6548fab54c21d00f2cd",
"title": "96fce0f71b3eb0249a9aa6548fab54c21d00f2cd",
"url": "https://fuchsia.googlesource.com/integration/+/96fce0f71b3eb0249a9aa6548fab54c21d00f2cd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "23355b3e93f0a7e49ac6cb286e08984910bccd7f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@23355b3e93f0a7e49ac6cb286e08984910bccd7f",
"title": "23355b3e93f0a7e49ac6cb286e08984910bccd7f",
"url": "https://fuchsia.googlesource.com/integration/+/23355b3e93f0a7e49ac6cb286e08984910bccd7f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1900110c5fec7467c41e1010e35507cb924cf6e2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1900110c5fec7467c41e1010e35507cb924cf6e2",
"title": "1900110c5fec7467c41e1010e35507cb924cf6e2",
"url": "https://fuchsia.googlesource.com/integration/+/1900110c5fec7467c41e1010e35507cb924cf6e2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ebbaf5725b9629b09b969df5b18755ad1331d331"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ebbaf5725b9629b09b969df5b18755ad1331d331",
"title": "ebbaf5725b9629b09b969df5b18755ad1331d331",
"url": "https://fuchsia.googlesource.com/integration/+/ebbaf5725b9629b09b969df5b18755ad1331d331"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "25ce2ef5c5c725747b74ba9ada814a1250a39745"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@25ce2ef5c5c725747b74ba9ada814a1250a39745",
"title": "25ce2ef5c5c725747b74ba9ada814a1250a39745",
"url": "https://fuchsia.googlesource.com/integration/+/25ce2ef5c5c725747b74ba9ada814a1250a39745"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "98111e977029f57b844ddc5ace9a9af767e20a51"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@98111e977029f57b844ddc5ace9a9af767e20a51",
"title": "98111e977029f57b844ddc5ace9a9af767e20a51",
"url": "https://fuchsia.googlesource.com/integration/+/98111e977029f57b844ddc5ace9a9af767e20a51"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9372a2403b66f6d53330a781cf84c84305558a2b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9372a2403b66f6d53330a781cf84c84305558a2b",
"title": "9372a2403b66f6d53330a781cf84c84305558a2b",
"url": "https://fuchsia.googlesource.com/integration/+/9372a2403b66f6d53330a781cf84c84305558a2b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5c12ebd94e8d8a443841754350afeeef4783a9f7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5c12ebd94e8d8a443841754350afeeef4783a9f7",
"title": "5c12ebd94e8d8a443841754350afeeef4783a9f7",
"url": "https://fuchsia.googlesource.com/integration/+/5c12ebd94e8d8a443841754350afeeef4783a9f7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6c0416d55b7647c7449919c5504fe18ba2e3b866"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6c0416d55b7647c7449919c5504fe18ba2e3b866",
"title": "6c0416d55b7647c7449919c5504fe18ba2e3b866",
"url": "https://fuchsia.googlesource.com/integration/+/6c0416d55b7647c7449919c5504fe18ba2e3b866"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "6c0416d55b7647c7449919c5504fe18ba2e3b866",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901816061965044224"
},
{
"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"
}
}
[07:14:36.124] Scheduled build:
{
"id": "8736386000011919233",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-19T07:14:35.785625122Z",
"updateTime": "2024-09-19T07:14:35.785625122Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "6c0416d55b7647c7449919c5504fe18ba2e3b866",
"ref": "refs/heads/main"
}
}
}
[07:14:36.124] Task URL: https://cr-buildbucket.appspot.com/build/8736386000011919233
[07:14:36.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:2:0) after 9m44s
[07:14:37.051] Received PubSub notification, asking Buildbucket for the build status
[07:14:37.068] Build status: SCHEDULED
[07:14:42.145] Received PubSub notification, asking Buildbucket for the build status
[07:14:42.166] Build status: STARTED
[07:24:20.224] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:2:0)
[07:24:20.249] Build status: STARTED
[07:24:20.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:5:0) after 4m37s
[07:28:57.243] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:5:0)
[07:28:57.271] Build status: STARTED
[07:28:57.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:6:0) after 6m14s
[07:35:11.339] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:6:0)
[07:35:11.421] Build status: STARTED
[07:35:11.421] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:7:0) after 1m32s
[07:36:43.467] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:7:0)
[07:36:43.489] Build status: STARTED
[07:36:43.489] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:8:0) after 6m4s
[07:42:47.504] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:8:0)
[07:42:47.522] Build status: STARTED
[07:42:47.522] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:9:0) after 3m24s
[07:46:11.547] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:9:0)
[07:46:11.584] Build status: STARTED
[07:46:11.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:10:0) after 5m42s
[07:51:53.649] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:10:0)
[07:51:53.672] Build status: STARTED
[07:51:53.672] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:11:0) after 2m38s
[07:54:31.657] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:11:0)
[07:54:31.679] Build status: STARTED
[07:54:31.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:12:0) after 9m41s
[08:04:12.704] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:12:0)
[08:04:12.724] Build status: STARTED
[08:04:12.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:13:0) after 7m1s
[08:11:13.732] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:13:0)
[08:11:13.754] Build status: STARTED
[08:11:13.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:14:0) after 8m36s
[08:19:49.764] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:14:0)
[08:19:49.784] Build status: STARTED
[08:19:49.784] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:15:0) after 5m49s
[08:25:38.801] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:15:0)
[08:25:38.826] Build status: STARTED
[08:25:38.826] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:16:0) after 9m47s
[08:35:25.868] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:16:0)
[08:35:25.904] Build status: STARTED
[08:35:25.904] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:17:0) after 4m12s
[08:39:37.975] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:17:0)
[08:39:37.995] Build status: STARTED
[08:39:37.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:18:0) after 2m48s
[08:42:26.011] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:18:0)
[08:42:26.027] Build status: STARTED
[08:42:26.027] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:19:0) after 7m47s
[08:50:13.313] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:19:0)
[08:50:13.380] Build status: STARTED
[08:50:13.380] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:20:0) after 7m56s
[08:58:09.579] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:20:0)
[08:58:09.610] Build status: STARTED
[08:58:09.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:21:0) after 3m31s
[09:01:40.637] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:21:0)
[09:01:40.666] Build status: STARTED
[09:01:40.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:22:0) after 3m18s
[09:04:58.687] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:22:0)
[09:04:58.710] Build status: STARTED
[09:04:58.710] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:23:0) after 4m38s
[09:09:36.930] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:23:0)
[09:09:36.952] Build status: STARTED
[09:09:36.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:24:0) after 3m1s
[09:12:38.090] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:24:0)
[09:12:38.107] Build status: STARTED
[09:12:38.107] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:25:0) after 8m1s
[09:20:39.278] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:25:0)
[09:20:39.298] Build status: STARTED
[09:20:39.298] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:26:0) after 2m44s
[09:23:23.328] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:26:0)
[09:23:23.382] Build status: STARTED
[09:23:23.382] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:27:0) after 3m24s
[09:26:47.409] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:27:0)
[09:26:47.432] Build status: STARTED
[09:26:47.432] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:28:0) after 1m24s
[09:28:11.588] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:28:0)
[09:28:11.653] Build status: STARTED
[09:28:11.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:29:0) after 9m37s
[09:37:48.919] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:29:0)
[09:37:48.939] Build status: STARTED
[09:37:48.939] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:30:0) after 5m49s
[09:43:38.114] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:30:0)
[09:43:38.131] Build status: STARTED
[09:43:38.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:31:0) after 3m43s
[09:47:21.248] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:31:0)
[09:47:21.270] Build status: STARTED
[09:47:21.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8901816061965044224:32:0) after 8m44s
[09:48:32.209] Received PubSub notification, asking Buildbucket for the build status
[09:48:32.241] Build:
{
"id": "8736386000011919233",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-19T07:14:35.785625122Z",
"startTime": "2024-09-19T07:14:41.951796336Z",
"endTime": "2024-09-19T09:48:31.833553638Z",
"updateTime": "2024-09-19T09:48:31.833553638Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "6c0416d55b7647c7449919c5504fe18ba2e3b866",
"ref": "refs/heads/main"
}
}
}
[09:48:32.241] Invocation finished in 2h33m57.701445275s with status FAILED