[02:05:08.273] New invocation is queued and will start shortly
[02:05:09.375] Starting the invocation (attempt 1)
[02:05:09.410] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/3882b7f5fd76da6381b2de7f7b1ae1018a31b5fa"
[02:05:09.410] Popped gitiles commit info from properties and tags
[02:05:09.410] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:05:09.410] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:05:09.411] Buildbucket request:
{
"requestId": "8887158821555366160",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8887158821555366160",
"job": "fuchsia/core.arm64-asan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fa81f66658a5111dab10f3529f6e3495f8d049f7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fa81f66658a5111dab10f3529f6e3495f8d049f7",
"title": "fa81f66658a5111dab10f3529f6e3495f8d049f7",
"url": "https://fuchsia.googlesource.com/integration/+/fa81f66658a5111dab10f3529f6e3495f8d049f7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0b12847efc70982d6ccf3d96c52a5602b6bd5710"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0b12847efc70982d6ccf3d96c52a5602b6bd5710",
"title": "0b12847efc70982d6ccf3d96c52a5602b6bd5710",
"url": "https://fuchsia.googlesource.com/integration/+/0b12847efc70982d6ccf3d96c52a5602b6bd5710"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bb78f6af4189d9a89b9f3998150affea3acb7d6a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bb78f6af4189d9a89b9f3998150affea3acb7d6a",
"title": "bb78f6af4189d9a89b9f3998150affea3acb7d6a",
"url": "https://fuchsia.googlesource.com/integration/+/bb78f6af4189d9a89b9f3998150affea3acb7d6a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ad4257b27418bffdbededc63159914dba87650f8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ad4257b27418bffdbededc63159914dba87650f8",
"title": "ad4257b27418bffdbededc63159914dba87650f8",
"url": "https://fuchsia.googlesource.com/integration/+/ad4257b27418bffdbededc63159914dba87650f8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9116f2692d2e40cf86cffc0b6833149d322653bc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9116f2692d2e40cf86cffc0b6833149d322653bc",
"title": "9116f2692d2e40cf86cffc0b6833149d322653bc",
"url": "https://fuchsia.googlesource.com/integration/+/9116f2692d2e40cf86cffc0b6833149d322653bc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9d6db0806a1ed5cd12a7bbc7f7fabdd24861287c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9d6db0806a1ed5cd12a7bbc7f7fabdd24861287c",
"title": "9d6db0806a1ed5cd12a7bbc7f7fabdd24861287c",
"url": "https://fuchsia.googlesource.com/integration/+/9d6db0806a1ed5cd12a7bbc7f7fabdd24861287c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3a646e710928b9cddcb9d4552280b9bba157e60d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3a646e710928b9cddcb9d4552280b9bba157e60d",
"title": "3a646e710928b9cddcb9d4552280b9bba157e60d",
"url": "https://fuchsia.googlesource.com/integration/+/3a646e710928b9cddcb9d4552280b9bba157e60d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0148658a258d6b4712d7b6c5f60bc11e50ef88c4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0148658a258d6b4712d7b6c5f60bc11e50ef88c4",
"title": "0148658a258d6b4712d7b6c5f60bc11e50ef88c4",
"url": "https://fuchsia.googlesource.com/integration/+/0148658a258d6b4712d7b6c5f60bc11e50ef88c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e5a4829c79d08d805567753b42865907c308a159"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e5a4829c79d08d805567753b42865907c308a159",
"title": "e5a4829c79d08d805567753b42865907c308a159",
"url": "https://fuchsia.googlesource.com/integration/+/e5a4829c79d08d805567753b42865907c308a159"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cce821eabd60feb6f74505f4ba71a354e4d62574"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cce821eabd60feb6f74505f4ba71a354e4d62574",
"title": "cce821eabd60feb6f74505f4ba71a354e4d62574",
"url": "https://fuchsia.googlesource.com/integration/+/cce821eabd60feb6f74505f4ba71a354e4d62574"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "99b51926d439ddf278471c2abb70a71577a61d41"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@99b51926d439ddf278471c2abb70a71577a61d41",
"title": "99b51926d439ddf278471c2abb70a71577a61d41",
"url": "https://fuchsia.googlesource.com/integration/+/99b51926d439ddf278471c2abb70a71577a61d41"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3e17a3eae0b559f3c690618ce560b1f1188ac78f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3e17a3eae0b559f3c690618ce560b1f1188ac78f",
"title": "3e17a3eae0b559f3c690618ce560b1f1188ac78f",
"url": "https://fuchsia.googlesource.com/integration/+/3e17a3eae0b559f3c690618ce560b1f1188ac78f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "191eabeb0496ee1d8e159568d5ab3d0cc5671e57"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@191eabeb0496ee1d8e159568d5ab3d0cc5671e57",
"title": "191eabeb0496ee1d8e159568d5ab3d0cc5671e57",
"url": "https://fuchsia.googlesource.com/integration/+/191eabeb0496ee1d8e159568d5ab3d0cc5671e57"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fb475f5bb10d4a12a8d2540131430def9a70cdb0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fb475f5bb10d4a12a8d2540131430def9a70cdb0",
"title": "fb475f5bb10d4a12a8d2540131430def9a70cdb0",
"url": "https://fuchsia.googlesource.com/integration/+/fb475f5bb10d4a12a8d2540131430def9a70cdb0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5815ee69a5d2fe365469b3b30db70882fed54fbc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5815ee69a5d2fe365469b3b30db70882fed54fbc",
"title": "5815ee69a5d2fe365469b3b30db70882fed54fbc",
"url": "https://fuchsia.googlesource.com/integration/+/5815ee69a5d2fe365469b3b30db70882fed54fbc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8e9d6f4ba19dfe63940732a8debd0c8fceb2e31d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8e9d6f4ba19dfe63940732a8debd0c8fceb2e31d",
"title": "8e9d6f4ba19dfe63940732a8debd0c8fceb2e31d",
"url": "https://fuchsia.googlesource.com/integration/+/8e9d6f4ba19dfe63940732a8debd0c8fceb2e31d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f5a8581d02efcc1dd30cfd8e2c85df9766326192"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f5a8581d02efcc1dd30cfd8e2c85df9766326192",
"title": "f5a8581d02efcc1dd30cfd8e2c85df9766326192",
"url": "https://fuchsia.googlesource.com/integration/+/f5a8581d02efcc1dd30cfd8e2c85df9766326192"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8b3943a54cc96c0005c9dceb0cde901508fccf0f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8b3943a54cc96c0005c9dceb0cde901508fccf0f",
"title": "8b3943a54cc96c0005c9dceb0cde901508fccf0f",
"url": "https://fuchsia.googlesource.com/integration/+/8b3943a54cc96c0005c9dceb0cde901508fccf0f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3882b7f5fd76da6381b2de7f7b1ae1018a31b5fa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3882b7f5fd76da6381b2de7f7b1ae1018a31b5fa",
"title": "3882b7f5fd76da6381b2de7f7b1ae1018a31b5fa",
"url": "https://fuchsia.googlesource.com/integration/+/3882b7f5fd76da6381b2de7f7b1ae1018a31b5fa"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "3882b7f5fd76da6381b2de7f7b1ae1018a31b5fa",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8887158821555366160"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.arm64-asan-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:05:09.761] Scheduled build:
{
"id": "8721728759656550593",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-28T02:05:09.461609844Z",
"updateTime": "2025-02-28T02:05:09.461609844Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "3882b7f5fd76da6381b2de7f7b1ae1018a31b5fa",
"ref": "refs/heads/main"
}
}
}
[02:05:09.761] Task URL: https://cr-buildbucket.appspot.com/build/8721728759656550593
[02:05:09.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:2:0) after 5m38s
[02:05:10.746] Received PubSub notification, asking Buildbucket for the build status
[02:05:10.770] Build status: SCHEDULED
[02:05:15.491] Received PubSub notification, asking Buildbucket for the build status
[02:05:15.512] Build status: STARTED
[02:10:47.934] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:2:0)
[02:10:47.979] Build status: STARTED
[02:10:47.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:5:0) after 1m12s
[02:11:59.995] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:5:0)
[02:12:00.095] Build status: STARTED
[02:12:00.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:6:0) after 3m3s
[02:15:03.129] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:6:0)
[02:15:03.147] Build status: STARTED
[02:15:03.147] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:7:0) after 1m7s
[02:16:10.168] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:7:0)
[02:16:10.203] Build status: STARTED
[02:16:10.203] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:8:0) after 9m42s
[02:25:52.271] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:8:0)
[02:25:52.328] Build status: STARTED
[02:25:52.328] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:9:0) after 2m9s
[02:28:01.396] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:9:0)
[02:28:01.428] Build status: STARTED
[02:28:01.428] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:10:0) after 3m35s
[02:31:36.449] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:10:0)
[02:31:36.496] Build status: STARTED
[02:31:36.497] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:11:0) after 8m47s
[02:40:23.690] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:11:0)
[02:40:23.708] Build status: STARTED
[02:40:23.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:12:0) after 6m0s
[02:46:23.734] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:12:0)
[02:46:23.756] Build status: STARTED
[02:46:23.756] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:13:0) after 4m30s
[02:50:53.776] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:13:0)
[02:50:53.803] Build status: STARTED
[02:50:53.803] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:14:0) after 8m54s
[02:59:47.861] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:14:0)
[02:59:47.883] Build status: STARTED
[02:59:47.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:15:0) after 1m33s
[03:01:20.967] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:15:0)
[03:01:20.990] Build status: STARTED
[03:01:20.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:16:0) after 3m2s
[03:04:23.005] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:16:0)
[03:04:23.027] Build status: STARTED
[03:04:23.027] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887158821555366160:17:0) after 3m5s
[03:05:36.194] Received PubSub notification, asking Buildbucket for the build status
[03:05:36.210] Build:
{
"id": "8721728759656550593",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-28T02:05:09.461609844Z",
"startTime": "2025-02-28T02:05:15.140143093Z",
"endTime": "2025-02-28T03:05:35.613776560Z",
"updateTime": "2025-02-28T03:05:35.613776560Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "3882b7f5fd76da6381b2de7f7b1ae1018a31b5fa",
"ref": "refs/heads/main"
}
}
}
[03:05:36.210] Invocation finished in 1h0m27.943391849s with status SUCCEEDED