[16:10:06.179] New invocation is queued and will start shortly
[16:10:07.304] Starting the invocation (attempt 1)
[16:10:07.339] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/08898c2fb4c2c12d519c7b7989b538c074cbbcf5"
[16:10:07.339] Popped gitiles commit info from properties and tags
[16:10:07.339] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:10:07.339] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:10:07.340] Buildbucket request:
{
"requestId": "8834106435606294640",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8834106435606294640",
"job": "fuchsia/global.ci-core.x64-asan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0da9b9f0dfe966ec2b6b8c92c9eeebe380639db5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0da9b9f0dfe966ec2b6b8c92c9eeebe380639db5",
"title": "0da9b9f0dfe966ec2b6b8c92c9eeebe380639db5",
"url": "https://fuchsia.googlesource.com/integration/+/0da9b9f0dfe966ec2b6b8c92c9eeebe380639db5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ce75e11a248b1623be49899ac526ee023aa75cf8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ce75e11a248b1623be49899ac526ee023aa75cf8",
"title": "ce75e11a248b1623be49899ac526ee023aa75cf8",
"url": "https://fuchsia.googlesource.com/integration/+/ce75e11a248b1623be49899ac526ee023aa75cf8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c8bc09b4564d5112f541ca12de29497a03b5e22b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c8bc09b4564d5112f541ca12de29497a03b5e22b",
"title": "c8bc09b4564d5112f541ca12de29497a03b5e22b",
"url": "https://fuchsia.googlesource.com/integration/+/c8bc09b4564d5112f541ca12de29497a03b5e22b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "beb82f21dbb515b0c97b8f0a2c32ea11c6c8d0f0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@beb82f21dbb515b0c97b8f0a2c32ea11c6c8d0f0",
"title": "beb82f21dbb515b0c97b8f0a2c32ea11c6c8d0f0",
"url": "https://fuchsia.googlesource.com/integration/+/beb82f21dbb515b0c97b8f0a2c32ea11c6c8d0f0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f7b89b7ec4a893349c91da6565004eaaf408b452"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f7b89b7ec4a893349c91da6565004eaaf408b452",
"title": "f7b89b7ec4a893349c91da6565004eaaf408b452",
"url": "https://fuchsia.googlesource.com/integration/+/f7b89b7ec4a893349c91da6565004eaaf408b452"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9fcef2419bf22a6b5f567b2ca1716bd822e4d769"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9fcef2419bf22a6b5f567b2ca1716bd822e4d769",
"title": "9fcef2419bf22a6b5f567b2ca1716bd822e4d769",
"url": "https://fuchsia.googlesource.com/integration/+/9fcef2419bf22a6b5f567b2ca1716bd822e4d769"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b67d663ec6db6ccbd8abba8c1819d6be2cd0bb61"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b67d663ec6db6ccbd8abba8c1819d6be2cd0bb61",
"title": "b67d663ec6db6ccbd8abba8c1819d6be2cd0bb61",
"url": "https://fuchsia.googlesource.com/integration/+/b67d663ec6db6ccbd8abba8c1819d6be2cd0bb61"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "57ea91faa85aa08a2b3971872a3c1ba0c5abccc7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@57ea91faa85aa08a2b3971872a3c1ba0c5abccc7",
"title": "57ea91faa85aa08a2b3971872a3c1ba0c5abccc7",
"url": "https://fuchsia.googlesource.com/integration/+/57ea91faa85aa08a2b3971872a3c1ba0c5abccc7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dd7a6ff8cfa8f0a6376d612fb5362cc276f3268c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dd7a6ff8cfa8f0a6376d612fb5362cc276f3268c",
"title": "dd7a6ff8cfa8f0a6376d612fb5362cc276f3268c",
"url": "https://fuchsia.googlesource.com/integration/+/dd7a6ff8cfa8f0a6376d612fb5362cc276f3268c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "28ad90bf8108b5b578024f0f18a42d735f378045"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@28ad90bf8108b5b578024f0f18a42d735f378045",
"title": "28ad90bf8108b5b578024f0f18a42d735f378045",
"url": "https://fuchsia.googlesource.com/integration/+/28ad90bf8108b5b578024f0f18a42d735f378045"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bbd7dbf0847fe7ebe966c0884653ce9050a7dc50"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bbd7dbf0847fe7ebe966c0884653ce9050a7dc50",
"title": "bbd7dbf0847fe7ebe966c0884653ce9050a7dc50",
"url": "https://fuchsia.googlesource.com/integration/+/bbd7dbf0847fe7ebe966c0884653ce9050a7dc50"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "561b667e365fca158e509bb04b903d3aa7b2f970"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@561b667e365fca158e509bb04b903d3aa7b2f970",
"title": "561b667e365fca158e509bb04b903d3aa7b2f970",
"url": "https://fuchsia.googlesource.com/integration/+/561b667e365fca158e509bb04b903d3aa7b2f970"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4cb5df7dae970f06069ad147501e7fbd4d58d8a7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4cb5df7dae970f06069ad147501e7fbd4d58d8a7",
"title": "4cb5df7dae970f06069ad147501e7fbd4d58d8a7",
"url": "https://fuchsia.googlesource.com/integration/+/4cb5df7dae970f06069ad147501e7fbd4d58d8a7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "58fe78586b997f715c8ca68c5ad13ce5c2407a86"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@58fe78586b997f715c8ca68c5ad13ce5c2407a86",
"title": "58fe78586b997f715c8ca68c5ad13ce5c2407a86",
"url": "https://fuchsia.googlesource.com/integration/+/58fe78586b997f715c8ca68c5ad13ce5c2407a86"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7768c5e8be1757fd939c8b7a514a1134b86329a2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7768c5e8be1757fd939c8b7a514a1134b86329a2",
"title": "7768c5e8be1757fd939c8b7a514a1134b86329a2",
"url": "https://fuchsia.googlesource.com/integration/+/7768c5e8be1757fd939c8b7a514a1134b86329a2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8d8a16842bc42fe20252c458f63abbf6ab3d71cb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8d8a16842bc42fe20252c458f63abbf6ab3d71cb",
"title": "8d8a16842bc42fe20252c458f63abbf6ab3d71cb",
"url": "https://fuchsia.googlesource.com/integration/+/8d8a16842bc42fe20252c458f63abbf6ab3d71cb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6fadeb53e908dd0e3bc061fde847481243b007d4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6fadeb53e908dd0e3bc061fde847481243b007d4",
"title": "6fadeb53e908dd0e3bc061fde847481243b007d4",
"url": "https://fuchsia.googlesource.com/integration/+/6fadeb53e908dd0e3bc061fde847481243b007d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "08898c2fb4c2c12d519c7b7989b538c074cbbcf5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@08898c2fb4c2c12d519c7b7989b538c074cbbcf5",
"title": "08898c2fb4c2c12d519c7b7989b538c074cbbcf5",
"url": "https://fuchsia.googlesource.com/integration/+/08898c2fb4c2c12d519c7b7989b538c074cbbcf5"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "08898c2fb4c2c12d519c7b7989b538c074cbbcf5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8834106435606294640"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.x64-asan-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:10:09.559] Scheduled build:
{
"id": "8668676372497389393",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-06T16:10:08.519195879Z",
"updateTime": "2026-10-06T16:10:08.519195879Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "08898c2fb4c2c12d519c7b7989b538c074cbbcf5",
"ref": "refs/heads/main"
}
}
}
[16:10:09.559] Task URL: https://cr-buildbucket.appspot.com/build/8668676372497389393
[16:10:09.559] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:2:0) after 8m27s
[16:10:09.739] Received PubSub notification, asking Buildbucket for the build status
[16:10:09.765] Build status: SCHEDULED
[16:10:19.152] Received PubSub notification, asking Buildbucket for the build status
[16:10:19.241] Build status: STARTED
[16:18:36.627] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:2:0)
[16:18:36.647] Build status: STARTED
[16:18:36.647] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:5:0) after 9m24s
[16:28:00.858] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:5:0)
[16:28:01.019] Build status: STARTED
[16:28:01.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:6:0) after 6m37s
[16:34:38.116] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:6:0)
[16:34:38.132] Build status: STARTED
[16:34:38.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:7:0) after 4m17s
[16:38:55.183] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:7:0)
[16:38:55.202] Build status: STARTED
[16:38:55.202] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:8:0) after 5m1s
[16:43:56.241] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:8:0)
[16:43:56.261] Build status: STARTED
[16:43:56.261] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:9:0) after 5m42s
[16:49:38.287] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:9:0)
[16:49:38.310] Build status: STARTED
[16:49:38.310] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:10:0) after 4m29s
[16:54:07.618] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:10:0)
[16:54:07.654] Build status: STARTED
[16:54:07.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:11:0) after 3m27s
[16:57:34.694] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:11:0)
[16:57:34.712] Build status: STARTED
[16:57:34.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:12:0) after 5m10s
[17:02:45.003] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:12:0)
[17:02:45.027] Build status: STARTED
[17:02:45.027] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:13:0) after 8m20s
[17:11:05.088] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:13:0)
[17:11:05.195] Build status: STARTED
[17:11:05.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:14:0) after 2m55s
[17:14:00.272] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:14:0)
[17:14:00.312] Build status: STARTED
[17:14:00.312] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:15:0) after 9m4s
[17:23:04.379] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:15:0)
[17:23:04.401] Build status: STARTED
[17:23:04.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:16:0) after 4m57s
[17:28:01.418] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:16:0)
[17:28:01.463] Build status: STARTED
[17:28:01.463] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8834106435606294640:17:0) after 7m29s
[17:33:39.381] Received PubSub notification, asking Buildbucket for the build status
[17:33:39.409] Build:
{
"id": "8668676372497389393",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-06T16:10:08.519195879Z",
"startTime": "2026-10-06T16:10:18.897407012Z",
"endTime": "2026-10-06T17:33:34.163479732Z",
"updateTime": "2026-10-06T17:33:34.163479732Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "08898c2fb4c2c12d519c7b7989b538c074cbbcf5",
"ref": "refs/heads/main"
}
}
}
[17:33:39.409] Invocation finished in 1h23m33.237264037s with status SUCCEEDED