[03:42:26.681] New invocation is queued and will start shortly
[03:42:27.788] Starting the invocation (attempt 1)
[03:42:27.817] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/0807b419d58bf47b9852866366c753ff74d9d04b"
[03:42:27.817] Popped gitiles commit info from properties and tags
[03:42:27.817] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:42:27.817] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:42:27.818] Buildbucket request:
{
"requestId": "8906812241256289856",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8906812241256289856",
"job": "fuchsia/core.arm64-kasan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "71649934cb043c4fb61cd7fa87ef3f80baa6342e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@71649934cb043c4fb61cd7fa87ef3f80baa6342e",
"title": "71649934cb043c4fb61cd7fa87ef3f80baa6342e",
"url": "https://fuchsia.googlesource.com/integration/+/71649934cb043c4fb61cd7fa87ef3f80baa6342e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "35733a27e1525cc8ac0af8fc1fc12b26b6fcaccb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@35733a27e1525cc8ac0af8fc1fc12b26b6fcaccb",
"title": "35733a27e1525cc8ac0af8fc1fc12b26b6fcaccb",
"url": "https://fuchsia.googlesource.com/integration/+/35733a27e1525cc8ac0af8fc1fc12b26b6fcaccb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "22efa752e562b0d7c2db99f91a6c8695fb9fe4e2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@22efa752e562b0d7c2db99f91a6c8695fb9fe4e2",
"title": "22efa752e562b0d7c2db99f91a6c8695fb9fe4e2",
"url": "https://fuchsia.googlesource.com/integration/+/22efa752e562b0d7c2db99f91a6c8695fb9fe4e2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d780ba861c5ebefa92a07ccb135eee03b29111d2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d780ba861c5ebefa92a07ccb135eee03b29111d2",
"title": "d780ba861c5ebefa92a07ccb135eee03b29111d2",
"url": "https://fuchsia.googlesource.com/integration/+/d780ba861c5ebefa92a07ccb135eee03b29111d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "98df093363a9378a0904bbe6c92cc503643d4d74"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@98df093363a9378a0904bbe6c92cc503643d4d74",
"title": "98df093363a9378a0904bbe6c92cc503643d4d74",
"url": "https://fuchsia.googlesource.com/integration/+/98df093363a9378a0904bbe6c92cc503643d4d74"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6c8d0671458e84925ca57f037d79a4c1dcba0170"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6c8d0671458e84925ca57f037d79a4c1dcba0170",
"title": "6c8d0671458e84925ca57f037d79a4c1dcba0170",
"url": "https://fuchsia.googlesource.com/integration/+/6c8d0671458e84925ca57f037d79a4c1dcba0170"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f38af995c5bbbdf0de1b2bcd747425e046139e9b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f38af995c5bbbdf0de1b2bcd747425e046139e9b",
"title": "f38af995c5bbbdf0de1b2bcd747425e046139e9b",
"url": "https://fuchsia.googlesource.com/integration/+/f38af995c5bbbdf0de1b2bcd747425e046139e9b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "85a04db5a0fb6923b8c658005d8c46c1699e1d19"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@85a04db5a0fb6923b8c658005d8c46c1699e1d19",
"title": "85a04db5a0fb6923b8c658005d8c46c1699e1d19",
"url": "https://fuchsia.googlesource.com/integration/+/85a04db5a0fb6923b8c658005d8c46c1699e1d19"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f6f3f7ca66b3fb59cc0907c6221490f5020ebf39"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f6f3f7ca66b3fb59cc0907c6221490f5020ebf39",
"title": "f6f3f7ca66b3fb59cc0907c6221490f5020ebf39",
"url": "https://fuchsia.googlesource.com/integration/+/f6f3f7ca66b3fb59cc0907c6221490f5020ebf39"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b1297d98eac30f25db7e584ea910b090a19c7fe7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b1297d98eac30f25db7e584ea910b090a19c7fe7",
"title": "b1297d98eac30f25db7e584ea910b090a19c7fe7",
"url": "https://fuchsia.googlesource.com/integration/+/b1297d98eac30f25db7e584ea910b090a19c7fe7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8370213d5044fc67593c2e11fa8685a8a7df9037"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8370213d5044fc67593c2e11fa8685a8a7df9037",
"title": "8370213d5044fc67593c2e11fa8685a8a7df9037",
"url": "https://fuchsia.googlesource.com/integration/+/8370213d5044fc67593c2e11fa8685a8a7df9037"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "eb3e4205fb15e70d07e1aa51d23a97f28da41eec"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@eb3e4205fb15e70d07e1aa51d23a97f28da41eec",
"title": "eb3e4205fb15e70d07e1aa51d23a97f28da41eec",
"url": "https://fuchsia.googlesource.com/integration/+/eb3e4205fb15e70d07e1aa51d23a97f28da41eec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dff2796bce5379561937a87bc38acb3aa5361bd1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dff2796bce5379561937a87bc38acb3aa5361bd1",
"title": "dff2796bce5379561937a87bc38acb3aa5361bd1",
"url": "https://fuchsia.googlesource.com/integration/+/dff2796bce5379561937a87bc38acb3aa5361bd1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9b38ca42d52bc3ce7ac19e623b7c65d6aa356279"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9b38ca42d52bc3ce7ac19e623b7c65d6aa356279",
"title": "9b38ca42d52bc3ce7ac19e623b7c65d6aa356279",
"url": "https://fuchsia.googlesource.com/integration/+/9b38ca42d52bc3ce7ac19e623b7c65d6aa356279"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2e6a5395a302294ea9ba1b50570f20791a58688a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2e6a5395a302294ea9ba1b50570f20791a58688a",
"title": "2e6a5395a302294ea9ba1b50570f20791a58688a",
"url": "https://fuchsia.googlesource.com/integration/+/2e6a5395a302294ea9ba1b50570f20791a58688a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ffe20ef2e58747f71f3d1c4982e220de3c10dfef"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ffe20ef2e58747f71f3d1c4982e220de3c10dfef",
"title": "ffe20ef2e58747f71f3d1c4982e220de3c10dfef",
"url": "https://fuchsia.googlesource.com/integration/+/ffe20ef2e58747f71f3d1c4982e220de3c10dfef"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8b7c6bdb9930d6f9876de847c24a0d90051d65e1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8b7c6bdb9930d6f9876de847c24a0d90051d65e1",
"title": "8b7c6bdb9930d6f9876de847c24a0d90051d65e1",
"url": "https://fuchsia.googlesource.com/integration/+/8b7c6bdb9930d6f9876de847c24a0d90051d65e1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ee7c4cb620902c7995a7cbb15d146f94078e48ed"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ee7c4cb620902c7995a7cbb15d146f94078e48ed",
"title": "ee7c4cb620902c7995a7cbb15d146f94078e48ed",
"url": "https://fuchsia.googlesource.com/integration/+/ee7c4cb620902c7995a7cbb15d146f94078e48ed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f5677be4d7ee21ee1e192204d5adc71f7ae23845"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f5677be4d7ee21ee1e192204d5adc71f7ae23845",
"title": "f5677be4d7ee21ee1e192204d5adc71f7ae23845",
"url": "https://fuchsia.googlesource.com/integration/+/f5677be4d7ee21ee1e192204d5adc71f7ae23845"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "514cabf8e3574281ef209411025ddf321b2b8536"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@514cabf8e3574281ef209411025ddf321b2b8536",
"title": "514cabf8e3574281ef209411025ddf321b2b8536",
"url": "https://fuchsia.googlesource.com/integration/+/514cabf8e3574281ef209411025ddf321b2b8536"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4d488d0193401d97cfbc2362dd2bdbd0883ab2a2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4d488d0193401d97cfbc2362dd2bdbd0883ab2a2",
"title": "4d488d0193401d97cfbc2362dd2bdbd0883ab2a2",
"url": "https://fuchsia.googlesource.com/integration/+/4d488d0193401d97cfbc2362dd2bdbd0883ab2a2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0807b419d58bf47b9852866366c753ff74d9d04b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0807b419d58bf47b9852866366c753ff74d9d04b",
"title": "0807b419d58bf47b9852866366c753ff74d9d04b",
"url": "https://fuchsia.googlesource.com/integration/+/0807b419d58bf47b9852866366c753ff74d9d04b"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "0807b419d58bf47b9852866366c753ff74d9d04b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8906812241256289856"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.arm64-kasan-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:42:28.438] Scheduled build:
{
"id": "8741382179327921089",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-26T03:42:27.891024338Z",
"updateTime": "2024-07-26T03:42:27.891024338Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "0807b419d58bf47b9852866366c753ff74d9d04b",
"ref": "refs/heads/main"
}
},
"canary": true
}
[03:42:28.438] Task URL: https://cr-buildbucket.appspot.com/build/8741382179327921089
[03:42:28.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:2:0) after 2m15s
[03:42:29.351] Received PubSub notification, asking Buildbucket for the build status
[03:42:29.386] Build status: SCHEDULED
[03:42:34.444] Received PubSub notification, asking Buildbucket for the build status
[03:42:34.490] Build status: STARTED
[03:44:43.466] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:2:0)
[03:44:43.502] Build status: STARTED
[03:44:43.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:5:0) after 1m59s
[03:46:42.533] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:5:0)
[03:46:42.554] Build status: STARTED
[03:46:42.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:6:0) after 5m58s
[03:52:40.726] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:6:0)
[03:52:40.863] Build status: STARTED
[03:52:40.863] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:7:0) after 7m55s
[04:00:36.069] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:7:0)
[04:00:36.101] Build status: STARTED
[04:00:36.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:8:0) after 6m2s
[04:06:38.126] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:8:0)
[04:06:38.154] Build status: STARTED
[04:06:38.154] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:9:0) after 8m18s
[04:14:56.189] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:9:0)
[04:14:56.237] Build status: STARTED
[04:14:56.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:10:0) after 3m57s
[04:18:53.259] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:10:0)
[04:18:53.277] Build status: STARTED
[04:18:53.277] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:11:0) after 7m2s
[04:25:55.579] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:11:0)
[04:25:55.612] Build status: STARTED
[04:25:55.612] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:12:0) after 6m46s
[04:32:42.061] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:12:0)
[04:32:42.078] Build status: STARTED
[04:32:42.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:13:0) after 5m6s
[04:37:48.060] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:13:0)
[04:37:48.087] Build status: STARTED
[04:37:48.087] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:14:0) after 7m59s
[04:45:47.162] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:14:0)
[04:45:47.181] Build status: STARTED
[04:45:47.181] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:15:0) after 8m23s
[04:54:10.199] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:15:0)
[04:54:10.227] Build status: STARTED
[04:54:10.227] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:16:0) after 1m19s
[04:55:29.562] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:16:0)
[04:55:29.635] Build status: STARTED
[04:55:29.635] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:17:0) after 6m22s
[05:01:51.655] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:17:0)
[05:01:51.687] Build status: STARTED
[05:01:51.687] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:18:0) after 5m29s
[05:07:20.707] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:18:0)
[05:07:20.766] Build status: STARTED
[05:07:20.766] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:19:0) after 1m5s
[05:08:25.786] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:19:0)
[05:08:25.815] Build status: STARTED
[05:08:25.815] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-kasan-e5a0ec7f:8906812241256289856:20:0) after 4m12s
[05:10:35.071] Received PubSub notification, asking Buildbucket for the build status
[05:10:35.096] Build:
{
"id": "8741382179327921089",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-26T03:42:27.891024338Z",
"startTime": "2024-07-26T03:42:34.150592902Z",
"endTime": "2024-07-26T05:10:30.306503673Z",
"updateTime": "2024-07-26T05:10:30.306503673Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "0807b419d58bf47b9852866366c753ff74d9d04b",
"ref": "refs/heads/main"
}
},
"canary": true
}
[05:10:35.096] Invocation finished in 1h28m8.427250248s with status FAILED