[03:04:16.009] New invocation is queued and will start shortly
[03:04:17.138] Starting the invocation (attempt 1)
[03:04:17.170] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/1f2c05141721719e15b8edd4b0c0570680cb48a1"
[03:04:17.170] Popped gitiles commit info from properties and tags
[03:04:17.171] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:04:17.171] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:04:17.172] Buildbucket request:
{
"requestId": "8847201839303615712",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8847201839303615712",
"job": "fuchsia/global.ci-core.x64-debug-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "090efa8533e68159d430a066fff8ef8f9acf8a9b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@090efa8533e68159d430a066fff8ef8f9acf8a9b",
"title": "090efa8533e68159d430a066fff8ef8f9acf8a9b",
"url": "https://fuchsia.googlesource.com/integration/+/090efa8533e68159d430a066fff8ef8f9acf8a9b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8304de39388898629425a8ab3a4ec77e3a79a3ab"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8304de39388898629425a8ab3a4ec77e3a79a3ab",
"title": "8304de39388898629425a8ab3a4ec77e3a79a3ab",
"url": "https://fuchsia.googlesource.com/integration/+/8304de39388898629425a8ab3a4ec77e3a79a3ab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "88929b8e450b556c3c560b69c5e50d08b720e9f5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@88929b8e450b556c3c560b69c5e50d08b720e9f5",
"title": "88929b8e450b556c3c560b69c5e50d08b720e9f5",
"url": "https://fuchsia.googlesource.com/integration/+/88929b8e450b556c3c560b69c5e50d08b720e9f5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f6c84a6575158de56a0412c5a1e3593c8bf4d2e4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f6c84a6575158de56a0412c5a1e3593c8bf4d2e4",
"title": "f6c84a6575158de56a0412c5a1e3593c8bf4d2e4",
"url": "https://fuchsia.googlesource.com/integration/+/f6c84a6575158de56a0412c5a1e3593c8bf4d2e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d4e103f1651a6a27c97b16b8930f14e65fbaa94b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d4e103f1651a6a27c97b16b8930f14e65fbaa94b",
"title": "d4e103f1651a6a27c97b16b8930f14e65fbaa94b",
"url": "https://fuchsia.googlesource.com/integration/+/d4e103f1651a6a27c97b16b8930f14e65fbaa94b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2eab741da8f4807edbe57c96304a24a41de3fb65"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2eab741da8f4807edbe57c96304a24a41de3fb65",
"title": "2eab741da8f4807edbe57c96304a24a41de3fb65",
"url": "https://fuchsia.googlesource.com/integration/+/2eab741da8f4807edbe57c96304a24a41de3fb65"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f85054e44af33202e533d83de3175924c6cb5c44"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f85054e44af33202e533d83de3175924c6cb5c44",
"title": "f85054e44af33202e533d83de3175924c6cb5c44",
"url": "https://fuchsia.googlesource.com/integration/+/f85054e44af33202e533d83de3175924c6cb5c44"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "950e4fbe0a1d8cf771c41e2f4e9b28a4150600bb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@950e4fbe0a1d8cf771c41e2f4e9b28a4150600bb",
"title": "950e4fbe0a1d8cf771c41e2f4e9b28a4150600bb",
"url": "https://fuchsia.googlesource.com/integration/+/950e4fbe0a1d8cf771c41e2f4e9b28a4150600bb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d5cba6e579dd4ccf46722a2947a665aab9e50318"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d5cba6e579dd4ccf46722a2947a665aab9e50318",
"title": "d5cba6e579dd4ccf46722a2947a665aab9e50318",
"url": "https://fuchsia.googlesource.com/integration/+/d5cba6e579dd4ccf46722a2947a665aab9e50318"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "40886ae2871dcd6ab6e0ea03fa8515c5400accce"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@40886ae2871dcd6ab6e0ea03fa8515c5400accce",
"title": "40886ae2871dcd6ab6e0ea03fa8515c5400accce",
"url": "https://fuchsia.googlesource.com/integration/+/40886ae2871dcd6ab6e0ea03fa8515c5400accce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fcfcba34b0206352ee38ec32fa110a4cf536ab8d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fcfcba34b0206352ee38ec32fa110a4cf536ab8d",
"title": "fcfcba34b0206352ee38ec32fa110a4cf536ab8d",
"url": "https://fuchsia.googlesource.com/integration/+/fcfcba34b0206352ee38ec32fa110a4cf536ab8d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "29478fd5f4694a411c9891a392f30900d843f64b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@29478fd5f4694a411c9891a392f30900d843f64b",
"title": "29478fd5f4694a411c9891a392f30900d843f64b",
"url": "https://fuchsia.googlesource.com/integration/+/29478fd5f4694a411c9891a392f30900d843f64b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6667f08fb8cad974dedb1ca377c95264fb8a59bf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6667f08fb8cad974dedb1ca377c95264fb8a59bf",
"title": "6667f08fb8cad974dedb1ca377c95264fb8a59bf",
"url": "https://fuchsia.googlesource.com/integration/+/6667f08fb8cad974dedb1ca377c95264fb8a59bf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ac3d76344251f30b2e30e8bd653713d9f90c608a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ac3d76344251f30b2e30e8bd653713d9f90c608a",
"title": "ac3d76344251f30b2e30e8bd653713d9f90c608a",
"url": "https://fuchsia.googlesource.com/integration/+/ac3d76344251f30b2e30e8bd653713d9f90c608a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fef0c1bad8ef2b8cdcd2f42f94e196ed31fe67ff"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fef0c1bad8ef2b8cdcd2f42f94e196ed31fe67ff",
"title": "fef0c1bad8ef2b8cdcd2f42f94e196ed31fe67ff",
"url": "https://fuchsia.googlesource.com/integration/+/fef0c1bad8ef2b8cdcd2f42f94e196ed31fe67ff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "64af776d7f2e23e36424d4a8a048396bb66f4181"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@64af776d7f2e23e36424d4a8a048396bb66f4181",
"title": "64af776d7f2e23e36424d4a8a048396bb66f4181",
"url": "https://fuchsia.googlesource.com/integration/+/64af776d7f2e23e36424d4a8a048396bb66f4181"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7e8130486542c27ba6d06614d8715e118e0e9d2e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7e8130486542c27ba6d06614d8715e118e0e9d2e",
"title": "7e8130486542c27ba6d06614d8715e118e0e9d2e",
"url": "https://fuchsia.googlesource.com/integration/+/7e8130486542c27ba6d06614d8715e118e0e9d2e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7e0bda24293b629cf8788ad5a7cc04f4ca1e8ca3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7e0bda24293b629cf8788ad5a7cc04f4ca1e8ca3",
"title": "7e0bda24293b629cf8788ad5a7cc04f4ca1e8ca3",
"url": "https://fuchsia.googlesource.com/integration/+/7e0bda24293b629cf8788ad5a7cc04f4ca1e8ca3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1f2c05141721719e15b8edd4b0c0570680cb48a1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1f2c05141721719e15b8edd4b0c0570680cb48a1",
"title": "1f2c05141721719e15b8edd4b0c0570680cb48a1",
"url": "https://fuchsia.googlesource.com/integration/+/1f2c05141721719e15b8edd4b0c0570680cb48a1"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1f2c05141721719e15b8edd4b0c0570680cb48a1",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8847201839303615712"
},
{
"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"
}
}
[03:04:17.786] Scheduled build:
{
"id": "8681771777174933649",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-05-15T03:04:17.415650444Z",
"updateTime": "2026-05-15T03:04:17.415650444Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1f2c05141721719e15b8edd4b0c0570680cb48a1",
"ref": "refs/heads/main"
}
}
}
[03:04:17.786] Task URL: https://cr-buildbucket.appspot.com/build/8681771777174933649
[03:04:17.786] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:2:0) after 4m0s
[03:04:18.767] Received PubSub notification, asking Buildbucket for the build status
[03:04:18.814] Build status: SCHEDULED
[03:04:21.929] Received PubSub notification, asking Buildbucket for the build status
[03:04:21.949] Build status: STARTED
[03:08:17.814] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:2:0)
[03:08:17.862] Build status: STARTED
[03:08:17.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:5:0) after 4m38s
[03:12:55.909] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:5:0)
[03:12:56.116] Build status: STARTED
[03:12:56.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:6:0) after 5m42s
[03:18:38.132] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:6:0)
[03:18:38.156] Build status: STARTED
[03:18:38.156] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:7:0) after 7m17s
[03:25:55.180] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:7:0)
[03:25:55.233] Build status: STARTED
[03:25:55.233] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:8:0) after 1m22s
[03:27:17.296] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:8:0)
[03:27:17.335] Build status: STARTED
[03:27:17.335] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:9:0) after 2m16s
[03:29:33.497] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:9:0)
[03:29:33.519] Build status: STARTED
[03:29:33.519] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:10:0) after 1m17s
[03:30:50.581] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:10:0)
[03:30:50.638] Build status: STARTED
[03:30:50.638] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:11:0) after 7m44s
[03:38:34.658] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:11:0)
[03:38:34.738] Build status: STARTED
[03:38:34.738] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:12:0) after 2m14s
[03:40:48.741] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:12:0)
[03:40:48.764] Build status: STARTED
[03:40:48.764] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:13:0) after 2m34s
[03:43:22.778] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:13:0)
[03:43:22.799] Build status: STARTED
[03:43:22.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:14:0) after 5m57s
[03:49:19.825] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:14:0)
[03:49:19.842] Build status: STARTED
[03:49:19.842] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:15:0) after 5m48s
[03:55:07.954] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:15:0)
[03:55:07.987] Build status: STARTED
[03:55:07.987] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:16:0) after 1m2s
[03:56:10.022] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:16:0)
[03:56:10.045] Build status: STARTED
[03:56:10.045] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:17:0) after 3m11s
[03:59:21.079] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:17:0)
[03:59:21.096] Build status: STARTED
[03:59:21.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:18:0) after 7m19s
[04:06:40.068] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:18:0)
[04:06:40.103] Build status: STARTED
[04:06:40.103] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:19:0) after 2m19s
[04:08:59.176] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:19:0)
[04:08:59.198] Build status: STARTED
[04:08:59.198] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:20:0) after 4m2s
[04:13:01.216] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:20:0)
[04:13:01.300] Build status: STARTED
[04:13:01.300] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:21:0) after 2m11s
[04:15:12.337] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:21:0)
[04:15:12.357] Build status: STARTED
[04:15:12.357] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:22:0) after 4m14s
[04:19:26.372] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:22:0)
[04:19:26.392] Build status: STARTED
[04:19:26.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-e5a0ec7f:8847201839303615712:23:0) after 4m14s
[04:22:48.439] Received PubSub notification, asking Buildbucket for the build status
[04:22:48.705] Build:
{
"id": "8681771777174933649",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-05-15T03:04:17.415650444Z",
"startTime": "2026-05-15T03:04:21.762811177Z",
"endTime": "2026-05-15T04:22:47.683087422Z",
"updateTime": "2026-05-15T04:22:47.683087422Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1f2c05141721719e15b8edd4b0c0570680cb48a1",
"ref": "refs/heads/main"
}
}
}
[04:22:48.705] Invocation finished in 1h18m32.703162143s with status SUCCEEDED