[23:40:40.972] New invocation is queued and will start shortly
[23:40:42.203] Starting the invocation (attempt 1)
[23:40:42.230] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/1cc2eb8d03feda087cd6a843f32385937cb48fcc"
[23:40:42.230] Popped gitiles commit info from properties and tags
[23:40:42.231] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:40:42.232] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:40:42.233] Buildbucket request:
{
"requestId": "8833353311835927392",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8833353311835927392",
"job": "fuchsia/global.ci-core.x64-debug-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "497e46f6b86c3f4a4733da082d33aa70b61767b5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@497e46f6b86c3f4a4733da082d33aa70b61767b5",
"title": "497e46f6b86c3f4a4733da082d33aa70b61767b5",
"url": "https://fuchsia.googlesource.com/integration/+/497e46f6b86c3f4a4733da082d33aa70b61767b5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c6cdcb7a5fc2f6c7b94af46765d84321eaf6ae3b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c6cdcb7a5fc2f6c7b94af46765d84321eaf6ae3b",
"title": "c6cdcb7a5fc2f6c7b94af46765d84321eaf6ae3b",
"url": "https://fuchsia.googlesource.com/integration/+/c6cdcb7a5fc2f6c7b94af46765d84321eaf6ae3b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3ed75a63133d61bb3c638b712da88cce8b9a6114"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3ed75a63133d61bb3c638b712da88cce8b9a6114",
"title": "3ed75a63133d61bb3c638b712da88cce8b9a6114",
"url": "https://fuchsia.googlesource.com/integration/+/3ed75a63133d61bb3c638b712da88cce8b9a6114"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ae22539d7da313aee5489022a5dd28d8709cb05c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ae22539d7da313aee5489022a5dd28d8709cb05c",
"title": "ae22539d7da313aee5489022a5dd28d8709cb05c",
"url": "https://fuchsia.googlesource.com/integration/+/ae22539d7da313aee5489022a5dd28d8709cb05c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "094e20246e3fdb9c90815a8783be6f38f74b5f2b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@094e20246e3fdb9c90815a8783be6f38f74b5f2b",
"title": "094e20246e3fdb9c90815a8783be6f38f74b5f2b",
"url": "https://fuchsia.googlesource.com/integration/+/094e20246e3fdb9c90815a8783be6f38f74b5f2b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ba37aec27fd9643b15b627c9d30d86adfed09225"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ba37aec27fd9643b15b627c9d30d86adfed09225",
"title": "ba37aec27fd9643b15b627c9d30d86adfed09225",
"url": "https://fuchsia.googlesource.com/integration/+/ba37aec27fd9643b15b627c9d30d86adfed09225"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "91b5c8e8575e402a4d5b4bef29a833db3da30d37"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@91b5c8e8575e402a4d5b4bef29a833db3da30d37",
"title": "91b5c8e8575e402a4d5b4bef29a833db3da30d37",
"url": "https://fuchsia.googlesource.com/integration/+/91b5c8e8575e402a4d5b4bef29a833db3da30d37"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4844201131bf1a20245f65f1e8913b6196bb39dd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4844201131bf1a20245f65f1e8913b6196bb39dd",
"title": "4844201131bf1a20245f65f1e8913b6196bb39dd",
"url": "https://fuchsia.googlesource.com/integration/+/4844201131bf1a20245f65f1e8913b6196bb39dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d3122f89a6e8e0d9d0768ffa0f38ffd56ffc1ca5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d3122f89a6e8e0d9d0768ffa0f38ffd56ffc1ca5",
"title": "d3122f89a6e8e0d9d0768ffa0f38ffd56ffc1ca5",
"url": "https://fuchsia.googlesource.com/integration/+/d3122f89a6e8e0d9d0768ffa0f38ffd56ffc1ca5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8c320e28d008b94d4ffbd4d323bf52ea751dfd25"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8c320e28d008b94d4ffbd4d323bf52ea751dfd25",
"title": "8c320e28d008b94d4ffbd4d323bf52ea751dfd25",
"url": "https://fuchsia.googlesource.com/integration/+/8c320e28d008b94d4ffbd4d323bf52ea751dfd25"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "25cf74bf451f6df134fe12ef97d6ac024c93458c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@25cf74bf451f6df134fe12ef97d6ac024c93458c",
"title": "25cf74bf451f6df134fe12ef97d6ac024c93458c",
"url": "https://fuchsia.googlesource.com/integration/+/25cf74bf451f6df134fe12ef97d6ac024c93458c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2697c9d9238c8b5c11f18d1f7430bd14517899d2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2697c9d9238c8b5c11f18d1f7430bd14517899d2",
"title": "2697c9d9238c8b5c11f18d1f7430bd14517899d2",
"url": "https://fuchsia.googlesource.com/integration/+/2697c9d9238c8b5c11f18d1f7430bd14517899d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9e224ea5949eda471651986b524cec38344ad630"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9e224ea5949eda471651986b524cec38344ad630",
"title": "9e224ea5949eda471651986b524cec38344ad630",
"url": "https://fuchsia.googlesource.com/integration/+/9e224ea5949eda471651986b524cec38344ad630"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1cc2eb8d03feda087cd6a843f32385937cb48fcc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1cc2eb8d03feda087cd6a843f32385937cb48fcc",
"title": "1cc2eb8d03feda087cd6a843f32385937cb48fcc",
"url": "https://fuchsia.googlesource.com/integration/+/1cc2eb8d03feda087cd6a843f32385937cb48fcc"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1cc2eb8d03feda087cd6a843f32385937cb48fcc",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8833353311835927392"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.x64-debug-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:40:42.633] Scheduled build:
{
"id": "8667923249795611121",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-14T23:40:42.297998534Z",
"updateTime": "2026-10-14T23:40:42.297998534Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1cc2eb8d03feda087cd6a843f32385937cb48fcc",
"ref": "refs/heads/main"
}
}
}
[23:40:42.633] Task URL: https://cr-buildbucket.appspot.com/build/8667923249795611121
[23:40:42.633] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:2:0) after 3m58s
[23:40:42.693] Received PubSub notification, asking Buildbucket for the build status
[23:40:42.722] Build status: SCHEDULED
[23:40:48.839] Received PubSub notification, asking Buildbucket for the build status
[23:40:48.856] Build status: STARTED
[23:44:40.650] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:2:0)
[23:44:40.674] Build status: STARTED
[23:44:40.674] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:5:0) after 1m9s
[23:45:49.691] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:5:0)
[23:45:49.735] Build status: STARTED
[23:45:49.735] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:6:0) after 5m39s
[23:51:28.816] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:6:0)
[23:51:28.836] Build status: STARTED
[23:51:28.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:7:0) after 6m15s
[23:57:43.856] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:7:0)
[23:57:43.885] Build status: STARTED
[23:57:43.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:8:0) after 6m27s
[00:04:11.293] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:8:0)
[00:04:11.381] Build status: STARTED
[00:04:11.382] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:9:0) after 2m22s
[00:06:33.468] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:9:0)
[00:06:33.490] Build status: STARTED
[00:06:33.490] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:10:0) after 5m51s
[00:12:24.595] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:10:0)
[00:12:24.617] Build status: STARTED
[00:12:24.617] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:11:0) after 5m13s
[00:17:37.673] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:11:0)
[00:17:37.693] Build status: STARTED
[00:17:37.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:12:0) after 8m31s
[00:26:08.716] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:12:0)
[00:26:08.843] Build status: STARTED
[00:26:08.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:13:0) after 2m44s
[00:28:52.866] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:13:0)
[00:28:52.898] Build status: STARTED
[00:28:52.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:14:0) after 8m1s
[00:36:53.970] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:14:0)
[00:36:53.994] Build status: STARTED
[00:36:53.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:15:0) after 5m52s
[00:42:46.019] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:15:0)
[00:42:46.145] Build status: STARTED
[00:42:46.145] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:16:0) after 5m32s
[00:48:18.168] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:16:0)
[00:48:18.191] Build status: STARTED
[00:48:18.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:17:0) after 3m29s
[00:51:47.173] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:17:0)
[00:51:47.192] Build status: STARTED
[00:51:47.192] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:18:0) after 1m38s
[00:53:25.346] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:18:0)
[00:53:25.365] Build status: STARTED
[00:53:25.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:19:0) after 1m25s
[00:54:50.389] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:19:0)
[00:54:50.438] Build status: STARTED
[00:54:50.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:20:0) after 4m42s
[00:59:32.519] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:20:0)
[00:59:32.545] Build status: STARTED
[00:59:32.545] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:21:0) after 4m31s
[01:04:03.617] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:21:0)
[01:04:03.639] Build status: STARTED
[01:04:03.639] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:22:0) after 6m3s
[01:10:06.865] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:22:0)
[01:10:07.045] Build status: STARTED
[01:10:07.045] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8833353311835927392:23:0) after 2m49s
[01:11:55.503] Received PubSub notification, asking Buildbucket for the build status
[01:11:55.524] Build:
{
"id": "8667923249795611121",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-14T23:40:42.297998534Z",
"startTime": "2026-10-14T23:40:48.110090080Z",
"endTime": "2026-10-15T01:11:54.933305878Z",
"updateTime": "2026-10-15T01:11:54.933305878Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1cc2eb8d03feda087cd6a843f32385937cb48fcc",
"ref": "refs/heads/main"
}
}
}
[01:11:55.524] Invocation finished in 1h31m14.557224892s with status SUCCEEDED