[16:46:55.643] New invocation is queued and will start shortly
[16:46:56.773] Starting the invocation (attempt 1)
[16:46:56.797] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/203adee6478bb2ee04e8c033ba66de7fc9d26073"
[16:46:56.797] Popped gitiles commit info from properties and tags
[16:46:56.797] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:46:56.797] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:46:56.797] Buildbucket request:
{
"requestId": "8840355309491968560",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8840355309491968560",
"job": "fuchsia/global.ci-core.arm64-kasan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "df9955db3dd269cee8b8595700775f7c8e1f52bb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@df9955db3dd269cee8b8595700775f7c8e1f52bb",
"title": "df9955db3dd269cee8b8595700775f7c8e1f52bb",
"url": "https://fuchsia.googlesource.com/integration/+/df9955db3dd269cee8b8595700775f7c8e1f52bb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "71183cf05f3a50de6712f2752aa2868174cfd0ff"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@71183cf05f3a50de6712f2752aa2868174cfd0ff",
"title": "71183cf05f3a50de6712f2752aa2868174cfd0ff",
"url": "https://fuchsia.googlesource.com/integration/+/71183cf05f3a50de6712f2752aa2868174cfd0ff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "66a36506f17001e78f0e7e3c07830e271b342395"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@66a36506f17001e78f0e7e3c07830e271b342395",
"title": "66a36506f17001e78f0e7e3c07830e271b342395",
"url": "https://fuchsia.googlesource.com/integration/+/66a36506f17001e78f0e7e3c07830e271b342395"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1ab543ca944aeed43f7a7682e9c1730950992d7b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1ab543ca944aeed43f7a7682e9c1730950992d7b",
"title": "1ab543ca944aeed43f7a7682e9c1730950992d7b",
"url": "https://fuchsia.googlesource.com/integration/+/1ab543ca944aeed43f7a7682e9c1730950992d7b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "203adee6478bb2ee04e8c033ba66de7fc9d26073"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@203adee6478bb2ee04e8c033ba66de7fc9d26073",
"title": "203adee6478bb2ee04e8c033ba66de7fc9d26073",
"url": "https://fuchsia.googlesource.com/integration/+/203adee6478bb2ee04e8c033ba66de7fc9d26073"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "203adee6478bb2ee04e8c033ba66de7fc9d26073",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8840355309491968560"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.arm64-kasan-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:46:57.536] Scheduled build:
{
"id": "8674925247498090785",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-29T16:46:56.924613504Z",
"updateTime": "2026-07-29T16:46:56.924613504Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "203adee6478bb2ee04e8c033ba66de7fc9d26073",
"ref": "refs/heads/main"
}
}
}
[16:46:57.536] Task URL: https://cr-buildbucket.appspot.com/build/8674925247498090785
[16:46:57.536] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:2:0) after 4m47s
[16:47:08.224] Received PubSub notification, asking Buildbucket for the build status
[16:47:08.323] Build status: STARTED
[16:47:11.821] Received PubSub notification, asking Buildbucket for the build status
[16:47:11.844] Build status: STARTED
[16:51:44.554] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:2:0)
[16:51:44.655] Build status: STARTED
[16:51:44.655] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:5:0) after 5m51s
[16:57:35.814] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:5:0)
[16:57:35.837] Build status: STARTED
[16:57:35.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:6:0) after 1m2s
[16:58:37.868] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:6:0)
[16:58:37.918] Build status: STARTED
[16:58:37.918] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:7:0) after 8m53s
[17:07:31.098] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:7:0)
[17:07:31.189] Build status: STARTED
[17:07:31.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:8:0) after 2m18s
[17:09:49.203] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:8:0)
[17:09:49.222] Build status: STARTED
[17:09:49.222] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:9:0) after 4m2s
[17:13:51.234] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:9:0)
[17:13:51.253] Build status: STARTED
[17:13:51.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:10:0) after 6m20s
[17:20:11.373] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:10:0)
[17:20:11.404] Build status: STARTED
[17:20:11.404] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:11:0) after 4m52s
[17:25:03.432] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:11:0)
[17:25:03.451] Build status: STARTED
[17:25:03.451] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:12:0) after 6m24s
[17:31:27.463] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:12:0)
[17:31:27.499] Build status: STARTED
[17:31:27.499] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:13:0) after 7m20s
[17:38:47.837] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:13:0)
[17:38:47.851] Build status: STARTED
[17:38:47.851] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:14:0) after 8m20s
[17:47:07.909] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:14:0)
[17:47:07.930] Build status: STARTED
[17:47:07.930] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:15:0) after 4m38s
[17:51:45.953] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:15:0)
[17:51:45.975] Build status: STARTED
[17:51:45.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:16:0) after 7m29s
[17:59:15.043] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:16:0)
[17:59:15.058] Build status: STARTED
[17:59:15.058] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:17:0) after 7m4s
[18:06:19.077] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:17:0)
[18:06:19.101] Build status: STARTED
[18:06:19.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:18:0) after 7m9s
[18:13:28.210] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:18:0)
[18:13:28.247] Build status: STARTED
[18:13:28.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:19:0) after 1m36s
[18:15:04.260] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:19:0)
[18:15:04.279] Build status: STARTED
[18:15:04.279] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:20:0) after 8m8s
[18:23:12.291] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:20:0)
[18:23:12.311] Build status: STARTED
[18:23:12.311] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840355309491968560:21:0) after 8m5s
[18:23:17.857] Received PubSub notification, asking Buildbucket for the build status
[18:23:18.064] Build:
{
"id": "8674925247498090785",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-29T16:46:56.924613504Z",
"startTime": "2026-07-29T16:47:02.220419116Z",
"endTime": "2026-07-29T18:23:17.472192690Z",
"updateTime": "2026-07-29T18:23:17.472192690Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "203adee6478bb2ee04e8c033ba66de7fc9d26073",
"ref": "refs/heads/main"
}
}
}
[18:23:18.064] Invocation finished in 1h36m22.424964635s with status SUCCEEDED